builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1461501932.81 results: success (0) buildid: 20160424030601 builduid: 6c665d98c5ae4206b8a1aabef46f1129 revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.806831) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.807214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.807475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.838857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.839413) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 05:45:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-24 05:45:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.975626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.975945) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017617 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.029327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.029632) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 05:45:33,298 truncating revision to first 12 chars 2016-04-24 05:45:33,299 Setting DEBUG logging. 2016-04-24 05:45:33,299 attempt 1/10 2016-04-24 05:45:33,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab8a76ac7b34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 05:45:33,535 unpacking tar archive at: mozilla-central-ab8a76ac7b34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516508 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.561067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.561344) ========= script_repo_revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.561687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.561944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.571525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-24 05:45:33.571780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:33 INFO - MultiFileLogger online at 20160424 05:45:33 in /builds/slave/test 05:45:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:45:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:33 INFO - {'append_to_log': False, 05:45:33 INFO - 'base_work_dir': '/builds/slave/test', 05:45:33 INFO - 'blob_upload_branch': 'Firefox', 05:45:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:33 INFO - 'branch': 'Firefox', 05:45:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:33 INFO - 'config_files': ('talos/linux_config.py',), 05:45:33 INFO - 'default_actions': ('clobber', 05:45:33 INFO - 'read-buildbot-config', 05:45:33 INFO - 'download-and-extract', 05:45:33 INFO - 'populate-webroot', 05:45:33 INFO - 'create-virtualenv', 05:45:33 INFO - 'install', 05:45:33 INFO - 'run-tests'), 05:45:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:33 INFO - 'download_minidump_stackwalk': True, 05:45:33 INFO - 'download_symbols': 'ondemand', 05:45:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:33 INFO - 'installer_path': 'installer.exe', 05:45:33 INFO - 'log_level': 'info', 05:45:33 INFO - 'log_name': 'talos', 05:45:33 INFO - 'log_to_console': True, 05:45:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:33 INFO - 'opt_config_files': (), 05:45:33 INFO - 'pip_index': False, 05:45:33 INFO - 'sps_profile': False, 05:45:33 INFO - 'sps_profile_interval': 0, 05:45:33 INFO - 'suite': 'dromaeojs-e10s', 05:45:33 INFO - 'system_bits': '32', 05:45:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:33 INFO - 'title': 'talos-linux64-ix-016', 05:45:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:33 INFO - 'use_talos_json': True, 05:45:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:33 INFO - 'work_dir': 'build'} 05:45:33 INFO - ##### 05:45:33 INFO - ##### Running clobber step. 05:45:33 INFO - ##### 05:45:33 INFO - Running pre-action listener: _resource_record_pre_action 05:45:33 INFO - Running main action method: clobber 05:45:33 INFO - rmtree: /builds/slave/test/build 05:45:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:34 INFO - Running post-action listener: _resource_record_post_action 05:45:34 INFO - ##### 05:45:34 INFO - ##### Running read-buildbot-config step. 05:45:34 INFO - ##### 05:45:34 INFO - Running pre-action listener: _resource_record_pre_action 05:45:34 INFO - Running main action method: read_buildbot_config 05:45:34 INFO - Using buildbot properties: 05:45:34 INFO - { 05:45:34 INFO - "project": "", 05:45:34 INFO - "product": "firefox", 05:45:34 INFO - "script_repo_revision": "production", 05:45:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:34 INFO - "repository": "", 05:45:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:45:34 INFO - "buildid": "20160424030601", 05:45:34 INFO - "stage_platform": "linux64-pgo", 05:45:34 INFO - "basedir": "/builds/slave/test", 05:45:34 INFO - "nightly_build": "True", 05:45:34 INFO - "buildnumber": 2, 05:45:34 INFO - "slavename": "talos-linux64-ix-016", 05:45:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:45:34 INFO - "platform": "ubuntu64_hw", 05:45:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:34 INFO - "branch": "mozilla-central", 05:45:34 INFO - "repo_path": "mozilla-central", 05:45:34 INFO - "revision": "ab8a76ac7b34db20dd3c220c9846826334f3efdc", 05:45:34 INFO - "pgo_build": "True", 05:45:34 INFO - "builduid": "6c665d98c5ae4206b8a1aabef46f1129", 05:45:34 INFO - "slavebuilddir": "test" 05:45:34 INFO - } 05:45:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:45:34 INFO - Running post-action listener: _resource_record_post_action 05:45:34 INFO - ##### 05:45:34 INFO - ##### Running download-and-extract step. 05:45:34 INFO - ##### 05:45:34 INFO - Running pre-action listener: _resource_record_pre_action 05:45:34 INFO - Running main action method: download_and_extract 05:45:34 INFO - mkdir: /builds/slave/test/build/tests 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:34 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:45:41 INFO - Downloaded 1361 bytes. 05:45:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:41 INFO - Using the following test package requirements: 05:45:41 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'jsshell-linux-x86_64.zip'], 05:45:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:41 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:41 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:49 INFO - Downloaded 23857858 bytes. 05:45:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:50 INFO - Return code: 0 05:45:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:50 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:52 INFO - Downloaded 23857858 bytes. 05:45:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:53 INFO - Return code: 0 05:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:53 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:45:54 INFO - Downloaded 10840145 bytes. 05:45:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:45:54 INFO - Return code: 0 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:45:56 INFO - Downloaded 58366061 bytes. 05:45:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:56 INFO - mkdir: /builds/slave/test/properties 05:45:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:56 INFO - Contents: 05:45:56 INFO - build_url:https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:57 INFO - Running post-action listener: _resource_record_post_action 05:45:57 INFO - Running post-action listener: set_extra_try_arguments 05:45:57 INFO - ##### 05:45:57 INFO - ##### Running populate-webroot step. 05:45:57 INFO - ##### 05:45:57 INFO - Running pre-action listener: _resource_record_pre_action 05:45:57 INFO - Running main action method: populate_webroot 05:45:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:57 INFO - '--tppagecycles', 05:45:57 INFO - '7'], 05:45:57 INFO - 'tests': ['tsvgm']}}, 05:45:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['damp', 'tps']}, 05:45:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'tests': ['damp', 'tps']}, 05:45:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['dromaeo_dom']}, 05:45:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['a11yr', 05:45:57 INFO - 'ts_paint', 05:45:57 INFO - 'tpaint', 05:45:57 INFO - 'sessionrestore', 05:45:57 INFO - 'sessionrestore_no_auto_restore', 05:45:57 INFO - 'tabpaint']}, 05:45:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['tsvgx', 05:45:57 INFO - 'tsvgr_opacity', 05:45:57 INFO - 'tart', 05:45:57 INFO - 'tscrollx', 05:45:57 INFO - 'cart']}, 05:45:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:57 INFO - 'tsvgr_opacity', 05:45:57 INFO - 'tart', 05:45:57 INFO - 'tscrollx', 05:45:57 INFO - 'cart']}, 05:45:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'talos_options': ['--disable-e10s'], 05:45:57 INFO - 'tests': ['tp5o']}, 05:45:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'tests': ['tp5o']}, 05:45:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'talos_options': ['--disable-e10s', 05:45:57 INFO - '--xperf_path', 05:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:57 INFO - 'tests': ['tp5n']}, 05:45:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:57 INFO - 'talos_options': ['--xperf_path', 05:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:57 INFO - 'tests': ['tp5n']}}, 05:45:57 INFO - 'talos.zip': {'path': '', 05:45:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:57 INFO - Running post-action listener: _resource_record_post_action 05:45:57 INFO - ##### 05:45:57 INFO - ##### Running create-virtualenv step. 05:45:57 INFO - ##### 05:45:57 INFO - Running pre-action listener: _resource_record_pre_action 05:45:57 INFO - Running main action method: create_virtualenv 05:45:57 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:45:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:57 INFO - Using real prefix '/usr' 05:45:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:59 INFO - Installing pip.................done. 05:45:59 INFO - Return code: 0 05:45:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:59 INFO - Cleaning up... 05:45:59 INFO - Return code: 0 05:45:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:00 INFO - Downloading/unpacking psutil>=0.7.1 05:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:02 INFO - Installing collected packages: psutil 05:46:02 INFO - Running setup.py install for psutil 05:46:02 INFO - building 'psutil._psutil_linux' extension 05:46:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:46:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:46:02 INFO - building 'psutil._psutil_posix' extension 05:46:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:46:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:46:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:02 INFO - Successfully installed psutil 05:46:02 INFO - Cleaning up... 05:46:02 INFO - Return code: 0 05:46:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:46:02 INFO - Using env: {'DISPLAY': ':0', 05:46:02 INFO - 'HOME': '/home/cltbld', 05:46:02 INFO - 'LANG': 'en_US.UTF-8', 05:46:02 INFO - 'LANGUAGE': 'en_US:en', 05:46:02 INFO - 'LOGNAME': 'cltbld', 05:46:02 INFO - 'MAIL': '/var/mail/cltbld', 05:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:02 INFO - 'MOZ_NO_REMOTE': '1', 05:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:02 INFO - 'NO_EM_RESTART': '1', 05:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:02 INFO - 'PWD': '/builds/slave/test', 05:46:02 INFO - 'SHELL': '/bin/bash', 05:46:02 INFO - 'SHLVL': '1', 05:46:02 INFO - 'TERM': 'linux', 05:46:02 INFO - 'TMOUT': '86400', 05:46:02 INFO - 'USER': 'cltbld', 05:46:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:02 INFO - '_': '/tools/buildbot/bin/python'} 05:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:46:04 INFO - Installing collected packages: mozsystemmonitor 05:46:04 INFO - Running setup.py install for mozsystemmonitor 05:46:04 INFO - Successfully installed mozsystemmonitor 05:46:04 INFO - Cleaning up... 05:46:05 INFO - Return code: 0 05:46:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:46:05 INFO - Using env: {'DISPLAY': ':0', 05:46:05 INFO - 'HOME': '/home/cltbld', 05:46:05 INFO - 'LANG': 'en_US.UTF-8', 05:46:05 INFO - 'LANGUAGE': 'en_US:en', 05:46:05 INFO - 'LOGNAME': 'cltbld', 05:46:05 INFO - 'MAIL': '/var/mail/cltbld', 05:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:05 INFO - 'MOZ_NO_REMOTE': '1', 05:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:05 INFO - 'NO_EM_RESTART': '1', 05:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:05 INFO - 'PWD': '/builds/slave/test', 05:46:05 INFO - 'SHELL': '/bin/bash', 05:46:05 INFO - 'SHLVL': '1', 05:46:05 INFO - 'TERM': 'linux', 05:46:05 INFO - 'TMOUT': '86400', 05:46:05 INFO - 'USER': 'cltbld', 05:46:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:05 INFO - '_': '/tools/buildbot/bin/python'} 05:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Downloading docopt-0.6.1.tar.gz 05:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:07 INFO - Running setup.py install for blobuploader 05:46:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:07 INFO - Running setup.py install for requests 05:46:08 INFO - Running setup.py install for docopt 05:46:08 INFO - Successfully installed blobuploader requests docopt 05:46:08 INFO - Cleaning up... 05:46:08 INFO - Return code: 0 05:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:08 INFO - Using env: {'DISPLAY': ':0', 05:46:08 INFO - 'HOME': '/home/cltbld', 05:46:08 INFO - 'LANG': 'en_US.UTF-8', 05:46:08 INFO - 'LANGUAGE': 'en_US:en', 05:46:08 INFO - 'LOGNAME': 'cltbld', 05:46:08 INFO - 'MAIL': '/var/mail/cltbld', 05:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:08 INFO - 'MOZ_NO_REMOTE': '1', 05:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:08 INFO - 'NO_EM_RESTART': '1', 05:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:08 INFO - 'PWD': '/builds/slave/test', 05:46:08 INFO - 'SHELL': '/bin/bash', 05:46:08 INFO - 'SHLVL': '1', 05:46:08 INFO - 'TERM': 'linux', 05:46:08 INFO - 'TMOUT': '86400', 05:46:08 INFO - 'USER': 'cltbld', 05:46:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:08 INFO - '_': '/tools/buildbot/bin/python'} 05:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:08 INFO - Running setup.py (path:/tmp/pip-jHDFSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:08 INFO - Running setup.py (path:/tmp/pip-AmmTPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:08 INFO - Running setup.py (path:/tmp/pip-IPc0tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:08 INFO - Running setup.py (path:/tmp/pip-DQ6az1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:08 INFO - Running setup.py (path:/tmp/pip-QrTwGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:09 INFO - Running setup.py (path:/tmp/pip-Af0Cmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:09 INFO - Running setup.py (path:/tmp/pip-ClRDfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:09 INFO - Running setup.py (path:/tmp/pip-DkoBU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:09 INFO - Running setup.py (path:/tmp/pip-Dk74Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:09 INFO - Running setup.py (path:/tmp/pip-zHcr6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:09 INFO - Running setup.py (path:/tmp/pip-r9rGqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:09 INFO - Running setup.py (path:/tmp/pip-V_u4QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:09 INFO - Running setup.py (path:/tmp/pip-ncq1Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:09 INFO - Running setup.py (path:/tmp/pip-PcLCyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:09 INFO - Running setup.py (path:/tmp/pip-N9Vux1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:09 INFO - Running setup.py (path:/tmp/pip-Vk0lKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:09 INFO - Running setup.py (path:/tmp/pip-kYzF5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:09 INFO - Running setup.py install for manifestparser 05:46:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for mozcrash 05:46:10 INFO - Running setup.py install for mozdebug 05:46:10 INFO - Running setup.py install for mozdevice 05:46:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for mozfile 05:46:10 INFO - Running setup.py install for mozhttpd 05:46:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for mozinfo 05:46:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for mozInstall 05:46:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for mozleak 05:46:10 INFO - Running setup.py install for mozlog 05:46:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:10 INFO - Running setup.py install for moznetwork 05:46:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Running setup.py install for mozprocess 05:46:11 INFO - Running setup.py install for mozprofile 05:46:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Running setup.py install for mozrunner 05:46:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Running setup.py install for mozscreenshot 05:46:11 INFO - Running setup.py install for moztest 05:46:11 INFO - Running setup.py install for mozversion 05:46:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:11 INFO - Cleaning up... 05:46:11 INFO - Return code: 0 05:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:11 INFO - Using env: {'DISPLAY': ':0', 05:46:11 INFO - 'HOME': '/home/cltbld', 05:46:11 INFO - 'LANG': 'en_US.UTF-8', 05:46:11 INFO - 'LANGUAGE': 'en_US:en', 05:46:11 INFO - 'LOGNAME': 'cltbld', 05:46:11 INFO - 'MAIL': '/var/mail/cltbld', 05:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:11 INFO - 'MOZ_NO_REMOTE': '1', 05:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:11 INFO - 'NO_EM_RESTART': '1', 05:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:11 INFO - 'PWD': '/builds/slave/test', 05:46:11 INFO - 'SHELL': '/bin/bash', 05:46:11 INFO - 'SHLVL': '1', 05:46:11 INFO - 'TERM': 'linux', 05:46:11 INFO - 'TMOUT': '86400', 05:46:11 INFO - 'USER': 'cltbld', 05:46:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:11 INFO - '_': '/tools/buildbot/bin/python'} 05:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:11 INFO - Running setup.py (path:/tmp/pip-VgZUO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:11 INFO - Running setup.py (path:/tmp/pip-MjPurv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:12 INFO - Running setup.py (path:/tmp/pip-Kg5_Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:12 INFO - Running setup.py (path:/tmp/pip-8JhDSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:12 INFO - Running setup.py (path:/tmp/pip-WxRrMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:12 INFO - Running setup.py (path:/tmp/pip-aAu3wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:12 INFO - Running setup.py (path:/tmp/pip-0hee52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Running setup.py (path:/tmp/pip-eXheRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Running setup.py (path:/tmp/pip-90xso7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Running setup.py (path:/tmp/pip-TX9QiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:12 INFO - Running setup.py (path:/tmp/pip-dDOk_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:12 INFO - Running setup.py (path:/tmp/pip-TGvqwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:12 INFO - Running setup.py (path:/tmp/pip-Y2bPJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:12 INFO - Running setup.py (path:/tmp/pip-CMGFw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:12 INFO - Running setup.py (path:/tmp/pip-55gXS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:12 INFO - Running setup.py (path:/tmp/pip-ON0PZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:13 INFO - Running setup.py (path:/tmp/pip-6C47mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:15 INFO - Downloading blessings-1.6.tar.gz 05:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:15 INFO - Installing collected packages: blessings 05:46:15 INFO - Running setup.py install for blessings 05:46:15 INFO - Successfully installed blessings 05:46:15 INFO - Cleaning up... 05:46:15 INFO - Return code: 0 05:46:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:15 INFO - Reading from file tmpfile_stdout 05:46:15 INFO - Current package versions: 05:46:15 INFO - argparse == 1.2.1 05:46:15 INFO - blessings == 1.6 05:46:15 INFO - blobuploader == 1.2.4 05:46:15 INFO - docopt == 0.6.1 05:46:15 INFO - manifestparser == 1.1 05:46:15 INFO - mozInstall == 1.12 05:46:15 INFO - mozcrash == 0.17 05:46:15 INFO - mozdebug == 0.1 05:46:15 INFO - mozdevice == 0.48 05:46:15 INFO - mozfile == 1.2 05:46:15 INFO - mozhttpd == 0.7 05:46:15 INFO - mozinfo == 0.9 05:46:15 INFO - mozleak == 0.1 05:46:15 INFO - mozlog == 3.1 05:46:15 INFO - moznetwork == 0.27 05:46:15 INFO - mozprocess == 0.22 05:46:15 INFO - mozprofile == 0.28 05:46:15 INFO - mozrunner == 6.11 05:46:15 INFO - mozscreenshot == 0.1 05:46:15 INFO - mozsystemmonitor == 0.0 05:46:15 INFO - moztest == 0.7 05:46:15 INFO - mozversion == 1.4 05:46:15 INFO - psutil == 3.1.1 05:46:15 INFO - requests == 1.2.3 05:46:15 INFO - wsgiref == 0.1.2 05:46:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:15 INFO - Using env: {'DISPLAY': ':0', 05:46:15 INFO - 'HOME': '/home/cltbld', 05:46:15 INFO - 'LANG': 'en_US.UTF-8', 05:46:15 INFO - 'LANGUAGE': 'en_US:en', 05:46:15 INFO - 'LOGNAME': 'cltbld', 05:46:15 INFO - 'MAIL': '/var/mail/cltbld', 05:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:15 INFO - 'MOZ_NO_REMOTE': '1', 05:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:15 INFO - 'NO_EM_RESTART': '1', 05:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:15 INFO - 'PWD': '/builds/slave/test', 05:46:15 INFO - 'SHELL': '/bin/bash', 05:46:15 INFO - 'SHLVL': '1', 05:46:15 INFO - 'TERM': 'linux', 05:46:15 INFO - 'TMOUT': '86400', 05:46:15 INFO - 'USER': 'cltbld', 05:46:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:15 INFO - '_': '/tools/buildbot/bin/python'} 05:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:15 INFO - Cleaning up... 05:46:15 INFO - Return code: 0 05:46:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:15 INFO - Using env: {'DISPLAY': ':0', 05:46:15 INFO - 'HOME': '/home/cltbld', 05:46:15 INFO - 'LANG': 'en_US.UTF-8', 05:46:15 INFO - 'LANGUAGE': 'en_US:en', 05:46:15 INFO - 'LOGNAME': 'cltbld', 05:46:15 INFO - 'MAIL': '/var/mail/cltbld', 05:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:15 INFO - 'MOZ_NO_REMOTE': '1', 05:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:15 INFO - 'NO_EM_RESTART': '1', 05:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:15 INFO - 'PWD': '/builds/slave/test', 05:46:15 INFO - 'SHELL': '/bin/bash', 05:46:15 INFO - 'SHLVL': '1', 05:46:15 INFO - 'TERM': 'linux', 05:46:15 INFO - 'TMOUT': '86400', 05:46:15 INFO - 'USER': 'cltbld', 05:46:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:15 INFO - '_': '/tools/buildbot/bin/python'} 05:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:15 INFO - Downloading/unpacking jsonschema 05:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:17 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:18 INFO - warning: no files found matching '*.txt' 05:46:18 INFO - no previously-included directories found matching 'build' 05:46:18 INFO - no previously-included directories found matching 'dist' 05:46:18 INFO - no previously-included directories found matching '.git*' 05:46:18 INFO - Installing collected packages: jsonschema, functools32 05:46:18 INFO - Running setup.py install for functools32 05:46:18 INFO - warning: no files found matching '*.txt' 05:46:18 INFO - no previously-included directories found matching 'build' 05:46:18 INFO - no previously-included directories found matching 'dist' 05:46:18 INFO - no previously-included directories found matching '.git*' 05:46:18 INFO - Successfully installed jsonschema functools32 05:46:18 INFO - Cleaning up... 05:46:18 INFO - Return code: 0 05:46:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5ab4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:46:18 INFO - Using env: {'DISPLAY': ':0', 05:46:18 INFO - 'HOME': '/home/cltbld', 05:46:18 INFO - 'LANG': 'en_US.UTF-8', 05:46:18 INFO - 'LANGUAGE': 'en_US:en', 05:46:18 INFO - 'LOGNAME': 'cltbld', 05:46:18 INFO - 'MAIL': '/var/mail/cltbld', 05:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:18 INFO - 'MOZ_NO_REMOTE': '1', 05:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:18 INFO - 'NO_EM_RESTART': '1', 05:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:18 INFO - 'PWD': '/builds/slave/test', 05:46:18 INFO - 'SHELL': '/bin/bash', 05:46:18 INFO - 'SHLVL': '1', 05:46:18 INFO - 'TERM': 'linux', 05:46:18 INFO - 'TMOUT': '86400', 05:46:18 INFO - 'USER': 'cltbld', 05:46:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:18 INFO - '_': '/tools/buildbot/bin/python'} 05:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 INFO - Downloading/unpacking flake8 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:21 INFO - no previously-included directories found matching 'docs/_build' 05:46:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:21 INFO - Running setup.py install for pep8 05:46:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:21 INFO - no previously-included directories found matching 'docs/_build' 05:46:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:46:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:21 INFO - Cleaning up... 05:46:21 INFO - Return code: 0 05:46:21 INFO - Running post-action listener: _resource_record_post_action 05:46:21 INFO - Running post-action listener: _start_resource_monitoring 05:46:21 INFO - Starting resource monitoring. 05:46:21 INFO - ##### 05:46:21 INFO - ##### Running install step. 05:46:21 INFO - ##### 05:46:21 INFO - Running pre-action listener: _resource_record_pre_action 05:46:21 INFO - Running main action method: install 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Output received: 05:46:21 INFO - Usage: mozinstall [options] installer 05:46:21 INFO - Options: 05:46:21 INFO - -h, --help show this help message and exit 05:46:21 INFO - -d DEST, --destination=DEST 05:46:21 INFO - Directory to install application into. [default: 05:46:21 INFO - "/builds/slave/test"] 05:46:21 INFO - --app=APP Application being installed. [default: firefox] 05:46:21 INFO - mkdir: /builds/slave/test/build/application 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:46:38 INFO - Reading from file tmpfile_stdout 05:46:38 INFO - Output received: 05:46:38 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:38 INFO - Running post-action listener: _resource_record_post_action 05:46:38 INFO - ##### 05:46:38 INFO - ##### Running run-tests step. 05:46:38 INFO - ##### 05:46:38 INFO - Running pre-action listener: _resource_record_pre_action 05:46:38 INFO - Running main action method: run_tests 05:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:38 INFO - Python 2.7.3 05:46:38 INFO - Return code: 0 05:46:38 INFO - grabbing minidump binary from tooltool 05:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202f410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20307a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:46:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:38 INFO - Return code: 0 05:46:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:46:39 INFO - Return code: 0 05:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:46:39 INFO - Using env: {'DISPLAY': ':0', 05:46:39 INFO - 'HOME': '/home/cltbld', 05:46:39 INFO - 'LANG': 'en_US.UTF-8', 05:46:39 INFO - 'LANGUAGE': 'en_US:en', 05:46:39 INFO - 'LOGNAME': 'cltbld', 05:46:39 INFO - 'MAIL': '/var/mail/cltbld', 05:46:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:39 INFO - 'MOZ_NO_REMOTE': '1', 05:46:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:39 INFO - 'NO_EM_RESTART': '1', 05:46:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:39 INFO - 'PWD': '/builds/slave/test', 05:46:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:39 INFO - 'SHELL': '/bin/bash', 05:46:39 INFO - 'SHLVL': '1', 05:46:39 INFO - 'TERM': 'linux', 05:46:39 INFO - 'TMOUT': '86400', 05:46:39 INFO - 'USER': 'cltbld', 05:46:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461489470.697660-899516282', 05:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:39 INFO - '_': '/tools/buildbot/bin/python'} 05:46:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:46:39 INFO - mozversion application_buildid: 20160424030601 05:46:39 INFO - mozversion application_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 05:46:39 INFO - mozversion application_display_name: Nightly 05:46:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:39 INFO - mozversion application_name: Firefox 05:46:39 INFO - mozversion application_remotingname: firefox 05:46:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:39 INFO - mozversion application_vendor: Mozilla 05:46:39 INFO - mozversion application_version: 48.0a1 05:46:39 INFO - mozversion platform_buildid: 20160424030601 05:46:39 INFO - mozversion platform_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 05:46:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:39 INFO - mozversion platform_version: 48.0a1 05:46:39 INFO - using testdate: 1461501999 05:46:39 INFO - actual date: 1461501999 05:46:39 INFO - starting webserver on 'localhost:42933' 05:46:39 INFO - SUITE-START | Running 2 tests 05:46:39 INFO - TEST-START | dromaeo_css 05:46:39 INFO - operating with platform_type : linux_ 05:46:39 INFO - Initialising browser for dromaeo_css test... 05:46:39 INFO - TEST-INFO | started process 17456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7fHsCa/profile http://localhost:42933/getInfo.html) 05:46:42 INFO - PROCESS | 17456 | 05:46:42 INFO - PROCESS | 17456 | (process:17522): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:46:43 INFO - PROCESS | 17456 | __metrics Screen width/height:1600/1200 05:46:43 INFO - PROCESS | 17456 | colorDepth:24 05:46:43 INFO - PROCESS | 17456 | Browser inner width/height: 1024/697 05:46:43 INFO - PROCESS | 17456 | __metrics 05:46:44 ERROR - PROCESS | 17456 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:46:45 INFO - TEST-INFO | 17456: exit 0 05:46:45 INFO - Browser initialized. 05:46:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:45 INFO - TEST-INFO | started process 17573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7fHsCa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:47 INFO - PROCESS | 17573 | 05:46:47 INFO - PROCESS | 17573 | (process:17634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:46:57 INFO - PROCESS | 17573 | RSS: Main: 164134912 05:46:57 INFO - PROCESS | 17573 | 05:47:46 INFO - PROCESS | 17573 | 1461502066780 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:54 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42933/tests/dromaeo/cssquery-ext.html) 05:49:55 INFO - PROCESS | 17573 | RSS: Main: 168931328 05:49:55 INFO - PROCESS | 17573 | 05:52:57 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-ext.html (next: http://localhost:42933/tests/dromaeo/cssquery-jquery.html) 05:52:58 INFO - PROCESS | 17573 | RSS: Main: 166858752 05:52:58 INFO - PROCESS | 17573 | 05:56:00 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42933/tests/dromaeo/cssquery-mootools.html) 05:56:00 INFO - PROCESS | 17573 | RSS: Main: 167424000 05:56:00 INFO - PROCESS | 17573 | 05:59:02 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42933/tests/dromaeo/cssquery-prototype.html) 05:59:02 INFO - PROCESS | 17573 | RSS: Main: 165134336 05:59:02 INFO - PROCESS | 17573 | 06:02:05 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42933/tests/dromaeo/cssquery-yui.html) 06:02:06 INFO - PROCESS | 17573 | RSS: Main: 165744640 06:02:06 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | Cycle 1(1): loaded http://localhost:42933/tests/dromaeo/cssquery-yui.html (next: http://localhost:42933/tests/dromaeo/cssquery-dojo.html) 06:05:08 INFO - PROCESS | 17573 | RSS: Main: 168218624 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | __start_tp_report 06:05:08 INFO - PROCESS | 17573 | _x_x_mozilla_page_load 06:05:08 INFO - PROCESS | 17573 | _x_x_mozilla_page_load_details 06:05:08 INFO - PROCESS | 17573 | |i|pagename|runs| 06:05:08 INFO - PROCESS | 17573 | |0;dojo.html;3169.3185965017524;3212.261179928618;3225.9032229033123;3260.6902344277287;3261.7553683473743;5407.134858422648;5432.239486471892;5480.177973304007;5486.149646804742;5519.254900588419;5351.063563876325;5448.37343705474;5487.067198576242;5521.806736764214;5558;4958.355413796201;4994.575461085812;5051.318072060261;5065.265536497206;5116.1814109742445;781.9823833523606;4897.436794768611;4956.256561515784;4976.502349765013;5081.034603425356;4931.309616653672;4942.258661200831;4959.727215003173;4990.950090499103;4994.200927851544;4980;4989.326440930464;4999.975000124976;5004.074246264417;5042.218456139304;4890.510948905081;4919.754012299407;4941.184704523749;4942.579880710108;4954.653174277802;5272.499112584298;5305.495977882095;5315.707636080014;5347.946520534783;5352.545033672103;5587.106063029895;5768.221290125864;5770.538356931477;5783.566232532577;5828.854278643025;5770.971145144289;5829.504492118175;5835.9708201458725;5838.591298609099;5881.617694849864;5424.240606315158;5425.131978883399;5427.6472029317965;5429.321334833146;5455.918161227585;5837.620554663933;5875.853103672443;5878.2358293421585;5885.588008839341;5955.136505206808;5741.799037033684;5745.396733343023;5755.9424405756245;5756.5682573807135;5766.538676905921;5832.88334233313;5843.941560584425;5844.6785426801935;5851.473367396955;5854.5901786875365;5770.596058275964;5779.133130030529;5806;5818.243628328375;5850.180974663551;5685;5695.145728140812;5724.141378793214;5741.937741517832;5751.654900705971;4253.532111467736;4326.82692692295;4339;4343.500497442835;4376.693631445768;3783.1487915218854;3872.0900588361715;3908.882733517999;3920.4707364505425;3925.7448265862627;5448.673079615236;5477.04151773446;5546.168074788733;5567.220589117527;5607.158926161027;5605.990921634064;5855.765769369177;5868.3251426086545;5875.177475153482;5878;5428.511433970962;5529.834104976857;5551.833444996657;5562.582806289544;5566.165075238666;4881.096997055556;4915.729634870045;4923.818283611908;4994.150994330972;5001.274815151855;5855.473007429352;6041.2750469943885;6051.667158306247;6056.06131049688;6080.331163572004;5840.532757379485;5892.764289428461;5895.94104058954;5904.9704751475965;5915.08316210988;6044.607100538451;6061.666608336407;6061.969690151697;6070.848228794315;6093.9390606093375;5579.69311687861;5707.514861236841;5763.452472015152;5770.826875193751;5802.796902108406;5766.654000759968;5780.653160810365;5796.681182535001;5805.129230615273;5853.560982926212;5600.691961942132;5610.691411972381;5614.466625670555;5616.719164041863;5617.129344951539;5548.833534993957;5623.297087864017;5684.459976302244;5718.056520674042;5742.28221472316;5611.298587676541;5616.8876622466505;5621.437856214346;5624.353199382123;5629.634073785191;5667.574931880043;5686.886262274814;5728.112142617901;5763.193152958505;5783.797567085132;5442.782288708408;5551;5555.388907220122;5556.472135147154;5616.831495055155 06:05:08 INFO - PROCESS | 17573 | |1;ext.html;596.9134475501053;638.1066506890353;641.4099028893418;651;676.4182802789597;35510.644893551056;36864.44703329452;36884.446733299024;36902;36970.26059478815;38147.61852381475;38589.80705096477;38593.42109868354;38650.8067459663;38769.61230387695;8366.958165209166;8539.829203415928;8548.914510854906;8551.871721924175;8556.058833528306;8410.411271211018;8592.355573331994;8611.698590549331;8675.783105422383;8700.608472618716;8659.263962563158;8665.480071195718;8709.477431354107;8726.345524085687;8756.737297881074;8649.178328058855;8665.43674661145;8690.391672582922;8694.478331300143;8732.607032683482;8585.570721463902;8609.827803443959;8622.741317760478;8665.35009874262;8679.43583667066;29884.701152988408;36787.264254715024;37497.43753843695;37585;37598.43602345967;3250.8087146794733;3401.642827503101;3633.9273214535824;4002.939955900664;4249.2563801334645;29711.554326685116;29993.70006299931;30116.763515488372;30283.07440556373;31068.223294417596;4278.465191851019;4321.24378233811;4322.265214913472;4364.956350436487;4390.824367025315;296879;299610;303649;303831.9999999978;304907;61275.38724612697;61384.693076534335;61733;61893.69053154706;62010;65817.34182658208;66349;68698;69070.30929690639;69100.65449672719;16185.59536011609;16378.099204543865;16392.426265080903;16406.671866562603;16408.83591164097;12130.029597632345;12169.878301216875;12196.14626976121;12208.755824883452;12215.877841221652;20221.49446263855;20366.898165509374;20385.592288154156;20446.488837779176;20483.59032819365;7639.694412223449;7696.692132314756;7706;7841.451098423056;8024.959875200587;1025.0518270599666;1055.7413433708791;1121.545773961547;1130.547780887635;1130.728625129963;31460.37079258448;31495.842520787708;31667.524987125213;32331;32639.184020399203;1092.3664274720643;1106.7233191702076;1115.1914861725184;1137.8122609769462;1195.3903509210365;14350.856491435161;14691.118532887847;14699.412023519153;14738;14788.412482091047;411362;412083;414844;416992;426235;51840.22239666408;52415;52540;52690.20964685533;52932.47067529352;1418.5318844781198;1420.8010878476814;1427.336288625794;1439.417036100381;1454.185656032625;28854.711452885203;29399.706002939696;29579.704202957695;29915.75631827665;30352.241193970327;45680.54319456763;46467.76766116148;46684;46710.53289467062;46722.76638616921;399657;400414;402720;403539;404709;27777.916656250458;28103.859480702467;28269.29326766765;28427.28931776722;28428.85785571059;44439.55560444354;44465;44590.77704611456;45343;45543;38886.61113388943;38904.2219155621;39109.804450977565;39692.2061558773;39761.2047759049;37198.44202337021;37702.62297376991;38416.61583384242;38514.80742596269;39194;32403.837980809945;33017.17457063593;33342.833285834386;39734.80132599318;40598.18803623852;30335.544966825957;31288.21779455532;31381.686183137877;31576.36847263088;33517;25710.228693139237;25839.741602583734;26233.213003609922;26251;26385.472290554466 06:05:08 INFO - PROCESS | 17573 | |2;jquery.html;382.6728147433944;387.17918013810714;395.5372214509024;395.7770489188407;403.1232070247212;14008.789868151986;14278.571642850706;17506.38727644531;18098.63802723945;18125.456236312915;17834.910825445888;17869.82130178698;18084;18084.186211620476;18724.719129213037;4776.97611511942;4997.125503036972;5177.197534382177;5224.138017227153;5224.346956630421;5562.443755624426;5576.776928922838;5584.301962254718;5617.41017193195;5622.606417550773;5071.290019397269;5337.2794672719265;5580;5587.664740115606;5589.804356847511;5147.0992576298995;5150.845474635767;5156.123459011977;5167.586593072564;5182.896342073156;4815.518448155191;4999.650024498286;5004.349434573519;5010.023045506127;5013.6490445668815;13029.739405211843;13368.532101376502;13472.663183420493;13514.391852366569;13612.31938403076;2285.8285628577923;2363.1610778173845;2375.5011447596025;2391.5695174868515;2416.7583241675693;9665.661701840472;11355.432228388547;13541.796873046913;14057.367418466194;14181.716365672628;1884.6513395021964;1890.7258447525169;1916.3963351544219;1922.0459464289222;1950.9609807803906;61705;72675;79760;79902.60048699778;82157;10198.133158681447;10539.789204215873;10556.841647375142;10571.36571805694;10785.245032847626;14591.78112328316;14873.92563037178;14904.478343257933;14921.328540215716;14932;7829.256220659028;7969.322607578305;8011.679532818738;8026.317762990095;8040.7938809179095;7532.849343013109;7627.733029343946;7726.227377262228;7765.805854853674;7949.403794715419;4446.888827779267;4577.382053422745;4592.254125346704;4595.701279416827;4658.697184682985;1862.5622978600288;1927.4699457649258;1946.4452631000381;1971.3001884331143;1972.3688419705843;880.3969281042506;994.4928086675848;1000.9149222316039;1057.8519007338978;1060.5492665617082;17043.062631555134;18469.53826154357;18542;18662.626747464976;18969.43091707251;994.7562847102362;1008.6570566007592;1011.6358111080006;1019.6176433837311;1058.1270451877078;10302.433366164783;10596.31123976939;10640.521176547074;10692.411917344465;10760.46197690128;448475;451147;468818;469735;472838;89429;89992;90509;90837.54581227052;91311.54344228236;949.6296444386695;955.6082006377352;966.6036924860773;970.1220395542045;984.1732944326657;16301.51095467138;16374.83625163733;16495.17524123813;16560.343965603344;16592.75110873362;36861.07847303731;38033.619663804115;38286.80856595699;38416.42375364316;38609.80695096507;51044;54694;55158.448415516934;55241.44758552363;55329;5039.748012599282;5329.866753331198;7794.766157015299;7872.01599800025;8450.704225352083;11672.241304315192;12786.74426511446;13054.54309099177;13171.47314107425;13314.667133321744;5441.83674489766;7861.489003214772;10488.947555262175;11074.39090850011;11751.413559169403;11051.557937682403;11173.106151508022;11352.716182095513;11362.829557556477;11461.48423320936;11203.71990700239;11324.37715925632;11642.825357619473;11685.240459370114;11864.762704745684;8457.915420845713;8475.32197424217;8620.224179823846;8630.482171069756;8631.870521942301;8503.362247831561;10965.780684386427;11584.768304634028;11632.76734465289;11707.531698731955 06:05:08 INFO - PROCESS | 17573 | |3;mootools.html;1477.4238047161605;1508.9320980555874;1598.9920050399753;1680.2690829489165;1692.8137904830473;7175.067241258629;8060.476069055508;8092.514449133041;8239.546824924626;8301.87547186792;8086.71696490623;8093.514389136656;8105.594720263978;8110.716124935629;8166;2198.8131008864266;2234.0728597632046;2238.55228954209;2238.753737088919;2241.1707668162803;2201.680756290337;2204.933851984443;2217.2018073493527;2225.7662945390744;2278.646809744484;2224.2548746169973;2225.7996780289773;2249.5388445368744;2260.480089579398;2290.816734661223;2197.6703494475796;2225.5660146271484;2232.0290673557056;2234.3967128875192;2246.1015593762545;2238.2837492002564;2248.5615305015526;2250.2349201271645;2257.3340864445026;2262.6040442922585;8211.425200235986;8251;8309.293710034653;8326.45878017927;8330.208630180123;4976;5152.227165925104;5159.948400515985;5171.922421163686;5195.6622819516615;3215.3569286142865;3312.9171770705684;3442.3287458945515;3460.2214501737158;3511.8595256189724;1098.6649072033026;1104.4312179227704;1112.2103306652286;1119.731264496515;1144.730988217768;11549.595764148215;11555.711107222303;11558.422078896107;11561.190716649839;11572.59495917639;4165.354370072643;4254.680898932593;4384.298512238027;4397.208502469586;4475.328700694922;9783.853242201372;9819.116279534876;9846.606135754633;9850.901490985141;9855.063768941938;4949.925751113737;4970.552650261494;4998.4251811042195;5005.974970125126;5055.797768089235;4052.169305292408;4494.5730155635165;4619.792109355087;4644.814207431665;4645.210314246586;3775.7923314217433;3833.6933045356304;3881.1073453105378;3912.7065470089287;3922.490076290064;1255.1026016398318;1258.6853286678331;1258.9748205035849;1260.9054320925784;1279.9104062715521;842.0358689300716;887.5784002598714;909.3861643390685;911.1389736698756;915.9954200228956;5504.80733174337;5538.16037194065;5553.444655534495;5591.217229587861;5640.633358831745;921.3320342751585;958.4393130018877;964.8504481805331;973.5035132082688;1019.0675531888239;3806.333891568964;3956.4263181838473;3968.7023473239624;3972.682185425159;3996.7801770902297;10087;10371.377717336984;10507.789844203226;10513.474326283655;10524.158067354594;10230.28388012832;10242.59029638821;10378;10386.11718003963;10397.11624511925;7288.6720097595735;7678.884816727754;7713.614319284014;7787.766367008885;7814.726484573012;5436.7553460093595;5437;5437.5378092860965;5569.582281328835;5620.718964051699;9096.727098187064;9159;9233.445993240428;9272.675456358995;9324.11420915012;9396.107369799858;9411.152996230097;9509.476978766234;9524.428534287965;9529.809403812023;6752.797416077526;7245.710171593078;7275.6362181889635;7457.142428620561;7460.440466965108;8003.959485266878;8007.239312265326;8046.637901294573;8053.194680532134;8073.596320184085;7041.43668506508;7281.781546553612;7291.927080729125;7367.594782287026;7375.557466552024;7037.7184912602925;7211.891821622575;7215.422766178588;7219.0976127984;7291.307325804252;6647.235567909753;6693.297203793726;6705.865882682417;6735.898961515679;6740.966295168493;4634.791434385528;4831.613470922388;4842.37049183618;4849.3210950466255;4856.490068542894;4869.293952376956;4885.65800393969;4897.853064408074;4898.093852637274;4948.233023881304 06:05:08 INFO - PROCESS | 17573 | |4;prototype.html;323.8607398818508;326.45319090523367;334.2829630442701;335.8774047472672;340.28879641549156;5872.4127587241255;6005.399460053998;6029.6382217067;6139.01775715885;6178.165947597078;6024.909626355608;6054.485368743651;6074.088886667002;6091.2690477142805;6097;4668.346431499593;4681.64887633428;4681.9297710534365;4685.273782563691;4689.976550117244;4367;4590.793414296365;4607.1476776796235;4614.584687378136;4692.319613656018;4554.954450455486;4564.771761411933;4587.72473651582;4589.79345929434;4599.356090147382;4590.05903789724;4607.3549703041435;4608.539146085364;4612.607928326096;4626.074785043005;3896.649301562845;3942.763434193929;3959.109200429909;3968.523777146732;3975.9602403975878;5793;5802.419758024206;5819.923314186889;5822.767089316422;5840.072775983957;5194.857131431117;5231.738413079369;5232.895342093137;5249.816256431045;5273.630845840793;6221.097940798604;6270.78052268173;6285.340039295854;6321.462675672527;6323.93676063238;4238.152369526107;4242.278812601865;4251.149770046003;4251.341042138473;4260.55264197261;6470;6558.573692709959;6568.408843204134;6618.966905165492;6629.867402651968;4423.20382331177;4449.822007119744;4456.665750068758;4464.821407143743;4477.552244775497;4514.187446259705;4531.68278220528;4532.501424843264;4541.661044562054;4551.2717965126085;5005.224190250444;5272.657277276965;5275.287836142072;5284.916592098611;5289.18017707256;6270.7491700331475;6430.549861509649;6433.581817181868;6433.742650293936;6438.8390290243115;1541.175471122944;1548.6902619475925;1557.353698215228;1559.594505428574;1560.508439841469;1019.3017782818793;1020.6070662794729;1032.808930347888;1045.994770026145;1051.9434505541649;6177.96911015451;6201.10084037812;6217.844553886189;6223.626582405071;6244.313125556185;6519.250286217051;6565.179352580927;6567.310432404529;6585.769498067544;6594.8351291218105;5917.940820591739;6098.878022439526;6196.442320191204;6202.906956395657;6205.813825585149;3532.823358832048;3536.964630353715;3561.519194908706;3568.411212150018;3569.660882216185;6686.5653732507235;6806.625635589991;6817.5568588041615;6825.69284382204;6904.654767261617;6652.234992975773;6680.565763225472;6685.398314151653;6692.765753198712;6699.129113215251;6543.378379053982;6824.283450237753;6828.487863410264;6832.350926661959;6885.311468853175;6525.247982410228;6558.344165583403;6595.307492713196;6597.736090556324;6610.8347291318105;6289.465395441439;6496.317886621837;6520.804375868732;6534.738610455529;6558.672066396565;6731.764388246388;6751.966240168767;6763.661816909036;6779.491538134758;6808.659567021728;4392.209402307615;4402.625776809007;4404.273294906305;4405.920549465402;4408.096340250305;6319;6482.476617994673;6599.7360105595235;6689.966550167218;6712.362325579063;6444.903326450013;6462.933615953315;6465.224173099258;6484.319146489551;6486.870262594816;6258.342873998165;6425.518086143465;6446.129772480655;6447.4197322241225;6467.838304042437;6276.686165691606;6344.365563443619;6372.299047104908;6378.968105159444;6379.234491861006;6434.227892652912;6446.129772480655;6479.1901012373455;6485.935140648722;6492;6145.9692701536205;6304.7162877671535;6314.137329487904;6333.240011198685;6373.553851230555 06:05:08 INFO - PROCESS | 17573 | |5;yui.html;735.9779206623801;839.1734141870259;847.4915050969419;850.438710451102;869.7086476030529;13159.934200328997;13872.583822485316;14689.559313220594;14741.48404805832;14747.48383806567;14935;14997.700045999074;15008.774868376982;15054.623634409145;15059.924700376483;641.8652083062562;780.1340512031641;799.5083023940279;800.2917418084978;800.8518424091533;802.0495712580581;807.3823525003348;807.90709068457;808.308895894011;809.2150613904532;850.1838235294125;851.259404318244;853.0616322045762;854.3763052971335;856.0070318430621;842.2924743215698;844.3329769482102;848.1264297773241;849.3969281809923;855.7646647172046;609.0590038390696;610.0239616613427;610.7099127914249;611.3153268339444;614.4316507230793;13566.389512471962;13602.93198534001;13671.658208544766;13678.863211367958;13700.725985480334;12130.45412956419;12357.814632780515;12794.040446966515;13543.59369218925;13608.183508989394;11139.777204455866;11177.66467005991;11230.94384528072;11400.372979486125;11441.313521188755;3748.8687895923513;3914.2367238388524;3922.92119667091;3955.4857868476915;4012.7592344459426;49433.25850112251;53157;53298;53645.73177134089;54112.99999999961;11305.70383254358;11489.770204595861;11562.479688414041;11885.76228475443;11894.82157767634;20403;20538.38384848457;20558.588828223652;20605.79394206069;20706.68939965902;8013.679452821939;8109.067457242375;8138.104808471064;8310.293625041939;8312.127226641236;4502.617277531446;4568.285575039023;4602.332661764025;4702.835400760957;4747.311639812277;3248.8700451982127;3300.075978725961;3304.7190988766224;3305.190228394011;3308.6360500344945;567.6764244380663;587.7355190164358;588.3733823477983;590.9349971503132;595.5235811350902;618.3785295777715;718.608358444649;723.2839488905945;738.8263758016861;762.9852296445714;8562.74311770648;9054.909450905407;9227.95386023079;9248.491332976617;9465.195458386115;571.4456976732563;604.8125081224835;698.6122701900392;719.6401799100449;732.0812380462486;4358.5205627380965;4363.650907927422;4425;4436.645068394585;4482.21561226784;60185.699071504365;62137.68931155315;62212.68893655503;62635.06047409293;63177.68411157915;53403.19895201575;54051.45948540543;54715.45284547104;54761.1785823213;55104.448955510736;44657;47620.5237947623;48350.5164948346;48605.5139448601;49692.254616180784;8705.608247629;8771.473711577326;8772.29779668803;8797;8923.73228803137;31756.523652145697;32671.509927350635;32717.672823272416;33078.17304567405;33116.503252451716;37337;40647;44067.33898991453;44076.55923440724;45087.54912450833;11486.597969071378;11534.077273817906;11717.76564468723;11854.288742675468;11953.641390758292;12760.074859638178;12982.675433113869;13083.149595276276;13495.932520337336;13792.103513271606;12750.48998040068;12813.295268760308;12898.097133200587;12898.290594017044;13219.933900330438;12732.809007864704;12745.617631470699;12791.872081279069;12958.546450874173;13511.932440337736;12262.754744904874;12454.564090256797;12479;12543.937280313905;12580.245185288912;10596.470176491299;10709.678709638723;10872.565097396016;11059.281146725438;11214.495347709535;10692.679219623424;10785.298955567863;11019.504122314675;11070.335779853234;11098 06:05:08 INFO - PROCESS | 17573 | __end_tp_report 06:05:08 INFO - PROCESS | 17573 | __start_cc_report 06:05:08 INFO - PROCESS | 17573 | _x_x_mozilla_cycle_collect,346 06:05:08 INFO - PROCESS | 17573 | __end_cc_report 06:05:08 INFO - PROCESS | 17573 | __startTimestamp1461503108603__endTimestamp 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | ------- Summary: start ------- 06:05:08 INFO - PROCESS | 17573 | Number of tests: 6 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#0] dojo.html Cycles:165 Average:5371.78 Median:5607.16 stddev:709.80 (12.7%) stddev-sans-first:690.63 06:05:08 INFO - PROCESS | 17573 | Values: 3169.3 3212.3 3225.9 3260.7 3261.8 5407.1 5432.2 5480.2 5486.1 5519.3 5351.1 5448.4 5487.1 5521.8 5558.0 4958.4 4994.6 5051.3 5065.3 5116.2 782.0 4897.4 4956.3 4976.5 5081.0 4931.3 4942.3 4959.7 4991.0 4994.2 4980.0 4989.3 5000.0 5004.1 5042.2 4890.5 4919.8 4941.2 4942.6 4954.7 5272.5 5305.5 5315.7 5347.9 5352.5 5587.1 5768.2 5770.5 5783.6 5828.9 5771.0 5829.5 5836.0 5838.6 5881.6 5424.2 5425.1 5427.6 5429.3 5455.9 5837.6 5875.9 5878.2 5885.6 5955.1 5741.8 5745.4 5755.9 5756.6 5766.5 5832.9 5843.9 5844.7 5851.5 5854.6 5770.6 5779.1 5806.0 5818.2 5850.2 5685.0 5695.1 5724.1 5741.9 5751.7 4253.5 4326.8 4339.0 4343.5 4376.7 3783.1 3872.1 3908.9 3920.5 3925.7 5448.7 5477.0 5546.2 5567.2 5607.2 5606.0 5855.8 5868.3 5875.2 5878.0 5428.5 5529.8 5551.8 5562.6 5566.2 4881.1 4915.7 4923.8 4994.2 5001.3 5855.5 6041.3 6051.7 6056.1 6080.3 5840.5 5892.8 5895.9 5905.0 5915.1 6044.6 6061.7 6062.0 6070.8 6093.9 5579.7 5707.5 5763.5 5770.8 5802.8 5766.7 5780.7 5796.7 5805.1 5853.6 5600.7 5610.7 5614.5 5616.7 5617.1 5548.8 5623.3 5684.5 5718.1 5742.3 5611.3 5616.9 5621.4 5624.4 5629.6 5667.6 5686.9 5728.1 5763.2 5783.8 5442.8 5551.0 5555.4 5556.5 5616.8 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#1] ext.html Cycles:180 Average:53400.38 Median:38552.31 stddev:99451.91 (258.0%) stddev-sans-first:99651.88 06:05:08 INFO - PROCESS | 17573 | Values: 596.9 638.1 641.4 651.0 676.4 35510.6 36864.4 36884.4 36902.0 36970.3 38147.6 38589.8 38593.4 38650.8 38769.6 8367.0 8539.8 8548.9 8551.9 8556.1 8410.4 8592.4 8611.7 8675.8 8700.6 8659.3 8665.5 8709.5 8726.3 8756.7 8649.2 8665.4 8690.4 8694.5 8732.6 8585.6 8609.8 8622.7 8665.4 8679.4 29884.7 36787.3 37497.4 37585.0 37598.4 3250.8 3401.6 3633.9 4002.9 4249.3 29711.6 29993.7 30116.8 30283.1 31068.2 4278.5 4321.2 4322.3 4365.0 4390.8 296879.0 299610.0 303649.0 303832.0 304907.0 61275.4 61384.7 61733.0 61893.7 62010.0 65817.3 66349.0 68698.0 69070.3 69100.7 16185.6 16378.1 16392.4 16406.7 16408.8 12130.0 12169.9 12196.1 12208.8 12215.9 20221.5 20366.9 20385.6 20446.5 20483.6 7639.7 7696.7 7706.0 7841.5 8025.0 1025.1 1055.7 1121.5 1130.5 1130.7 31460.4 31495.8 31667.5 32331.0 32639.2 1092.4 1106.7 1115.2 1137.8 1195.4 14350.9 14691.1 14699.4 14738.0 14788.4 411362.0 412083.0 414844.0 416992.0 426235.0 51840.2 52415.0 52540.0 52690.2 52932.5 1418.5 1420.8 1427.3 1439.4 1454.2 28854.7 29399.7 29579.7 29915.8 30352.2 45680.5 46467.8 46684.0 46710.5 46722.8 399657.0 400414.0 402720.0 403539.0 404709.0 27777.9 28103.9 28269.3 28427.3 28428.9 44439.6 44465.0 44590.8 45343.0 45543.0 38886.6 38904.2 39109.8 39692.2 39761.2 37198.4 37702.6 38416.6 38514.8 39194.0 32403.8 33017.2 33342.8 39734.8 40598.2 30335.5 31288.2 31381.7 31576.4 33517.0 25710.2 25839.7 26233.2 26251.0 26385.5 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#2] jquery.html Cycles:180 Average:27189.89 Median:19334.74 stddev:76308.57 (394.7%) stddev-sans-first:76496.08 06:05:08 INFO - PROCESS | 17573 | Values: 382.7 387.2 395.5 395.8 403.1 14008.8 14278.6 17506.4 18098.6 18125.5 17834.9 17869.8 18084.0 18084.2 18724.7 4777.0 4997.1 5177.2 5224.1 5224.3 5562.4 5576.8 5584.3 5617.4 5622.6 5071.3 5337.3 5580.0 5587.7 5589.8 5147.1 5150.8 5156.1 5167.6 5182.9 4815.5 4999.7 5004.3 5010.0 5013.6 13029.7 13368.5 13472.7 13514.4 13612.3 2285.8 2363.2 2375.5 2391.6 2416.8 9665.7 11355.4 13541.8 14057.4 14181.7 1884.7 1890.7 1916.4 1922.0 1951.0 61705.0 72675.0 79760.0 79902.6 82157.0 10198.1 10539.8 10556.8 10571.4 10785.2 14591.8 14873.9 14904.5 14921.3 14932.0 7829.3 7969.3 8011.7 8026.3 8040.8 7532.8 7627.7 7726.2 7765.8 7949.4 4446.9 4577.4 4592.3 4595.7 4658.7 1862.6 1927.5 1946.4 1971.3 1972.4 880.4 994.5 1000.9 1057.9 1060.5 17043.1 18469.5 18542.0 18662.6 18969.4 994.8 1008.7 1011.6 1019.6 1058.1 10302.4 10596.3 10640.5 10692.4 10760.5 448475.0 451147.0 468818.0 469735.0 472838.0 89429.0 89992.0 90509.0 90837.5 91311.5 949.6 955.6 966.6 970.1 984.2 16301.5 16374.8 16495.2 16560.3 16592.8 36861.1 38033.6 38286.8 38416.4 38609.8 51044.0 54694.0 55158.4 55241.4 55329.0 5039.7 5329.9 7794.8 7872.0 8450.7 11672.2 12786.7 13054.5 13171.5 13314.7 5441.8 7861.5 10488.9 11074.4 11751.4 11051.6 11173.1 11352.7 11362.8 11461.5 11203.7 11324.4 11642.8 11685.2 11864.8 8457.9 8475.3 8620.2 8630.5 8631.9 8503.4 10965.8 11584.8 11632.8 11707.5 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#3] mootools.html Cycles:180 Average:5478.26 Median:4949.08 stddev:3062.46 (61.9%) stddev-sans-first:3056.30 06:05:08 INFO - PROCESS | 17573 | Values: 1477.4 1508.9 1599.0 1680.3 1692.8 7175.1 8060.5 8092.5 8239.5 8301.9 8086.7 8093.5 8105.6 8110.7 8166.0 2198.8 2234.1 2238.6 2238.8 2241.2 2201.7 2204.9 2217.2 2225.8 2278.6 2224.3 2225.8 2249.5 2260.5 2290.8 2197.7 2225.6 2232.0 2234.4 2246.1 2238.3 2248.6 2250.2 2257.3 2262.6 8211.4 8251.0 8309.3 8326.5 8330.2 4976.0 5152.2 5159.9 5171.9 5195.7 3215.4 3312.9 3442.3 3460.2 3511.9 1098.7 1104.4 1112.2 1119.7 1144.7 11549.6 11555.7 11558.4 11561.2 11572.6 4165.4 4254.7 4384.3 4397.2 4475.3 9783.9 9819.1 9846.6 9850.9 9855.1 4949.9 4970.6 4998.4 5006.0 5055.8 4052.2 4494.6 4619.8 4644.8 4645.2 3775.8 3833.7 3881.1 3912.7 3922.5 1255.1 1258.7 1259.0 1260.9 1279.9 842.0 887.6 909.4 911.1 916.0 5504.8 5538.2 5553.4 5591.2 5640.6 921.3 958.4 964.9 973.5 1019.1 3806.3 3956.4 3968.7 3972.7 3996.8 10087.0 10371.4 10507.8 10513.5 10524.2 10230.3 10242.6 10378.0 10386.1 10397.1 7288.7 7678.9 7713.6 7787.8 7814.7 5436.8 5437.0 5437.5 5569.6 5620.7 9096.7 9159.0 9233.4 9272.7 9324.1 9396.1 9411.2 9509.5 9524.4 9529.8 6752.8 7245.7 7275.6 7457.1 7460.4 8004.0 8007.2 8046.6 8053.2 8073.6 7041.4 7281.8 7291.9 7367.6 7375.6 7037.7 7211.9 7215.4 7219.1 7291.3 6647.2 6693.3 6705.9 6735.9 6741.0 4634.8 4831.6 4842.4 4849.3 4856.5 4869.3 4885.7 4897.9 4898.1 4948.2 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#4] prototype.html Cycles:180 Average:5325.13 Median:6142.49 stddev:1625.09 (26.5%) stddev-sans-first:1585.70 06:05:08 INFO - PROCESS | 17573 | Values: 323.9 326.5 334.3 335.9 340.3 5872.4 6005.4 6029.6 6139.0 6178.2 6024.9 6054.5 6074.1 6091.3 6097.0 4668.3 4681.6 4681.9 4685.3 4690.0 4367.0 4590.8 4607.1 4614.6 4692.3 4555.0 4564.8 4587.7 4589.8 4599.4 4590.1 4607.4 4608.5 4612.6 4626.1 3896.6 3942.8 3959.1 3968.5 3976.0 5793.0 5802.4 5819.9 5822.8 5840.1 5194.9 5231.7 5232.9 5249.8 5273.6 6221.1 6270.8 6285.3 6321.5 6323.9 4238.2 4242.3 4251.1 4251.3 4260.6 6470.0 6558.6 6568.4 6619.0 6629.9 4423.2 4449.8 4456.7 4464.8 4477.6 4514.2 4531.7 4532.5 4541.7 4551.3 5005.2 5272.7 5275.3 5284.9 5289.2 6270.7 6430.5 6433.6 6433.7 6438.8 1541.2 1548.7 1557.4 1559.6 1560.5 1019.3 1020.6 1032.8 1046.0 1051.9 6178.0 6201.1 6217.8 6223.6 6244.3 6519.3 6565.2 6567.3 6585.8 6594.8 5917.9 6098.9 6196.4 6202.9 6205.8 3532.8 3537.0 3561.5 3568.4 3569.7 6686.6 6806.6 6817.6 6825.7 6904.7 6652.2 6680.6 6685.4 6692.8 6699.1 6543.4 6824.3 6828.5 6832.4 6885.3 6525.2 6558.3 6595.3 6597.7 6610.8 6289.5 6496.3 6520.8 6534.7 6558.7 6731.8 6752.0 6763.7 6779.5 6808.7 4392.2 4402.6 4404.3 4405.9 4408.1 6319.0 6482.5 6599.7 6690.0 6712.4 6444.9 6462.9 6465.2 6484.3 6486.9 6258.3 6425.5 6446.1 6447.4 6467.8 6276.7 6344.4 6372.3 6379.0 6379.2 6434.2 6446.1 6479.2 6485.9 6492.0 6146.0 6304.7 6314.1 6333.2 6373.6 06:05:08 INFO - PROCESS | 17573 | 06:05:08 INFO - PROCESS | 17573 | [#5] yui.html Cycles:180 Average:14590.00 Median:24250.78 stddev:16618.31 (68.5%) stddev-sans-first:16632.36 06:05:08 INFO - PROCESS | 17573 | Values: 736.0 839.2 847.5 850.4 869.7 13159.9 13872.6 14689.6 14741.5 14747.5 14935.0 14997.7 15008.8 15054.6 15059.9 641.9 780.1 799.5 800.3 800.9 802.0 807.4 807.9 808.3 809.2 850.2 851.3 853.1 854.4 856.0 842.3 844.3 848.1 849.4 855.8 609.1 610.0 610.7 611.3 614.4 13566.4 13602.9 13671.7 13678.9 13700.7 12130.5 12357.8 12794.0 13543.6 13608.2 11139.8 11177.7 11230.9 11400.4 11441.3 3748.9 3914.2 3922.9 3955.5 4012.8 49433.3 53157.0 53298.0 53645.7 54113.0 11305.7 11489.8 11562.5 11885.8 11894.8 20403.0 20538.4 20558.6 20605.8 20706.7 8013.7 8109.1 8138.1 8310.3 8312.1 4502.6 4568.3 4602.3 4702.8 4747.3 3248.9 3300.1 3304.7 3305.2 3308.6 567.7 587.7 588.4 590.9 595.5 618.4 718.6 723.3 738.8 763.0 8562.7 9054.9 9228.0 9248.5 9465.2 571.4 604.8 698.6 719.6 732.1 4358.5 4363.7 4425.0 4436.6 4482.2 60185.7 62137.7 62212.7 62635.1 63177.7 53403.2 54051.5 54715.5 54761.2 55104.4 44657.0 47620.5 48350.5 48605.5 49692.3 8705.6 8771.5 8772.3 8797.0 8923.7 31756.5 32671.5 32717.7 33078.2 33116.5 37337.0 40647.0 44067.3 44076.6 45087.5 11486.6 11534.1 11717.8 11854.3 11953.6 12760.1 12982.7 13083.1 13495.9 13792.1 12750.5 12813.3 12898.1 12898.3 13219.9 12732.8 12745.6 12791.9 12958.5 13511.9 12262.8 12454.6 12479.0 12543.9 12580.2 10596.5 10709.7 10872.6 11059.3 11214.5 10692.7 10785.3 11019.5 11070.3 11098.0 06:05:08 INFO - PROCESS | 17573 | -------- Summary: end -------- 06:05:08 INFO - PROCESS | 17573 | 06:05:09 INFO - TEST-INFO | 17573: exit 0 06:05:09 INFO - TEST-OK | dromaeo_css | took 1109934ms 06:05:09 INFO - TEST-START | kraken 06:05:09 INFO - operating with platform_type : linux_ 06:05:09 INFO - Initialising browser for kraken test... 06:05:09 INFO - TEST-INFO | started process 17809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaOXbtT/profile http://localhost:42933/getInfo.html) 06:05:13 INFO - PROCESS | 17809 | 06:05:13 INFO - PROCESS | 17809 | (process:17879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:13 INFO - PROCESS | 17809 | __metrics Screen width/height:1600/1200 06:05:13 INFO - PROCESS | 17809 | colorDepth:24 06:05:13 INFO - PROCESS | 17809 | Browser inner width/height: 1024/697 06:05:13 INFO - PROCESS | 17809 | __metrics 06:05:14 ERROR - PROCESS | 17809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:05:15 INFO - TEST-INFO | 17809: exit 0 06:05:15 INFO - Browser initialized. 06:05:15 INFO - Running cycle 1/1 for kraken test... 06:05:15 INFO - TEST-INFO | started process 17930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaOXbtT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:17 INFO - PROCESS | 17930 | 06:05:17 INFO - PROCESS | 17930 | (process:17990): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:27 INFO - PROCESS | 17930 | RSS: Main: 164880384 06:05:27 INFO - PROCESS | 17930 | 06:05:29 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42933/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:30 INFO - PROCESS | 17930 | RSS: Main: 169324544 06:05:30 INFO - PROCESS | 17930 | 06:05:33 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42933/tests/kraken/driver.html?testName=audio-dft) 06:05:33 INFO - PROCESS | 17930 | RSS: Main: 172539904 06:05:33 INFO - PROCESS | 17930 | 06:05:36 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42933/tests/kraken/driver.html?testName=audio-fft) 06:05:37 INFO - PROCESS | 17930 | RSS: Main: 162283520 06:05:37 INFO - PROCESS | 17930 | 06:05:39 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42933/tests/kraken/driver.html?testName=audio-oscillator) 06:05:40 INFO - PROCESS | 17930 | RSS: Main: 163176448 06:05:40 INFO - PROCESS | 17930 | 06:05:42 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:43 INFO - PROCESS | 17930 | RSS: Main: 164945920 06:05:43 INFO - PROCESS | 17930 | 06:05:46 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42933/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:46 INFO - PROCESS | 17930 | RSS: Main: 164352000 06:05:46 INFO - PROCESS | 17930 | 06:05:50 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42933/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:50 INFO - PROCESS | 17930 | RSS: Main: 167034880 06:05:50 INFO - PROCESS | 17930 | 06:05:53 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42933/tests/kraken/driver.html?testName=json-parse-financial) 06:05:54 INFO - PROCESS | 17930 | RSS: Main: 166666240 06:05:54 INFO - PROCESS | 17930 | 06:05:55 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:56 INFO - PROCESS | 17930 | RSS: Main: 167518208 06:05:56 INFO - PROCESS | 17930 | 06:05:58 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:58 INFO - PROCESS | 17930 | RSS: Main: 167149568 06:05:58 INFO - PROCESS | 17930 | 06:06:00 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:01 INFO - PROCESS | 17930 | RSS: Main: 167251968 06:06:01 INFO - PROCESS | 17930 | 06:06:04 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:04 INFO - PROCESS | 17930 | RSS: Main: 167956480 06:06:04 INFO - PROCESS | 17930 | 06:06:07 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:08 INFO - PROCESS | 17930 | RSS: Main: 167813120 06:06:08 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | Cycle 1(1): loaded http://localhost:42933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42933/tests/kraken/driver.html?testName=ai-astar) 06:06:10 INFO - PROCESS | 17930 | RSS: Main: 169422848 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | __start_tp_report 06:06:10 INFO - PROCESS | 17930 | _x_x_mozilla_page_load 06:06:10 INFO - PROCESS | 17930 | _x_x_mozilla_page_load_details 06:06:10 INFO - PROCESS | 17930 | |i|pagename|runs| 06:06:10 INFO - PROCESS | 17930 | |0;ai-astar;112;108;112;109;112;123;111;117;112;110 06:06:10 INFO - PROCESS | 17930 | |1;audio-beat-detection;163;131;160;185;129;159;160;136;183;135 06:06:10 INFO - PROCESS | 17930 | |2;audio-dft;163;163;163;162;161;166;167;163;165;164 06:06:10 INFO - PROCESS | 17930 | |3;audio-fft;77;73;75;161;75;78;77;76;171;76 06:06:10 INFO - PROCESS | 17930 | |4;audio-oscillator;93;95;153;93;93;93;151;93;93;139 06:06:10 INFO - PROCESS | 17930 | |5;imaging-gaussian-blur;118;117;117;117;117;116;118;117;118;117 06:06:10 INFO - PROCESS | 17930 | |6;imaging-darkroom;146;147;146;146;146;146;147;147;145;146 06:06:10 INFO - PROCESS | 17930 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;94;96 06:06:10 INFO - PROCESS | 17930 | |8;json-parse-financial;60;61;60;58;61;60;62;74;58;58 06:06:10 INFO - PROCESS | 17930 | |9;json-stringify-tinderbox;61;63;63;61;62;62;61;62;61;62 06:06:10 INFO - PROCESS | 17930 | |10;stanford-crypto-aes;80;85;77;78;87;80;79;79;80;88 06:06:10 INFO - PROCESS | 17930 | |11;stanford-crypto-ccm;132;134;128;129;135;128;130;144;164;150 06:06:10 INFO - PROCESS | 17930 | |12;stanford-crypto-pbkdf2;171;165;175;173;169;169;172;166;175;168 06:06:10 INFO - PROCESS | 17930 | |13;stanford-crypto-sha256-iterative;71;69;71;73;71;68;67;68;75;72 06:06:10 INFO - PROCESS | 17930 | __end_tp_report 06:06:10 INFO - PROCESS | 17930 | __start_cc_report 06:06:10 INFO - PROCESS | 17930 | _x_x_mozilla_cycle_collect,852 06:06:10 INFO - PROCESS | 17930 | __end_cc_report 06:06:10 INFO - PROCESS | 17930 | __startTimestamp1461503170264__endTimestamp 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | ------- Summary: start ------- 06:06:10 INFO - PROCESS | 17930 | Number of tests: 14 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.64 06:06:10 INFO - PROCESS | 17930 | Values: 112.0 108.0 112.0 109.0 112.0 123.0 111.0 117.0 112.0 110.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:160.00 stddev:20.60 (12.9%) stddev-sans-first:21.60 06:06:10 INFO - PROCESS | 17930 | Values: 163.0 131.0 160.0 185.0 129.0 159.0 160.0 136.0 183.0 135.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.83 (1.1%) stddev-sans-first:1.92 06:06:10 INFO - PROCESS | 17930 | Values: 163.0 163.0 163.0 162.0 161.0 166.0 167.0 163.0 165.0 164.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.10 (50.1%) stddev-sans-first:39.91 06:06:10 INFO - PROCESS | 17930 | Values: 77.0 73.0 75.0 161.0 75.0 78.0 77.0 76.0 171.0 76.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.52 (28.5%) stddev-sans-first:27.44 06:06:10 INFO - PROCESS | 17930 | Values: 93.0 95.0 153.0 93.0 93.0 93.0 151.0 93.0 93.0 139.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:06:10 INFO - PROCESS | 17930 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:06:10 INFO - PROCESS | 17930 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:06:10 INFO - PROCESS | 17930 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:60.50 stddev:4.71 (7.8%) stddev-sans-first:4.97 06:06:10 INFO - PROCESS | 17930 | Values: 60.0 61.0 60.0 58.0 61.0 60.0 62.0 74.0 58.0 58.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 06:06:10 INFO - PROCESS | 17930 | Values: 61.0 63.0 63.0 61.0 62.0 62.0 61.0 62.0 61.0 62.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:3.89 (4.9%) stddev-sans-first:4.10 06:06:10 INFO - PROCESS | 17930 | Values: 80.0 85.0 77.0 78.0 87.0 80.0 79.0 79.0 80.0 88.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:134.50 stddev:11.82 (8.8%) stddev-sans-first:12.38 06:06:10 INFO - PROCESS | 17930 | Values: 132.0 134.0 128.0 129.0 135.0 128.0 130.0 144.0 164.0 150.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:171.50 stddev:3.50 (2.0%) stddev-sans-first:3.70 06:06:10 INFO - PROCESS | 17930 | Values: 171.0 165.0 175.0 173.0 169.0 169.0 172.0 166.0 175.0 168.0 06:06:10 INFO - PROCESS | 17930 | 06:06:10 INFO - PROCESS | 17930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:2.51 (3.5%) stddev-sans-first:2.65 06:06:10 INFO - PROCESS | 17930 | Values: 71.0 69.0 71.0 73.0 71.0 68.0 67.0 68.0 75.0 72.0 06:06:10 INFO - PROCESS | 17930 | -------- Summary: end -------- 06:06:10 INFO - PROCESS | 17930 | 06:06:11 INFO - TEST-INFO | 17930: exit 0 06:06:11 INFO - TEST-OK | kraken | took 61952ms 06:06:11 INFO - SUITE-END | took 1171s 06:06:11 INFO - Completed test suite (00:19:32) 06:06:11 INFO - javascript benchmark 06:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.3185965017524, 3212.261179928618, 3225.9032229033123, 3260.6902344277287, 3261.7553683473743, 5407.134858422648, 5432.239486471892, 5480.177973304007, 5486.149646804742, 5519.254900588419, 5351.063563876325, 5448.37343705474, 5487.067198576242, 5521.806736764214, 5558.0, 4958.355413796201, 4994.575461085812, 5051.318072060261, 5065.265536497206, 5116.1814109742445, 781.9823833523606, 4897.436794768611, 4956.256561515784, 4976.502349765013, 5081.034603425356, 4931.309616653672, 4942.258661200831, 4959.727215003173, 4990.950090499103, 4994.200927851544, 4980.0, 4989.326440930464, 4999.975000124976, 5004.074246264417, 5042.218456139304, 4890.510948905081, 4919.754012299407, 4941.184704523749, 4942.579880710108, 4954.653174277802, 5272.499112584298, 5305.495977882095, 5315.707636080014, 5347.946520534783, 5352.545033672103, 5587.106063029895, 5768.221290125864, 5770.538356931477, 5783.566232532577, 5828.854278643025, 5770.971145144289, 5829.504492118175, 5835.9708201458725, 5838.591298609099, 5881.617694849864, 5424.240606315158, 5425.131978883399, 5427.6472029317965, 5429.321334833146, 5455.918161227585, 5837.620554663933, 5875.853103672443, 5878.2358293421585, 5885.588008839341, 5955.136505206808, 5741.799037033684, 5745.396733343023, 5755.9424405756245, 5756.5682573807135, 5766.538676905921, 5832.88334233313, 5843.941560584425, 5844.6785426801935, 5851.473367396955, 5854.5901786875365, 5770.596058275964, 5779.133130030529, 5806.0, 5818.243628328375, 5850.180974663551, 5685.0, 5695.145728140812, 5724.141378793214, 5741.937741517832, 5751.654900705971, 4253.532111467736, 4326.82692692295, 4339.0, 4343.500497442835, 4376.693631445768, 3783.1487915218854, 3872.0900588361715, 3908.882733517999, 3920.4707364505425, 3925.7448265862627, 5448.673079615236, 5477.04151773446, 5546.168074788733, 5567.220589117527, 5607.158926161027, 5605.990921634064, 5855.765769369177, 5868.3251426086545, 5875.177475153482, 5878.0, 5428.511433970962, 5529.834104976857, 5551.833444996657, 5562.582806289544, 5566.165075238666, 4881.096997055556, 4915.729634870045, 4923.818283611908, 4994.150994330972, 5001.274815151855, 5855.473007429352, 6041.2750469943885, 6051.667158306247, 6056.06131049688, 6080.331163572004, 5840.532757379485, 5892.764289428461, 5895.94104058954, 5904.9704751475965, 5915.08316210988, 6044.607100538451, 6061.666608336407, 6061.969690151697, 6070.848228794315, 6093.9390606093375, 5579.69311687861, 5707.514861236841, 5763.452472015152, 5770.826875193751, 5802.796902108406, 5766.654000759968, 5780.653160810365, 5796.681182535001, 5805.129230615273, 5853.560982926212, 5600.691961942132, 5610.691411972381, 5614.466625670555, 5616.719164041863, 5617.129344951539, 5548.833534993957, 5623.297087864017, 5684.459976302244, 5718.056520674042, 5742.28221472316, 5611.298587676541, 5616.8876622466505, 5621.437856214346, 5624.353199382123, 5629.634073785191, 5667.574931880043, 5686.886262274814, 5728.112142617901, 5763.193152958505, 5783.797567085132, 5442.782288708408, 5551.0, 5555.388907220122, 5556.472135147154, 5616.831495055155], "value": 5326.224947199398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9134475501053, 638.1066506890353, 641.4099028893418, 651.0, 676.4182802789597, 35510.644893551056, 36864.44703329452, 36884.446733299024, 36902.0, 36970.26059478815, 38147.61852381475, 38589.80705096477, 38593.42109868354, 38650.8067459663, 38769.61230387695, 8366.958165209166, 8539.829203415928, 8548.914510854906, 8551.871721924175, 8556.058833528306, 8410.411271211018, 8592.355573331994, 8611.698590549331, 8675.783105422383, 8700.608472618716, 8659.263962563158, 8665.480071195718, 8709.477431354107, 8726.345524085687, 8756.737297881074, 8649.178328058855, 8665.43674661145, 8690.391672582922, 8694.478331300143, 8732.607032683482, 8585.570721463902, 8609.827803443959, 8622.741317760478, 8665.35009874262, 8679.43583667066, 29884.701152988408, 36787.264254715024, 37497.43753843695, 37585.0, 37598.43602345967, 3250.8087146794733, 3401.642827503101, 3633.9273214535824, 4002.939955900664, 4249.2563801334645, 29711.554326685116, 29993.70006299931, 30116.763515488372, 30283.07440556373, 31068.223294417596, 4278.465191851019, 4321.24378233811, 4322.265214913472, 4364.956350436487, 4390.824367025315, 296879.0, 299610.0, 303649.0, 303831.9999999978, 304907.0, 61275.38724612697, 61384.693076534335, 61733.0, 61893.69053154706, 62010.0, 65817.34182658208, 66349.0, 68698.0, 69070.30929690639, 69100.65449672719, 16185.59536011609, 16378.099204543865, 16392.426265080903, 16406.671866562603, 16408.83591164097, 12130.029597632345, 12169.878301216875, 12196.14626976121, 12208.755824883452, 12215.877841221652, 20221.49446263855, 20366.898165509374, 20385.592288154156, 20446.488837779176, 20483.59032819365, 7639.694412223449, 7696.692132314756, 7706.0, 7841.451098423056, 8024.959875200587, 1025.0518270599666, 1055.7413433708791, 1121.545773961547, 1130.547780887635, 1130.728625129963, 31460.37079258448, 31495.842520787708, 31667.524987125213, 32331.0, 32639.184020399203, 1092.3664274720643, 1106.7233191702076, 1115.1914861725184, 1137.8122609769462, 1195.3903509210365, 14350.856491435161, 14691.118532887847, 14699.412023519153, 14738.0, 14788.412482091047, 411362.0, 412083.0, 414844.0, 416992.0, 426235.0, 51840.22239666408, 52415.0, 52540.0, 52690.20964685533, 52932.47067529352, 1418.5318844781198, 1420.8010878476814, 1427.336288625794, 1439.417036100381, 1454.185656032625, 28854.711452885203, 29399.706002939696, 29579.704202957695, 29915.75631827665, 30352.241193970327, 45680.54319456763, 46467.76766116148, 46684.0, 46710.53289467062, 46722.76638616921, 399657.0, 400414.0, 402720.0, 403539.0, 404709.0, 27777.916656250458, 28103.859480702467, 28269.29326766765, 28427.28931776722, 28428.85785571059, 44439.55560444354, 44465.0, 44590.77704611456, 45343.0, 45543.0, 38886.61113388943, 38904.2219155621, 39109.804450977565, 39692.2061558773, 39761.2047759049, 37198.44202337021, 37702.62297376991, 38416.61583384242, 38514.80742596269, 39194.0, 32403.837980809945, 33017.17457063593, 33342.833285834386, 39734.80132599318, 40598.18803623852, 30335.544966825957, 31288.21779455532, 31381.686183137877, 31576.36847263088, 33517.0, 25710.228693139237, 25839.741602583734, 26233.213003609922, 26251.0, 26385.472290554466], "value": 19236.212706069, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.6728147433944, 387.17918013810714, 395.5372214509024, 395.7770489188407, 403.1232070247212, 14008.789868151986, 14278.571642850706, 17506.38727644531, 18098.63802723945, 18125.456236312915, 17834.910825445888, 17869.82130178698, 18084.0, 18084.186211620476, 18724.719129213037, 4776.97611511942, 4997.125503036972, 5177.197534382177, 5224.138017227153, 5224.346956630421, 5562.443755624426, 5576.776928922838, 5584.301962254718, 5617.41017193195, 5622.606417550773, 5071.290019397269, 5337.2794672719265, 5580.0, 5587.664740115606, 5589.804356847511, 5147.0992576298995, 5150.845474635767, 5156.123459011977, 5167.586593072564, 5182.896342073156, 4815.518448155191, 4999.650024498286, 5004.349434573519, 5010.023045506127, 5013.6490445668815, 13029.739405211843, 13368.532101376502, 13472.663183420493, 13514.391852366569, 13612.31938403076, 2285.8285628577923, 2363.1610778173845, 2375.5011447596025, 2391.5695174868515, 2416.7583241675693, 9665.661701840472, 11355.432228388547, 13541.796873046913, 14057.367418466194, 14181.716365672628, 1884.6513395021964, 1890.7258447525169, 1916.3963351544219, 1922.0459464289222, 1950.9609807803906, 61705.0, 72675.0, 79760.0, 79902.60048699778, 82157.0, 10198.133158681447, 10539.789204215873, 10556.841647375142, 10571.36571805694, 10785.245032847626, 14591.78112328316, 14873.92563037178, 14904.478343257933, 14921.328540215716, 14932.0, 7829.256220659028, 7969.322607578305, 8011.679532818738, 8026.317762990095, 8040.7938809179095, 7532.849343013109, 7627.733029343946, 7726.227377262228, 7765.805854853674, 7949.403794715419, 4446.888827779267, 4577.382053422745, 4592.254125346704, 4595.701279416827, 4658.697184682985, 1862.5622978600288, 1927.4699457649258, 1946.4452631000381, 1971.3001884331143, 1972.3688419705843, 880.3969281042506, 994.4928086675848, 1000.9149222316039, 1057.8519007338978, 1060.5492665617082, 17043.062631555134, 18469.53826154357, 18542.0, 18662.626747464976, 18969.43091707251, 994.7562847102362, 1008.6570566007592, 1011.6358111080006, 1019.6176433837311, 1058.1270451877078, 10302.433366164783, 10596.31123976939, 10640.521176547074, 10692.411917344465, 10760.46197690128, 448475.0, 451147.0, 468818.0, 469735.0, 472838.0, 89429.0, 89992.0, 90509.0, 90837.54581227052, 91311.54344228236, 949.6296444386695, 955.6082006377352, 966.6036924860773, 970.1220395542045, 984.1732944326657, 16301.51095467138, 16374.83625163733, 16495.17524123813, 16560.343965603344, 16592.75110873362, 36861.07847303731, 38033.619663804115, 38286.80856595699, 38416.42375364316, 38609.80695096507, 51044.0, 54694.0, 55158.448415516934, 55241.44758552363, 55329.0, 5039.748012599282, 5329.866753331198, 7794.766157015299, 7872.01599800025, 8450.704225352083, 11672.241304315192, 12786.74426511446, 13054.54309099177, 13171.47314107425, 13314.667133321744, 5441.83674489766, 7861.489003214772, 10488.947555262175, 11074.39090850011, 11751.413559169403, 11051.557937682403, 11173.106151508022, 11352.716182095513, 11362.829557556477, 11461.48423320936, 11203.71990700239, 11324.37715925632, 11642.825357619473, 11685.240459370114, 11864.762704745684, 8457.915420845713, 8475.32197424217, 8620.224179823846, 8630.482171069756, 8631.870521942301, 8503.362247831561, 10965.780684386427, 11584.768304634028, 11632.76734465289, 11707.531698731955], "value": 8681.283411783616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.4238047161605, 1508.9320980555874, 1598.9920050399753, 1680.2690829489165, 1692.8137904830473, 7175.067241258629, 8060.476069055508, 8092.514449133041, 8239.546824924626, 8301.87547186792, 8086.71696490623, 8093.514389136656, 8105.594720263978, 8110.716124935629, 8166.0, 2198.8131008864266, 2234.0728597632046, 2238.55228954209, 2238.753737088919, 2241.1707668162803, 2201.680756290337, 2204.933851984443, 2217.2018073493527, 2225.7662945390744, 2278.646809744484, 2224.2548746169973, 2225.7996780289773, 2249.5388445368744, 2260.480089579398, 2290.816734661223, 2197.6703494475796, 2225.5660146271484, 2232.0290673557056, 2234.3967128875192, 2246.1015593762545, 2238.2837492002564, 2248.5615305015526, 2250.2349201271645, 2257.3340864445026, 2262.6040442922585, 8211.425200235986, 8251.0, 8309.293710034653, 8326.45878017927, 8330.208630180123, 4976.0, 5152.227165925104, 5159.948400515985, 5171.922421163686, 5195.6622819516615, 3215.3569286142865, 3312.9171770705684, 3442.3287458945515, 3460.2214501737158, 3511.8595256189724, 1098.6649072033026, 1104.4312179227704, 1112.2103306652286, 1119.731264496515, 1144.730988217768, 11549.595764148215, 11555.711107222303, 11558.422078896107, 11561.190716649839, 11572.59495917639, 4165.354370072643, 4254.680898932593, 4384.298512238027, 4397.208502469586, 4475.328700694922, 9783.853242201372, 9819.116279534876, 9846.606135754633, 9850.901490985141, 9855.063768941938, 4949.925751113737, 4970.552650261494, 4998.4251811042195, 5005.974970125126, 5055.797768089235, 4052.169305292408, 4494.5730155635165, 4619.792109355087, 4644.814207431665, 4645.210314246586, 3775.7923314217433, 3833.6933045356304, 3881.1073453105378, 3912.7065470089287, 3922.490076290064, 1255.1026016398318, 1258.6853286678331, 1258.9748205035849, 1260.9054320925784, 1279.9104062715521, 842.0358689300716, 887.5784002598714, 909.3861643390685, 911.1389736698756, 915.9954200228956, 5504.80733174337, 5538.16037194065, 5553.444655534495, 5591.217229587861, 5640.633358831745, 921.3320342751585, 958.4393130018877, 964.8504481805331, 973.5035132082688, 1019.0675531888239, 3806.333891568964, 3956.4263181838473, 3968.7023473239624, 3972.682185425159, 3996.7801770902297, 10087.0, 10371.377717336984, 10507.789844203226, 10513.474326283655, 10524.158067354594, 10230.28388012832, 10242.59029638821, 10378.0, 10386.11718003963, 10397.11624511925, 7288.6720097595735, 7678.884816727754, 7713.614319284014, 7787.766367008885, 7814.726484573012, 5436.7553460093595, 5437.0, 5437.5378092860965, 5569.582281328835, 5620.718964051699, 9096.727098187064, 9159.0, 9233.445993240428, 9272.675456358995, 9324.11420915012, 9396.107369799858, 9411.152996230097, 9509.476978766234, 9524.428534287965, 9529.809403812023, 6752.797416077526, 7245.710171593078, 7275.6362181889635, 7457.142428620561, 7460.440466965108, 8003.959485266878, 8007.239312265326, 8046.637901294573, 8053.194680532134, 8073.596320184085, 7041.43668506508, 7281.781546553612, 7291.927080729125, 7367.594782287026, 7375.557466552024, 7037.7184912602925, 7211.891821622575, 7215.422766178588, 7219.0976127984, 7291.307325804252, 6647.235567909753, 6693.297203793726, 6705.865882682417, 6735.898961515679, 6740.966295168493, 4634.791434385528, 4831.613470922388, 4842.37049183618, 4849.3210950466255, 4856.490068542894, 4869.293952376956, 4885.65800393969, 4897.853064408074, 4898.093852637274, 4948.233023881304], "value": 4425.900242597649, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.8607398818508, 326.45319090523367, 334.2829630442701, 335.8774047472672, 340.28879641549156, 5872.4127587241255, 6005.399460053998, 6029.6382217067, 6139.01775715885, 6178.165947597078, 6024.909626355608, 6054.485368743651, 6074.088886667002, 6091.2690477142805, 6097.0, 4668.346431499593, 4681.64887633428, 4681.9297710534365, 4685.273782563691, 4689.976550117244, 4367.0, 4590.793414296365, 4607.1476776796235, 4614.584687378136, 4692.319613656018, 4554.954450455486, 4564.771761411933, 4587.72473651582, 4589.79345929434, 4599.356090147382, 4590.05903789724, 4607.3549703041435, 4608.539146085364, 4612.607928326096, 4626.074785043005, 3896.649301562845, 3942.763434193929, 3959.109200429909, 3968.523777146732, 3975.9602403975878, 5793.0, 5802.419758024206, 5819.923314186889, 5822.767089316422, 5840.072775983957, 5194.857131431117, 5231.738413079369, 5232.895342093137, 5249.816256431045, 5273.630845840793, 6221.097940798604, 6270.78052268173, 6285.340039295854, 6321.462675672527, 6323.93676063238, 4238.152369526107, 4242.278812601865, 4251.149770046003, 4251.341042138473, 4260.55264197261, 6470.0, 6558.573692709959, 6568.408843204134, 6618.966905165492, 6629.867402651968, 4423.20382331177, 4449.822007119744, 4456.665750068758, 4464.821407143743, 4477.552244775497, 4514.187446259705, 4531.68278220528, 4532.501424843264, 4541.661044562054, 4551.2717965126085, 5005.224190250444, 5272.657277276965, 5275.287836142072, 5284.916592098611, 5289.18017707256, 6270.7491700331475, 6430.549861509649, 6433.581817181868, 6433.742650293936, 6438.8390290243115, 1541.175471122944, 1548.6902619475925, 1557.353698215228, 1559.594505428574, 1560.508439841469, 1019.3017782818793, 1020.6070662794729, 1032.808930347888, 1045.994770026145, 1051.9434505541649, 6177.96911015451, 6201.10084037812, 6217.844553886189, 6223.626582405071, 6244.313125556185, 6519.250286217051, 6565.179352580927, 6567.310432404529, 6585.769498067544, 6594.8351291218105, 5917.940820591739, 6098.878022439526, 6196.442320191204, 6202.906956395657, 6205.813825585149, 3532.823358832048, 3536.964630353715, 3561.519194908706, 3568.411212150018, 3569.660882216185, 6686.5653732507235, 6806.625635589991, 6817.5568588041615, 6825.69284382204, 6904.654767261617, 6652.234992975773, 6680.565763225472, 6685.398314151653, 6692.765753198712, 6699.129113215251, 6543.378379053982, 6824.283450237753, 6828.487863410264, 6832.350926661959, 6885.311468853175, 6525.247982410228, 6558.344165583403, 6595.307492713196, 6597.736090556324, 6610.8347291318105, 6289.465395441439, 6496.317886621837, 6520.804375868732, 6534.738610455529, 6558.672066396565, 6731.764388246388, 6751.966240168767, 6763.661816909036, 6779.491538134758, 6808.659567021728, 4392.209402307615, 4402.625776809007, 4404.273294906305, 4405.920549465402, 4408.096340250305, 6319.0, 6482.476617994673, 6599.7360105595235, 6689.966550167218, 6712.362325579063, 6444.903326450013, 6462.933615953315, 6465.224173099258, 6484.319146489551, 6486.870262594816, 6258.342873998165, 6425.518086143465, 6446.129772480655, 6447.4197322241225, 6467.838304042437, 6276.686165691606, 6344.365563443619, 6372.299047104908, 6378.968105159444, 6379.234491861006, 6434.227892652912, 6446.129772480655, 6479.1901012373455, 6485.935140648722, 6492.0, 6145.9692701536205, 6304.7162877671535, 6314.137329487904, 6333.240011198685, 6373.553851230555], "value": 4789.5153577288365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.9779206623801, 839.1734141870259, 847.4915050969419, 850.438710451102, 869.7086476030529, 13159.934200328997, 13872.583822485316, 14689.559313220594, 14741.48404805832, 14747.48383806567, 14935.0, 14997.700045999074, 15008.774868376982, 15054.623634409145, 15059.924700376483, 641.8652083062562, 780.1340512031641, 799.5083023940279, 800.2917418084978, 800.8518424091533, 802.0495712580581, 807.3823525003348, 807.90709068457, 808.308895894011, 809.2150613904532, 850.1838235294125, 851.259404318244, 853.0616322045762, 854.3763052971335, 856.0070318430621, 842.2924743215698, 844.3329769482102, 848.1264297773241, 849.3969281809923, 855.7646647172046, 609.0590038390696, 610.0239616613427, 610.7099127914249, 611.3153268339444, 614.4316507230793, 13566.389512471962, 13602.93198534001, 13671.658208544766, 13678.863211367958, 13700.725985480334, 12130.45412956419, 12357.814632780515, 12794.040446966515, 13543.59369218925, 13608.183508989394, 11139.777204455866, 11177.66467005991, 11230.94384528072, 11400.372979486125, 11441.313521188755, 3748.8687895923513, 3914.2367238388524, 3922.92119667091, 3955.4857868476915, 4012.7592344459426, 49433.25850112251, 53157.0, 53298.0, 53645.73177134089, 54112.99999999961, 11305.70383254358, 11489.770204595861, 11562.479688414041, 11885.76228475443, 11894.82157767634, 20403.0, 20538.38384848457, 20558.588828223652, 20605.79394206069, 20706.68939965902, 8013.679452821939, 8109.067457242375, 8138.104808471064, 8310.293625041939, 8312.127226641236, 4502.617277531446, 4568.285575039023, 4602.332661764025, 4702.835400760957, 4747.311639812277, 3248.8700451982127, 3300.075978725961, 3304.7190988766224, 3305.190228394011, 3308.6360500344945, 567.6764244380663, 587.7355190164358, 588.3733823477983, 590.9349971503132, 595.5235811350902, 618.3785295777715, 718.608358444649, 723.2839488905945, 738.8263758016861, 762.9852296445714, 8562.74311770648, 9054.909450905407, 9227.95386023079, 9248.491332976617, 9465.195458386115, 571.4456976732563, 604.8125081224835, 698.6122701900392, 719.6401799100449, 732.0812380462486, 4358.5205627380965, 4363.650907927422, 4425.0, 4436.645068394585, 4482.21561226784, 60185.699071504365, 62137.68931155315, 62212.68893655503, 62635.06047409293, 63177.68411157915, 53403.19895201575, 54051.45948540543, 54715.45284547104, 54761.1785823213, 55104.448955510736, 44657.0, 47620.5237947623, 48350.5164948346, 48605.5139448601, 49692.254616180784, 8705.608247629, 8771.473711577326, 8772.29779668803, 8797.0, 8923.73228803137, 31756.523652145697, 32671.509927350635, 32717.672823272416, 33078.17304567405, 33116.503252451716, 37337.0, 40647.0, 44067.33898991453, 44076.55923440724, 45087.54912450833, 11486.597969071378, 11534.077273817906, 11717.76564468723, 11854.288742675468, 11953.641390758292, 12760.074859638178, 12982.675433113869, 13083.149595276276, 13495.932520337336, 13792.103513271606, 12750.48998040068, 12813.295268760308, 12898.097133200587, 12898.290594017044, 13219.933900330438, 12732.809007864704, 12745.617631470699, 12791.872081279069, 12958.546450874173, 13511.932440337736, 12262.754744904874, 12454.564090256797, 12479.0, 12543.937280313905, 12580.245185288912, 10596.470176491299, 10709.678709638723, 10872.565097396016, 11059.281146725438, 11214.495347709535, 10692.679219623424, 10785.298955567863, 11019.504122314675, 11070.335779853234, 11098.0], "value": 6682.704006207727, "unit": "score"}], "name": "dromaeo_css", "value": 7080.567301873148, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 109.0, 112.0, 123.0, 111.0, 117.0, 112.0, 110.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 160.0, 185.0, 129.0, 159.0, 160.0, 136.0, 183.0, 135.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 166.0, 167.0, 163.0, 165.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 75.0, 161.0, 75.0, 78.0, 77.0, 76.0, 171.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 153.0, 93.0, 93.0, 93.0, 151.0, 93.0, 93.0, 139.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 58.0, 61.0, 60.0, 62.0, 74.0, 58.0, 58.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 77.0, 78.0, 87.0, 80.0, 79.0, 79.0, 80.0, 88.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 128.0, 129.0, 135.0, 128.0, 130.0, 144.0, 164.0, 150.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 175.0, 173.0, 169.0, 169.0, 172.0, 166.0, 175.0, 168.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 73.0, 71.0, 68.0, 67.0, 68.0, 75.0, 72.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1574.8999999999999, "alertThreshold": 2.0}]} 06:06:11 INFO - Return code: 0 06:06:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:11 ERROR - # TBPL SUCCESS # 06:06:11 INFO - Running post-action listener: _resource_record_post_action 06:06:11 INFO - Running post-run listener: _resource_record_post_run 06:06:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536178688; Read time: 16; Write time: 424200 06:06:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244572160; Read time: 0; Write time: 244652 06:06:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291606528; Read time: 16; Write time: 179548 06:06:12 INFO - Running post-run listener: _upload_blobber_files 06:06:12 INFO - Blob upload gear active. 06:06:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:13 INFO - (blobuploader) - INFO - Done attempting. 06:06:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:14 INFO - (blobuploader) - INFO - Done attempting. 06:06:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:14 INFO - Return code: 0 06:06:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180b6be434ecd2788b6b8fe9d5c9e0c5a7b7e86acc41c288f0262831f7d1600b422007eb4bf1a9703b1b50af38fda692ccb1725721e6cbca8b18e312670f9f37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904ed77c0d0661d80ef21cbf256d99de1b1eac35139efa0c9b398085dc9ce5a66ffba750998d1ec4676d120199aa043b34b9f0289cd718304b8e7e699d3e1dd"} 06:06:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:14 INFO - Contents: 06:06:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180b6be434ecd2788b6b8fe9d5c9e0c5a7b7e86acc41c288f0262831f7d1600b422007eb4bf1a9703b1b50af38fda692ccb1725721e6cbca8b18e312670f9f37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904ed77c0d0661d80ef21cbf256d99de1b1eac35139efa0c9b398085dc9ce5a66ffba750998d1ec4676d120199aa043b34b9f0289cd718304b8e7e699d3e1dd"} 06:06:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:14 INFO - Copying logs to upload dir... 06:06:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.775121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-24 06:06:14.368336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:14.371400) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180b6be434ecd2788b6b8fe9d5c9e0c5a7b7e86acc41c288f0262831f7d1600b422007eb4bf1a9703b1b50af38fda692ccb1725721e6cbca8b18e312670f9f37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904ed77c0d0661d80ef21cbf256d99de1b1eac35139efa0c9b398085dc9ce5a66ffba750998d1ec4676d120199aa043b34b9f0289cd718304b8e7e699d3e1dd"} build_url:https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/180b6be434ecd2788b6b8fe9d5c9e0c5a7b7e86acc41c288f0262831f7d1600b422007eb4bf1a9703b1b50af38fda692ccb1725721e6cbca8b18e312670f9f37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904ed77c0d0661d80ef21cbf256d99de1b1eac35139efa0c9b398085dc9ce5a66ffba750998d1ec4676d120199aa043b34b9f0289cd718304b8e7e699d3e1dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:14.395353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:14.395661) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461489470.697660-899516282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:14.477819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 06:06:14.478162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 06:06:14.478475) ========= ========= Total master_lag: 0.18 =========