builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1461841893.23 results: success (0) buildid: 20160428013048 builduid: 7cf21be618634bf9996c355f70541c83 revision: 36c2c8a36ad9d6521b54e3867b12fd37be488d05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.230117) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.230942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.231261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.291653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.291922) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 04:11: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% 88.7M=0s 2016-04-28 04:11:33 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072680 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.378151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.378469) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:33.427585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 04:11:33.427929) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 36c2c8a36ad9d6521b54e3867b12fd37be488d05 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 36c2c8a36ad9d6521b54e3867b12fd37be488d05 --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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 04:11:33,834 truncating revision to first 12 chars 2016-04-28 04:11:33,835 Setting DEBUG logging. 2016-04-28 04:11:33,835 attempt 1/10 2016-04-28 04:11:33,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/36c2c8a36ad9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 04:11:35,004 unpacking tar archive at: mozilla-inbound-36c2c8a36ad9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 04:11:34.892463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:34.892789) ========= script_repo_revision: 36c2c8a36ad9d6521b54e3867b12fd37be488d05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:34.893198) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:34.893480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:11:34.904413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-28 04:11:34.904777) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:11:35 INFO - MultiFileLogger online at 20160428 04:11:35 in /builds/slave/test 04:11:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:11:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:35 INFO - {'append_to_log': False, 04:11:35 INFO - 'base_work_dir': '/builds/slave/test', 04:11:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:11:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:35 INFO - 'branch': 'Mozilla-Inbound', 04:11:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:35 INFO - 'config_files': ('talos/linux_config.py',), 04:11:35 INFO - 'default_actions': ('clobber', 04:11:35 INFO - 'read-buildbot-config', 04:11:35 INFO - 'download-and-extract', 04:11:35 INFO - 'populate-webroot', 04:11:35 INFO - 'create-virtualenv', 04:11:35 INFO - 'install', 04:11:35 INFO - 'run-tests'), 04:11:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:35 INFO - 'download_minidump_stackwalk': True, 04:11:35 INFO - 'download_symbols': 'ondemand', 04:11:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:35 INFO - 'installer_path': 'installer.exe', 04:11:35 INFO - 'log_level': 'info', 04:11:35 INFO - 'log_name': 'talos', 04:11:35 INFO - 'log_to_console': True, 04:11:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:11:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:11:35 INFO - 'opt_config_files': (), 04:11:35 INFO - 'pip_index': False, 04:11:35 INFO - 'sps_profile': False, 04:11:35 INFO - 'sps_profile_interval': 0, 04:11:35 INFO - 'suite': 'dromaeojs-e10s', 04:11:35 INFO - 'system_bits': '32', 04:11:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:35 INFO - 'title': 'talos-linux64-ix-034', 04:11:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:35 INFO - 'use_talos_json': True, 04:11:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:35 INFO - 'work_dir': 'build'} 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running clobber step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: clobber 04:11:35 INFO - rmtree: /builds/slave/test/build 04:11:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:35 INFO - Running post-action listener: _resource_record_post_action 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running read-buildbot-config step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: read_buildbot_config 04:11:35 INFO - Using buildbot properties: 04:11:35 INFO - { 04:11:35 INFO - "project": "", 04:11:35 INFO - "product": "firefox", 04:11:35 INFO - "script_repo_revision": "production", 04:11:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:11:35 INFO - "repository": "", 04:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:11:35 INFO - "buildid": "20160428013048", 04:11:35 INFO - "pgo_build": "True", 04:11:35 INFO - "basedir": "/builds/slave/test", 04:11:35 INFO - "buildnumber": 585, 04:11:35 INFO - "slavename": "talos-linux64-ix-034", 04:11:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:11:35 INFO - "platform": "ubuntu64_hw", 04:11:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:11:35 INFO - "branch": "mozilla-inbound", 04:11:35 INFO - "repo_path": "integration/mozilla-inbound", 04:11:35 INFO - "revision": "36c2c8a36ad9d6521b54e3867b12fd37be488d05", 04:11:35 INFO - "stage_platform": "linux64-pgo", 04:11:35 INFO - "builduid": "7cf21be618634bf9996c355f70541c83", 04:11:35 INFO - "slavebuilddir": "test" 04:11:35 INFO - } 04:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:11:35 INFO - Running post-action listener: _resource_record_post_action 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running download-and-extract step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: download_and_extract 04:11:35 INFO - mkdir: /builds/slave/test/build/tests 04:11:35 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')]} 04:11:35 INFO - https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:11:45 INFO - Downloaded 1361 bytes. 04:11:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:45 INFO - Using the following test package requirements: 04:11:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:11:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:11:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'jsshell-linux-x86_64.zip'], 04:11:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:11:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:11:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:11:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:11:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:11:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:11:45 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')]} 04:11:45 INFO - https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:11:52 INFO - Downloaded 23872938 bytes. 04:11:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:53 INFO - Return code: 0 04:11:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:11: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')]} 04:11:53 INFO - https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:11:55 INFO - Downloaded 23872938 bytes. 04:11:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:56 INFO - Return code: 0 04:11:56 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')]} 04:11:56 INFO - https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:11:58 INFO - Downloaded 10840145 bytes. 04:11:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:11:58 INFO - Return code: 0 04:11:58 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')]} 04:11:58 INFO - https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:00 INFO - Downloaded 58410775 bytes. 04:12:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:00 INFO - mkdir: /builds/slave/test/properties 04:12:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:00 INFO - Contents: 04:12:00 INFO - build_url:https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:12:00 INFO - Running post-action listener: _resource_record_post_action 04:12:00 INFO - Running post-action listener: set_extra_try_arguments 04:12:00 INFO - ##### 04:12:00 INFO - ##### Running populate-webroot step. 04:12:00 INFO - ##### 04:12:00 INFO - Running pre-action listener: _resource_record_pre_action 04:12:00 INFO - Running main action method: populate_webroot 04:12:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:00 INFO - '--tppagecycles', 04:12:00 INFO - '7'], 04:12:00 INFO - 'tests': ['tsvgm']}}, 04:12:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['damp', 'tps']}, 04:12:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'tests': ['damp', 'tps']}, 04:12:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['dromaeo_dom']}, 04:12:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['a11yr', 04:12:00 INFO - 'ts_paint', 04:12:00 INFO - 'tpaint', 04:12:00 INFO - 'sessionrestore', 04:12:00 INFO - 'sessionrestore_no_auto_restore', 04:12:00 INFO - 'tabpaint']}, 04:12:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['tsvgx', 04:12:00 INFO - 'tsvgr_opacity', 04:12:00 INFO - 'tart', 04:12:00 INFO - 'tscrollx', 04:12:00 INFO - 'cart']}, 04:12:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:00 INFO - 'tsvgr_opacity', 04:12:00 INFO - 'tart', 04:12:00 INFO - 'tscrollx', 04:12:00 INFO - 'cart']}, 04:12:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'talos_options': ['--disable-e10s'], 04:12:00 INFO - 'tests': ['tp5o']}, 04:12:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'tests': ['tp5o']}, 04:12:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'talos_options': ['--disable-e10s', 04:12:00 INFO - '--xperf_path', 04:12:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:00 INFO - 'tests': ['tp5n']}, 04:12:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:00 INFO - 'talos_options': ['--xperf_path', 04:12:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:00 INFO - 'tests': ['tp5n']}}, 04:12:00 INFO - 'talos.zip': {'path': '', 04:12:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:00 INFO - Running post-action listener: _resource_record_post_action 04:12:00 INFO - ##### 04:12:00 INFO - ##### Running create-virtualenv step. 04:12:00 INFO - ##### 04:12:00 INFO - Running pre-action listener: _resource_record_pre_action 04:12:00 INFO - Running main action method: create_virtualenv 04:12:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:00 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 04:12:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:00 INFO - Using real prefix '/usr' 04:12:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:03 INFO - Installing pip.................done. 04:12:03 INFO - Return code: 0 04:12:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:03 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')]} 04:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:03 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')]} 04:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:03 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:03 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 04:12:03 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 04:12:03 INFO - Using env: {'DISPLAY': ':0', 04:12:03 INFO - 'HOME': '/home/cltbld', 04:12:03 INFO - 'LANG': 'en_US.UTF-8', 04:12:03 INFO - 'LANGUAGE': 'en_US:en', 04:12:03 INFO - 'LOGNAME': 'cltbld', 04:12:03 INFO - 'MAIL': '/var/mail/cltbld', 04:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:03 INFO - 'MOZ_NO_REMOTE': '1', 04:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:03 INFO - 'NO_EM_RESTART': '1', 04:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:03 INFO - 'PWD': '/builds/slave/test', 04:12:03 INFO - 'SHELL': '/bin/bash', 04:12:03 INFO - 'SHLVL': '1', 04:12:03 INFO - 'TERM': 'linux', 04:12:03 INFO - 'TMOUT': '86400', 04:12:03 INFO - 'USER': 'cltbld', 04:12:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:03 INFO - '_': '/tools/buildbot/bin/python'} 04:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:03 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 04:12:03 INFO - Cleaning up... 04:12:03 INFO - Return code: 0 04:12:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:12:03 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')]} 04:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:03 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')]} 04:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:03 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:03 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 04:12:03 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 04:12:03 INFO - Using env: {'DISPLAY': ':0', 04:12:03 INFO - 'HOME': '/home/cltbld', 04:12:03 INFO - 'LANG': 'en_US.UTF-8', 04:12:03 INFO - 'LANGUAGE': 'en_US:en', 04:12:03 INFO - 'LOGNAME': 'cltbld', 04:12:03 INFO - 'MAIL': '/var/mail/cltbld', 04:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:03 INFO - 'MOZ_NO_REMOTE': '1', 04:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:03 INFO - 'NO_EM_RESTART': '1', 04:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:03 INFO - 'PWD': '/builds/slave/test', 04:12:03 INFO - 'SHELL': '/bin/bash', 04:12:03 INFO - 'SHLVL': '1', 04:12:03 INFO - 'TERM': 'linux', 04:12:03 INFO - 'TMOUT': '86400', 04:12:03 INFO - 'USER': 'cltbld', 04:12:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:03 INFO - '_': '/tools/buildbot/bin/python'} 04:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:03 INFO - Downloading/unpacking psutil>=0.7.1 04:12:03 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 04:12:03 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 04:12:03 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 04:12:03 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 04:12:03 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 04:12:03 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 04:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:05 INFO - Installing collected packages: psutil 04:12:05 INFO - Running setup.py install for psutil 04:12:05 INFO - building 'psutil._psutil_linux' extension 04:12:05 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 04:12:06 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 04:12:06 INFO - building 'psutil._psutil_posix' extension 04:12:06 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 04:12:06 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 04:12:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:06 INFO - Successfully installed psutil 04:12:06 INFO - Cleaning up... 04:12:06 INFO - Return code: 0 04:12:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:12:06 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')]} 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 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')]} 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:06 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 04:12:06 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 04:12:06 INFO - Using env: {'DISPLAY': ':0', 04:12:06 INFO - 'HOME': '/home/cltbld', 04:12:06 INFO - 'LANG': 'en_US.UTF-8', 04:12:06 INFO - 'LANGUAGE': 'en_US:en', 04:12:06 INFO - 'LOGNAME': 'cltbld', 04:12:06 INFO - 'MAIL': '/var/mail/cltbld', 04:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:06 INFO - 'MOZ_NO_REMOTE': '1', 04:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:06 INFO - 'NO_EM_RESTART': '1', 04:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:06 INFO - 'PWD': '/builds/slave/test', 04:12:06 INFO - 'SHELL': '/bin/bash', 04:12:06 INFO - 'SHLVL': '1', 04:12:06 INFO - 'TERM': 'linux', 04:12:06 INFO - 'TMOUT': '86400', 04:12:06 INFO - 'USER': 'cltbld', 04:12:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:06 INFO - '_': '/tools/buildbot/bin/python'} 04:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:12:08 INFO - Installing collected packages: mozsystemmonitor 04:12:08 INFO - Running setup.py install for mozsystemmonitor 04:12:08 INFO - Successfully installed mozsystemmonitor 04:12:08 INFO - Cleaning up... 04:12:08 INFO - Return code: 0 04:12:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:08 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:08 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 04:12:08 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 04:12:08 INFO - Using env: {'DISPLAY': ':0', 04:12:08 INFO - 'HOME': '/home/cltbld', 04:12:08 INFO - 'LANG': 'en_US.UTF-8', 04:12:08 INFO - 'LANGUAGE': 'en_US:en', 04:12:08 INFO - 'LOGNAME': 'cltbld', 04:12:08 INFO - 'MAIL': '/var/mail/cltbld', 04:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:08 INFO - 'MOZ_NO_REMOTE': '1', 04:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:08 INFO - 'NO_EM_RESTART': '1', 04:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:08 INFO - 'PWD': '/builds/slave/test', 04:12:08 INFO - 'SHELL': '/bin/bash', 04:12:08 INFO - 'SHLVL': '1', 04:12:08 INFO - 'TERM': 'linux', 04:12:08 INFO - 'TMOUT': '86400', 04:12:08 INFO - 'USER': 'cltbld', 04:12:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:08 INFO - '_': '/tools/buildbot/bin/python'} 04:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:08 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 04:12:08 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 04:12:08 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 04:12:08 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 04:12:08 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 04:12:08 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 04:12:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 INFO - Downloading docopt-0.6.1.tar.gz 04:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:11 INFO - Running setup.py install for blobuploader 04:12:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:11 INFO - Running setup.py install for requests 04:12:12 INFO - Running setup.py install for docopt 04:12:12 INFO - Successfully installed blobuploader requests docopt 04:12:12 INFO - Cleaning up... 04:12:12 INFO - Return code: 0 04:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:12 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')]} 04:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:12 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')]} 04:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:12 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:12 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 04:12:12 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 04:12:12 INFO - Using env: {'DISPLAY': ':0', 04:12:12 INFO - 'HOME': '/home/cltbld', 04:12:12 INFO - 'LANG': 'en_US.UTF-8', 04:12:12 INFO - 'LANGUAGE': 'en_US:en', 04:12:12 INFO - 'LOGNAME': 'cltbld', 04:12:12 INFO - 'MAIL': '/var/mail/cltbld', 04:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:12 INFO - 'MOZ_NO_REMOTE': '1', 04:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:12 INFO - 'NO_EM_RESTART': '1', 04:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:12 INFO - 'PWD': '/builds/slave/test', 04:12:12 INFO - 'SHELL': '/bin/bash', 04:12:12 INFO - 'SHLVL': '1', 04:12:12 INFO - 'TERM': 'linux', 04:12:12 INFO - 'TMOUT': '86400', 04:12:12 INFO - 'USER': 'cltbld', 04:12:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:12 INFO - '_': '/tools/buildbot/bin/python'} 04:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:12 INFO - Running setup.py (path:/tmp/pip-08nclj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:12 INFO - Running setup.py (path:/tmp/pip-u8R_1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:12 INFO - Running setup.py (path:/tmp/pip-rSrL9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:12 INFO - Running setup.py (path:/tmp/pip-SEgj1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:12 INFO - Running setup.py (path:/tmp/pip-mnZFf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:12 INFO - Running setup.py (path:/tmp/pip-iKnRK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:13 INFO - Running setup.py (path:/tmp/pip-KVupyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:13 INFO - Running setup.py (path:/tmp/pip-A5EGh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:13 INFO - Running setup.py (path:/tmp/pip-Bva61x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:13 INFO - Running setup.py (path:/tmp/pip-aeG4UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:13 INFO - Running setup.py (path:/tmp/pip-Z2mF9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:13 INFO - Running setup.py (path:/tmp/pip-l5HMzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:13 INFO - Running setup.py (path:/tmp/pip-eaNNgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:13 INFO - Running setup.py (path:/tmp/pip-FR10qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:13 INFO - Running setup.py (path:/tmp/pip-d7woQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:13 INFO - Running setup.py (path:/tmp/pip-pLsr6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:13 INFO - Running setup.py (path:/tmp/pip-cUDofx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:13 INFO - Running setup.py install for manifestparser 04:12:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:13 INFO - Running setup.py install for mozcrash 04:12:14 INFO - Running setup.py install for mozdebug 04:12:14 INFO - Running setup.py install for mozdevice 04:12:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozfile 04:12:14 INFO - Running setup.py install for mozhttpd 04:12:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozinfo 04:12:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozInstall 04:12:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozleak 04:12:14 INFO - Running setup.py install for mozlog 04:12:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for moznetwork 04:12:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozprocess 04:12:15 INFO - Running setup.py install for mozprofile 04:12:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Running setup.py install for mozrunner 04:12:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Running setup.py install for mozscreenshot 04:12:15 INFO - Running setup.py install for moztest 04:12:15 INFO - Running setup.py install for mozversion 04:12:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:15 INFO - Cleaning up... 04:12:15 INFO - Return code: 0 04:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:15 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:15 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 04:12:15 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 04:12:15 INFO - Using env: {'DISPLAY': ':0', 04:12:15 INFO - 'HOME': '/home/cltbld', 04:12:15 INFO - 'LANG': 'en_US.UTF-8', 04:12:15 INFO - 'LANGUAGE': 'en_US:en', 04:12:15 INFO - 'LOGNAME': 'cltbld', 04:12:15 INFO - 'MAIL': '/var/mail/cltbld', 04:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:15 INFO - 'MOZ_NO_REMOTE': '1', 04:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:15 INFO - 'NO_EM_RESTART': '1', 04:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:15 INFO - 'PWD': '/builds/slave/test', 04:12:15 INFO - 'SHELL': '/bin/bash', 04:12:15 INFO - 'SHLVL': '1', 04:12:15 INFO - 'TERM': 'linux', 04:12:15 INFO - 'TMOUT': '86400', 04:12:15 INFO - 'USER': 'cltbld', 04:12:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:15 INFO - '_': '/tools/buildbot/bin/python'} 04:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:15 INFO - Running setup.py (path:/tmp/pip-dH3dNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:15 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)) 04:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:15 INFO - Running setup.py (path:/tmp/pip-S2afm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:16 INFO - Running setup.py (path:/tmp/pip-u83lfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:16 INFO - Running setup.py (path:/tmp/pip-ILfng7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:16 INFO - Running setup.py (path:/tmp/pip-KCv923-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:16 INFO - Running setup.py (path:/tmp/pip-KREVwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:16 INFO - Running setup.py (path:/tmp/pip-4b9Utj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:16 INFO - Running setup.py (path:/tmp/pip-inC4N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:16 INFO - Running setup.py (path:/tmp/pip-Ts4rBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:16 INFO - Running setup.py (path:/tmp/pip-4G5toC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:16 INFO - Running setup.py (path:/tmp/pip-GeDfw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:16 INFO - Running setup.py (path:/tmp/pip-dG3Wiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:16 INFO - Running setup.py (path:/tmp/pip-mK33Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:16 INFO - Running setup.py (path:/tmp/pip-zkDN8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:16 INFO - Running setup.py (path:/tmp/pip-K_UWsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:16 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)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:16 INFO - Running setup.py (path:/tmp/pip-H1YOfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:17 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)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:17 INFO - Running setup.py (path:/tmp/pip-tN7M4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:17 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)) 04:12:17 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)) 04:12:17 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)) 04:12:17 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)) 04:12:17 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)) 04:12:17 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)) 04:12:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:18 INFO - Downloading blessings-1.6.tar.gz 04:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:19 INFO - Installing collected packages: blessings 04:12:19 INFO - Running setup.py install for blessings 04:12:19 INFO - Successfully installed blessings 04:12:19 INFO - Cleaning up... 04:12:19 INFO - Return code: 0 04:12:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:19 INFO - Reading from file tmpfile_stdout 04:12:19 INFO - Current package versions: 04:12:19 INFO - argparse == 1.2.1 04:12:19 INFO - blessings == 1.6 04:12:19 INFO - blobuploader == 1.2.4 04:12:19 INFO - docopt == 0.6.1 04:12:19 INFO - manifestparser == 1.1 04:12:19 INFO - mozInstall == 1.12 04:12:19 INFO - mozcrash == 0.17 04:12:19 INFO - mozdebug == 0.1 04:12:19 INFO - mozdevice == 0.48 04:12:19 INFO - mozfile == 1.2 04:12:19 INFO - mozhttpd == 0.7 04:12:19 INFO - mozinfo == 0.9 04:12:19 INFO - mozleak == 0.1 04:12:19 INFO - mozlog == 3.1 04:12:19 INFO - moznetwork == 0.27 04:12:19 INFO - mozprocess == 0.22 04:12:19 INFO - mozprofile == 0.28 04:12:19 INFO - mozrunner == 6.11 04:12:19 INFO - mozscreenshot == 0.1 04:12:19 INFO - mozsystemmonitor == 0.0 04:12:19 INFO - moztest == 0.7 04:12:19 INFO - mozversion == 1.4 04:12:19 INFO - psutil == 3.1.1 04:12:19 INFO - requests == 1.2.3 04:12:19 INFO - wsgiref == 0.1.2 04:12:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:19 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')]} 04:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:19 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')]} 04:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:19 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:19 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 04:12:19 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 04:12:19 INFO - Using env: {'DISPLAY': ':0', 04:12:19 INFO - 'HOME': '/home/cltbld', 04:12:19 INFO - 'LANG': 'en_US.UTF-8', 04:12:19 INFO - 'LANGUAGE': 'en_US:en', 04:12:19 INFO - 'LOGNAME': 'cltbld', 04:12:19 INFO - 'MAIL': '/var/mail/cltbld', 04:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:19 INFO - 'MOZ_NO_REMOTE': '1', 04:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:19 INFO - 'NO_EM_RESTART': '1', 04:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:19 INFO - 'PWD': '/builds/slave/test', 04:12:19 INFO - 'SHELL': '/bin/bash', 04:12:19 INFO - 'SHLVL': '1', 04:12:19 INFO - 'TERM': 'linux', 04:12:19 INFO - 'TMOUT': '86400', 04:12:19 INFO - 'USER': 'cltbld', 04:12:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:19 INFO - '_': '/tools/buildbot/bin/python'} 04:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 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)) 04:12:19 INFO - Cleaning up... 04:12:19 INFO - Return code: 0 04:12:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:19 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')]} 04:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:19 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')]} 04:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:19 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:19 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 04:12:19 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 04:12:19 INFO - Using env: {'DISPLAY': ':0', 04:12:19 INFO - 'HOME': '/home/cltbld', 04:12:19 INFO - 'LANG': 'en_US.UTF-8', 04:12:19 INFO - 'LANGUAGE': 'en_US:en', 04:12:19 INFO - 'LOGNAME': 'cltbld', 04:12:19 INFO - 'MAIL': '/var/mail/cltbld', 04:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:19 INFO - 'MOZ_NO_REMOTE': '1', 04:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:19 INFO - 'NO_EM_RESTART': '1', 04:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:19 INFO - 'PWD': '/builds/slave/test', 04:12:19 INFO - 'SHELL': '/bin/bash', 04:12:19 INFO - 'SHLVL': '1', 04:12:19 INFO - 'TERM': 'linux', 04:12:19 INFO - 'TMOUT': '86400', 04:12:19 INFO - 'USER': 'cltbld', 04:12:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:19 INFO - '_': '/tools/buildbot/bin/python'} 04:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:19 INFO - Downloading/unpacking jsonschema 04:12:19 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 04:12:19 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 04:12:19 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 04:12:19 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 04:12:19 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 04:12:19 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 04:12:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:12:21 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 04:12:21 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 04:12:21 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 04:12:21 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 04:12:21 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 04:12:21 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 04:12:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:22 INFO - warning: no files found matching '*.txt' 04:12:22 INFO - no previously-included directories found matching 'build' 04:12:22 INFO - no previously-included directories found matching 'dist' 04:12:22 INFO - no previously-included directories found matching '.git*' 04:12:22 INFO - Installing collected packages: jsonschema, functools32 04:12:22 INFO - Running setup.py install for functools32 04:12:22 INFO - warning: no files found matching '*.txt' 04:12:22 INFO - no previously-included directories found matching 'build' 04:12:22 INFO - no previously-included directories found matching 'dist' 04:12:22 INFO - no previously-included directories found matching '.git*' 04:12:22 INFO - Successfully installed jsonschema functools32 04:12:22 INFO - Cleaning up... 04:12:22 INFO - Return code: 0 04:12:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:12:22 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')]} 04:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 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')]} 04:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 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 0x7f69aa493f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', '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 04:12:22 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 04:12:22 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 04:12:22 INFO - Using env: {'DISPLAY': ':0', 04:12:22 INFO - 'HOME': '/home/cltbld', 04:12:22 INFO - 'LANG': 'en_US.UTF-8', 04:12:22 INFO - 'LANGUAGE': 'en_US:en', 04:12:22 INFO - 'LOGNAME': 'cltbld', 04:12:22 INFO - 'MAIL': '/var/mail/cltbld', 04:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:22 INFO - 'MOZ_NO_REMOTE': '1', 04:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:22 INFO - 'NO_EM_RESTART': '1', 04:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:22 INFO - 'PWD': '/builds/slave/test', 04:12:22 INFO - 'SHELL': '/bin/bash', 04:12:22 INFO - 'SHLVL': '1', 04:12:22 INFO - 'TERM': 'linux', 04:12:22 INFO - 'TMOUT': '86400', 04:12:22 INFO - 'USER': 'cltbld', 04:12:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:22 INFO - '_': '/tools/buildbot/bin/python'} 04:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:22 INFO - Downloading/unpacking flake8 04:12:22 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 04:12:22 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 04:12:22 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 04:12:22 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 04:12:22 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 04:12:22 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 04:12:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:12:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:12:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 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 04:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:25 INFO - no previously-included directories found matching 'docs/_build' 04:12:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:12:25 INFO - Running setup.py install for pep8 04:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:25 INFO - no previously-included directories found matching 'docs/_build' 04:12:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:12:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:12:25 INFO - Cleaning up... 04:12:25 INFO - Return code: 0 04:12:25 INFO - Running post-action listener: _resource_record_post_action 04:12:25 INFO - Running post-action listener: _start_resource_monitoring 04:12:25 INFO - Starting resource monitoring. 04:12:25 INFO - ##### 04:12:25 INFO - ##### Running install step. 04:12:25 INFO - ##### 04:12:25 INFO - Running pre-action listener: _resource_record_pre_action 04:12:25 INFO - Running main action method: install 04:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:25 INFO - Reading from file tmpfile_stdout 04:12:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:25 INFO - Reading from file tmpfile_stdout 04:12:25 INFO - Output received: 04:12:25 INFO - Usage: mozinstall [options] installer 04:12:25 INFO - Options: 04:12:25 INFO - -h, --help show this help message and exit 04:12:25 INFO - -d DEST, --destination=DEST 04:12:25 INFO - Directory to install application into. [default: 04:12:25 INFO - "/builds/slave/test"] 04:12:25 INFO - --app=APP Application being installed. [default: firefox] 04:12:25 INFO - mkdir: /builds/slave/test/build/application 04:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:12:42 INFO - Reading from file tmpfile_stdout 04:12:42 INFO - Output received: 04:12:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:12:42 INFO - Running post-action listener: _resource_record_post_action 04:12:42 INFO - ##### 04:12:42 INFO - ##### Running run-tests step. 04:12:42 INFO - ##### 04:12:42 INFO - Running pre-action listener: _resource_record_pre_action 04:12:42 INFO - Running main action method: run_tests 04:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:42 INFO - Python 2.7.3 04:12:42 INFO - Return code: 0 04:12:42 INFO - grabbing minidump binary from tooltool 04:12:42 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')]} 04:12:42 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 0x293b410>, '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 0x293c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:42 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 04:12:42 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 04:12:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:42 INFO - Return code: 0 04:12:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:12:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:12:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:12:43 INFO - Return code: 0 04:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 04:12:43 INFO - Using env: {'DISPLAY': ':0', 04:12:43 INFO - 'HOME': '/home/cltbld', 04:12:43 INFO - 'LANG': 'en_US.UTF-8', 04:12:43 INFO - 'LANGUAGE': 'en_US:en', 04:12:43 INFO - 'LOGNAME': 'cltbld', 04:12:43 INFO - 'MAIL': '/var/mail/cltbld', 04:12:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:43 INFO - 'MOZ_NO_REMOTE': '1', 04:12:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:43 INFO - 'NO_EM_RESTART': '1', 04:12:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:43 INFO - 'PWD': '/builds/slave/test', 04:12:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:43 INFO - 'SHELL': '/bin/bash', 04:12:43 INFO - 'SHLVL': '1', 04:12:43 INFO - 'TERM': 'linux', 04:12:43 INFO - 'TMOUT': '86400', 04:12:43 INFO - 'USER': 'cltbld', 04:12:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097', 04:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:43 INFO - '_': '/tools/buildbot/bin/python'} 04:12:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:12:43 INFO - mozversion application_buildid: 20160428013048 04:12:43 INFO - mozversion application_changeset: 36c2c8a36ad9d6521b54e3867b12fd37be488d05 04:12:43 INFO - mozversion application_display_name: Nightly 04:12:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:43 INFO - mozversion application_name: Firefox 04:12:43 INFO - mozversion application_remotingname: firefox 04:12:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:12:43 INFO - mozversion application_vendor: Mozilla 04:12:43 INFO - mozversion application_version: 49.0a1 04:12:43 INFO - mozversion platform_buildid: 20160428013048 04:12:43 INFO - mozversion platform_changeset: 36c2c8a36ad9d6521b54e3867b12fd37be488d05 04:12:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:12:43 INFO - mozversion platform_version: 49.0a1 04:12:43 INFO - using testdate: 1461841963 04:12:43 INFO - actual date: 1461841963 04:12:43 INFO - starting webserver on 'localhost:60749' 04:12:43 INFO - SUITE-START | Running 2 tests 04:12:43 INFO - TEST-START | dromaeo_css 04:12:43 INFO - operating with platform_type : linux_ 04:12:43 INFO - Initialising browser for dromaeo_css test... 04:12:43 INFO - TEST-INFO | started process 6755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgObA5r/profile http://localhost:60749/getInfo.html) 04:12:47 INFO - PROCESS | 6755 | 04:12:47 INFO - PROCESS | 6755 | (process:6825): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:48 INFO - PROCESS | 6755 | __metrics Screen width/height:1600/1200 04:12:48 INFO - PROCESS | 6755 | colorDepth:24 04:12:48 INFO - PROCESS | 6755 | Browser inner width/height: 1024/697 04:12:48 INFO - PROCESS | 6755 | __metrics 04:12:48 ERROR - PROCESS | 6755 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:12:49 INFO - TEST-INFO | 6755: exit 0 04:12:49 INFO - Browser initialized. 04:12:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:49 INFO - TEST-INFO | started process 6876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgObA5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:51 INFO - PROCESS | 6876 | 04:12:51 INFO - PROCESS | 6876 | (process:6936): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:13:01 INFO - PROCESS | 6876 | RSS: Main: 164777984 04:13:01 INFO - PROCESS | 6876 | 04:13:50 INFO - PROCESS | 6876 | 1461842030925 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] 04:15:58 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60749/tests/dromaeo/cssquery-ext.html) 04:15:59 INFO - PROCESS | 6876 | RSS: Main: 167292928 04:15:59 INFO - PROCESS | 6876 | 04:19:01 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-ext.html (next: http://localhost:60749/tests/dromaeo/cssquery-jquery.html) 04:19:01 INFO - PROCESS | 6876 | RSS: Main: 167002112 04:19:01 INFO - PROCESS | 6876 | 04:22:03 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60749/tests/dromaeo/cssquery-mootools.html) 04:22:03 INFO - PROCESS | 6876 | RSS: Main: 167505920 04:22:03 INFO - PROCESS | 6876 | 04:25:05 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60749/tests/dromaeo/cssquery-prototype.html) 04:25:06 INFO - PROCESS | 6876 | RSS: Main: 165191680 04:25:06 INFO - PROCESS | 6876 | 04:28:08 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60749/tests/dromaeo/cssquery-yui.html) 04:28:09 INFO - PROCESS | 6876 | RSS: Main: 166506496 04:28:09 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | Cycle 1(1): loaded http://localhost:60749/tests/dromaeo/cssquery-yui.html (next: http://localhost:60749/tests/dromaeo/cssquery-dojo.html) 04:31:11 INFO - PROCESS | 6876 | RSS: Main: 168239104 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | __start_tp_report 04:31:11 INFO - PROCESS | 6876 | _x_x_mozilla_page_load 04:31:11 INFO - PROCESS | 6876 | _x_x_mozilla_page_load_details 04:31:11 INFO - PROCESS | 6876 | |i|pagename|runs| 04:31:11 INFO - PROCESS | 6876 | |0;dojo.html;3113.98443007785;3160.905172844814;3164.8101113933153;3204.551362809207;3214.871405143793;5260.500252476018;5270.86822829429;5277.3139491866095;5292.338457692788;5303.9734801325985;5254.789808407659;5338.199270109486;5365.7585408656605;5392.325959255093;5462.262594549735;4820.108279968217;4838.491958344376;4870.902581948359;4881.292212629167;4922.360093187881;838.7367805804673;4765.809367625291;4778.068276686047;4784.162771514988;4818.855434336958;4792.592629626469;4811.855644330658;4812.759362031902;4842.29786680931;4861.124997500448;4757.904841903177;4781.665283430161;4793.616510679172;4798.376211092535;4879.56083952446;4762.952370476286;4814.2537906624175;4845.079434907357;4861.368022157132;4890.877728056791;5217.686938783685;5236.188390799432;5242.501962313574;5263.921041184385;5291.470852914677;5550.888982220333;5701.885962280731;5703.429657034263;5710.428957104256;5721.684012677108;5680.772769089232;5694.202811606378;5708.372079071299;5721.828345149652;5770.336411312711;5275.208718692188;5291.656042357273;5291.841244762625;5297.284866543006;5300.867478313035;5536.806211782568;5756.395578464285;5766.308043034863;5770.509506691894;5819;5578.776848925998;5585.078462053797;5593.720313984284;5602.803901863415;5642.322921249476;5633.605647604711;5648.51987581052;5653.180288858092;5654.491095801398;5661.34894487131;5497.01053810318;5559.166125081189;5640.943590564042;5643.746031428595;5644.887102258014;5694.743736531866;5705.429457054344;5706.144078388275;5714.200011998323;5716.885662286731;4308.5045219799495;4330.198913201068;4339.544347843431;4339.934900976488;4345.152695224401;3773.056735816046;3844.884653460345;3906.335922893115;3907.1208977979727;3928.607139286106;5342.759575819097;5402.648827826179;5428.5928555358505;5436.3476382834315;5451.400345961941;5700.486956173964;5713.371529131792;5714.142878568165;5743.8851222976145;5762.308522977186;5266.315379000705;5376.623636345418;5385.7307134643115;5393.2449457076045;5462.508374246337;4909.165441874889;4918.5573298403315;4946.802127914843;4956.5786908112495;4983.6013118950395;5903.439173278532;5916.053431451033;5927.1405646181065;5932.466078052909;5932.822015339547;5739.713014349266;5762.394948530344;5763;5764.19301297827;5769.94230057694;5774.913376299275;5905.527557795452;5959.404059594006;5993.910091348721;6007.48936340416;5617.9719101404235;5639.069553523786;5642.71786410686;5662.122371032497;5678.943210568007;5618.185363122243;5798.10129429939;5800.970995144998;5804.129380592776;5807.82576522705;5520.392756796829;5542.528885044816;5576.832695019156;5581.832545023656;5635.549156067586;5515.25544051564;5536.4186760389575;5541.418151094077;5541.972290138524;5549.861253468695;5320.467953204648;5421.512063914267;5437.9939711153565;5445.428230035789;5492.148716948879;5631.183478395527;5638.126090455986;5659.801906933238;5677.51741102011;5725.112607545837;5493.862653433696;5494.752736126804;5514.696691681996;5519.3652729936575;5535.114381698909 04:31:11 INFO - PROCESS | 6876 | |1;ext.html;611.2909025530386;633.9936600633993;661.7121552124826;669.5413641655464;676.5568552598048;32153.196170095758;38143.23713525728;39282.80358598203;39426.21147577047;39430.60569394305;41009;41187.382189267184;41670.791646041806;41718.957026074364;41811.16377672445;8677.783055423617;8890.822183556325;8897.110288971084;8915.55422228886;8926.464412135292;8785.38502304839;8914.955425222897;8915.1976322131;8954.776130596721;8962.462252264851;8918.50948197852;8973.551322433885;8995.775105622379;9006.954965225197;9007.279417646572;8926.062763409846;8990.550472476383;8994.010658827556;9001.774955626097;9024.909750902538;8787.692430764957;8913.064128266504;8913.1086891311;8933.731988040368;8937.687180948635;40656.39015414771;41094.79452602718;41165.79417102925;41193;41301.79349103265;3131.451995900731;3241.529978153178;3344.3812894614575;3589;3606.855725770966;31387;32078.518822217684;32256.838715806272;32257.1935701607;32302;4092.242935057024;4092.4270602115726;4092.6521245694153;4207.179599978005;4231.344141658017;322995;323007.9999999977;324136.37931810424;324892;325859;32976.34047319088;33402.49896251558;33767.66232337694;33773.49339759906;56883.71558142183;34466.31067378689;34673;34690.30619387598;34791.30417391638;34851;14303.427862885575;14361.712765744836;14475.638109047359;14476.203808790407;14494.710105797825;11960.222585531912;11990.520379184734;11996;12026.458809353426;12064.095192860395;8548.786280343042;8561.743147705578;8577.614007369682;8593.527355995355;8641.481511109354;3289.5723555938052;3310.470324748029;3355.198409328238;3368.814715190639;3376.139084533428;1092.4919912240687;1130.2257953302014;1185.1881461199107;1189.4766302826729;1261.9810702839466;31435.214119647193;31541;31719.84140079331;31843.681563184535;32428;1134.262729225993;1150.5685367987005;1186.9169158158845;1221.3587866370226;1234.0929416878587;16460.6707865842;16948.83051169497;17383.91308043452;17501.649967000587;17613.647727045645;494454.0554594408;505203;505398;507610;508352;47423.81440463947;48077.75961120172;48096.27855582169;48109.27836082462;48279.75860120677;1369.869862363074;1377.5178687459309;1395.4766962389308;1402.52314213168;1517.9165145916859;31006.37987240288;31207;31355.84322078375;31583.684163158076;32129;50046.49953500564;50497.747511263675;50625.49374506355;50972.74513627408;51047;332870;339000;341665;342817;343812;25146.74853251444;25293.74706252914;25298;25316.113936012152;25322.493550128525;47310.52689473061;47337;47945.280820788415;48514.757426214055;49131.754341228065;39546.2090758189;40233;40553.797231013654;40751.79624101861;41090;39013;40948.38577421282;41338.58661413348;41452;41486;28938;36396.45405318975;37429;37545.62454375421;38087.23825523419;31832.36335273235;33324.50013249851;33422.832885835414;33617.66382336243;33662.83168584239;26801.463970720088;27985.580216297178;28017.71982280151;28275.293117672223;28327.43345133127 04:31:11 INFO - PROCESS | 6876 | |2;jquery.html;376.3075940269903;377.24927394484973;378.8162741070581;383.75823231364234;389.9922001559967;17742.64514709705;19067.523311917208;19916.70124948125;20007.799922000777;20208.39374818756;17557.561060973483;17867.73198402025;18319.084045797725;18320.725189122175;18624.068796560186;5654.236678048463;5755.366909639957;5808.157817116516;5849.122631605272;5859.824205273849;5555.250041244441;5739.311282646067;5751.971240143794;5798.62308949919;5800.303963524383;5689.9146512802345;5693.430656934315;5736.971315143418;5743.10981797822;5784.942150578482;5577.163425486169;5663.9716801415725;5683.318001839764;5696.287964004499;5746.138079288098;4969.701817890902;5046.596272298208;5058.54473097423;5101;5104.4640312767;22289.108435662554;22713.886430567905;22875.313740587808;22937.541249174923;23050.42373940648;2342.5783358995373;2366.7278262999803;2368.9052437902465;2385.9164929227395;2421.9152329668555;9101;9221.815563688755;9396.48319342436;9612.66355677548;9795.118439340422;1914.5500807310411;1974.2300502803919;1991.980080199194;2031.2281333093479;2032.9796702032938;80033.59983200105;83790;84920.15079849245;85167.57416212879;85916.26753592207;10597.629082982214;10851.294665846695;10933.671989840317;11018.449077546251;11077.667669969915;15339.386424543116;15396.615084622974;15424.305906234247;15523.922380388025;15533.145676987875;7768.223177682186;7826.178251283647;7859.09620393662;7931.365490760725;7939.166387529342;7091.574505529685;7250.166230883516;7252.274772522811;7320.304571065741;7503.362214211744;4402.638187818571;4510.143072816154;4604.240300350471;4774.21225497789;4798.448178459522;1833.7982821889582;1947.3768394114031;1974.3583335416047;1978.5647157625299;2015.2543558883308;982.5725809272989;982.626601891291;1022.6983040003217;1108.3239224073309;1145.1010956399186;18097.819021809875;18458.81541184571;18848.15183316754;19103.713444298348;19238.134283957257;997.4962643864802;1023.7133602591286;1025.4206373399006;1027.8817935937313;1080.9297395669257;9944.25418093646;10559.736006599896;10590.576376944837;10594.023832811077;10617.309874858109;434675;449662;452870;455029;455688;90099;96490;96784.51607741916;96847;97124.51437742908;915.3546749541557;916.6058594804165;917.5916717060844;932.7807965128189;940.5673390240429;16165.353385864433;16845.831541684427;16852.567531759938;16879.7468037982;17193.742093868354;37588.436173457965;38002.14983876276;38963.80518097391;39175;39870.80064599658;58840.11739823992;60686.39313606984;62781.37218627755;63146.68426657837;63508.68245658742;7912.28789408956;7989.920100798918;8302.6678932842;8342.374321926001;8485.236328730443;13161.341932903508;13198.736025279633;13207.273599952096;13416.597502074954;13435.664108397368;11519.76960460803;11577.131715121232;11706;11901.10741694359;12151.878481215428;11552.595659152226;11718.051165841907;11808.82286765682;11942.283462992249;11962.282263064244;6605.636689981905;9740.269479789185;11950.103742219542;12008.399580020789;12078.396080196131;8329.083800782031;8539.8719019216;8551.230389264996;8563.229309362187;8692.826143476968;8537.82924341522;11608.129390295593;12251.816222756845;12260.448279827608;12302.446389912297 04:31:11 INFO - PROCESS | 6876 | |3;mootools.html;1448.3916754962916;1485.435534496891;1661.5264649574865;1793.6323053773979;1808.8010318864922;7289.599072051035;7869.80325491863;7990.081140668824;8157.061937877146;8176.264136227738;8056.315213206884;8077.757667269977;8130.105688374274;8131.064927533335;8140.023197216327;2287.2337766848127;2299.2642354446584;2311.884405779704;2312.5490529346785;2317.571249318873;2245.5733410651924;2263.7736226377315;2307.1002309099463;2313.3869524576003;2319.9072037118494;2228.765979572146;2236.284388995522;2252.853564518301;2299.793018628323;2306.5271619318;2250.324902529243;2255.954880902381;2258.954820903581;2265.29775769512;2269.0810221860174;2239.8208143348493;2240.9663855042186;2242.1143648258844;2253.8167462082374;2254.425121593983;8058.838823223561;8203.05664848544;8204.220599043081;8235.83528329436;8245;4891.1685013547785;5031.245313203049;5035.874103147414;5041.899162016776;5047.318611987408;3088;3106.8912588059534;3225.064731227941;3239.2387788869596;3249.52881832133;1048.2609760119099;1048.8374301983206;1051.6634676903393;1058.560697310615;1061.3101484035362;11070.003699667068;11087.33475991435;11092.55629774816;11100.222984391015;11113.166512511594;4376.168527979674;4516.096780643885;4529.252673308867;4572.1312950539295;4608;9469.810603788024;9482.810343793086;9485;9511.286653500876;9526.809463810685;5054.7978080876355;5062.974685126551;5081.796728130834;5097.592192624581;5101.20931255656;4102.2410853992105;4474.888127796831;4544;4606.355110284563;4619.514950930171;3778.848846046182;3895.2014836958356;3948.9605103949166;3962.920741585152;4000.3399439092805;1234.512367614787;1273.2169715624825;1287.5236162619703;1290.0582574720506;1294.825198598196;863.9308855291562;909.2135302962889;978.9755256118511;1011.9089281964658;1023.5445226873969;5341.412444631087;5442.8911421771345;5495.642783219078;5633.605647604629;5666.688332141689;907.0974380491454;935.3312381647155;1002.2733518199248;1035.7514196592763;1041.8383502394774;4031;4102.261592913304;4128.690348223895;4129.690273229459;4130.814113364906;10113.94943025295;10341.224408169417;10355.637552685619;10412.895871041193;10431.16550675944;10339.689809305733;10342.534585943651;10359.22305827066;10365.326253793479;10378.948105259426;7438.107427108782;7794.2985131338455;7839.804004899923;7846.215378462108;7862.034491377156;5747.626404283708;5879.176915231957;5910.822675319747;5944.494717949023;6029.155918171372;9220.26237900953;9293.86059209126;9369.578368973276;9396.530173491436;9587.616495340108;9363.063693630855;9528.666496672584;9620.086091821266;9621.711348659552;9627.181689556466;6358.395952384516;6702.463802895854;6883.346082122191;7025.6487175639995;7121.786346409616;7729.497582657109;7765.961170194113;7785.377169826514;7795.103563090091;7801.2198780121535;6894.517383783087;7031.156261248479;7121.359077683033;7134.143902731706;7217.314355136254;6813.7955861324235;6822.590644561144;6847.349501797321;6972.09362782835;6985.895211571932;6301.4328710416285;6434.034894765822;6442.677866106582;6485.675716214076;6526.347365263626;4993.80024799004;5074.3657042869645;5080.212567052113;5091.87270318245;5145.485451454824;4806.687565308243;4989.825356112518;5112.412072611549;5157.896842063213;5249.6850188987255 04:31:11 INFO - PROCESS | 6876 | |4;prototype.html;313.3967113306884;314.60517051100874;315.5424634280294;316.73394348747047;316.9255225022118;5619.57853161013;5639.379668236491;5649.774009039638;5657.490825825675;5688.260526131602;5562.86092847679;5571.693556854371;5580.358258800239;5582.7766889324375;5586.776528938848;4050.8784736457956;4106.79466026699;4324.783760811947;4336.91326173478;4345.826166953318;4242.984582323403;4263.616274535291;4264.339027450735;4273;4343.457067866517;4266.2534056540135;4286.378475121106;4301.268784306675;4301.6343610792965;4305.225059489307;4050.8379664813374;4269.487661480643;4280.293751530994;4286.442762440863;4290.914181716364;3674.926501469982;3690.6493883081066;3693.8522459101605;3701.6668499834873;3724.5344331958504;5362.91955620666;5374.758135883894;5376.11294136467;5376.516113549799;5402.621816472849;4585.862424127282;4819.879503012453;4863.586595139417;4868.103478430328;4919.877003074952;5807.506361959238;5811.418858114154;5816.563757718146;5827.329857066449;5844.620099693549;4038.071243613985;4045.4336392905016;4049.7570145791346;4053;4059.2490389278078;5939.762409503614;5942.226686054343;6036.909446358308;6065.423784740443;6102.51179905602;4139.586041395896;4154.335306350969;4158.4178215049915;4160.271952408317;4165.812538435777;4201.2017716634355;4203.516595591485;4204.894877628022;4210.32634778434;4232.30167022444;4670.626349892001;4846.224604063404;4855.053264613366;4862.781174847069;4866.05112003156;5857.531397488191;5865.266841644794;5882.794102206488;5938.257717785277;5940.554458415636;1512.455516014234;1535.5930678370241;1538.96152596186;1542.6066353079893;1543.1975372806078;913.5523593439167;984.699666601679;998.3460833154151;1007.345225603349;1017.9491025448698;5991.310999235056;6060.696965151725;6098.69506524672;6115.602485838495;6120.693965301717;6453.967730161319;6457.580257283355;6474.838129046717;6477.449416799531;6504.902426463606;5876.7649294028615;6022.2171117754415;6060.151578778975;6072.666003369769;6098.0852872069545;3414.2830005698584;3449.8093710494018;3472.618012018676;3473.4095203815414;3477.565304336958;6433.903491447632;6562.606243625398;6654.800355989328;6655.367740064686;6662.367075127855;6525.64108974011;6559.8032059038305;6572.671366431659;6576.671166441659;6587.4071333580205;6540.836479087966;6624.205095388488;6706.664666766642;6714.294999025032;6731.2932142125355;6391.93608063932;6413.422791948747;6453.386928241809;6479.967600161969;6488.708008139551;5823.7379317929945;6425.871482570229;6427.935720642734;6445.774397896051;6449.290578036318;6330.461910737639;6387.680615969276;6413.871722565429;6418.6469744164515;6424.839379015562;4119.436687265434;4148.979255103826;4200.978995105005;4213.199492096492;4217.219814334358;5879.970600147143;6198.969005154945;6218.315985241529;6221.2845522765465;6236.501079913505;5957.195778569838;5985.940140598713;5993.820185394445;6023.578349515492;6075.605085669417;5689.34572524165;5971.880562388815;5996.190514280516;6010.729517171825;6015.947209238453;5726.914096288642;5856.297244330707;5902.2327097477055;5905.498032667271;5915.792947246826;5984.551158663031;6032.426919442646;6041.365656605993;6063.5452341073715;6069.787557435468;5478.972605136949;5836.678982655825;5879.853003674943;5888.911666324922;5906.350301466749 04:31:11 INFO - PROCESS | 6876 | |5;yui.html;694.7776711452334;738.0847748791498;739.4971419434786;752.5522314223037;765.663108232378;13160.605181844536;13455.192688438701;14441;14485.130892146466;14600.269986500673;11806.232594881327;11851.585194518193;11861.940690296537;11893.108016898725;11895.405229738522;683.2654895986809;792.4136139256966;808.3573559020579;822.7778499805049;823.4688625836332;806.1978331560106;806.2904643913378;808.3654331349892;810.8135128920352;811.7767613906163;850.8468475674376;857.8927634045745;858.5149390594295;860.8278344331128;860.8708693695933;854.3891117850735;854.406187699549;857.7855536115972;858.4377232912452;858.8282343531318;620.5066971757464;622.2843729710823;623.8097380299007;624.6283461340495;625.680902739606;13113.934430327883;13199.934000329937;13204.735905281841;13264.668383290398;13311.267880266581;13739.381727822272;13756.793648095287;13950.23273719945;13967.79048314276;14318.928405357907;10679;10821.188410869216;10979.670609881716;10988.615398461096;10992.780144397148;4379.890502737425;4412.382266482695;4442.133783912139;4453.398791163184;4520.028193938286;53968;55395.72302138504;56186.43813561894;56590.15114773282;56619.999999999585;9244.768880778034;9441.575129119206;9459.24326053914;9715.562799674031;9739.659111931049;17669.381571645186;17795.377161799275;17805.554861128574;17808.732869006715;17830.643387132186;8121.878171827428;8213.835723285501;8345.248927596424;8460.830783384421;8647.956760216159;4714.4106986626675;4734.73958932262;4821.5178482151505;4824.734639594856;4932.556069953722;3040.543918412256;3088.675689052662;3097.4579448596405;3100.162956001912;3121.4069326828285;591.4765432592101;596.4542443664086;612.7793994162098;612.9785457508966;615.9907601385983;583.247610582344;653.0824192010233;661.2032500836481;676.1818199977984;702.0382076555152;9493.952530237304;9514.223500042288;9544.37961532512;9762.463064531377;9812.90187098134;619.1548536248079;654.5418207254941;686.8650722649621;693.3032302535919;699.867025265198;4543.4093567836635;4554.180247555471;4560.179167749837;4603.102395033004;4645.976770116128;66362;66573.66713166403;66676.66661666757;66763.33236667668;66838;56440;58645.70677146587;58801.705991470626;59102.40897590969;60031.39968600345;54353;54791.45208547943;55384.16923746147;55395.723021384634;56090.43909560934;8913.37606367548;8924.86612700823;8949.731508054769;8962.283017358726;9064.546772661472;36217.09457263589;36226;36388.636113638524;36412;36458.27083458263;43346.566534334255;43504.564954350055;43628.345574815765;47980;48432;11674.824877626672;11733.589324373606;11972.102092342935;11977.221480604081;12152.392380381123;12611.684707882376;12803.29581873006;12879.935600321938;13181.340932953122;13628.114172578751;12166.817497737364;12277.938610306892;12500.937495312466;12562.623121306375;12642.873571264538;11793.52825886955;12195.315208240198;12437.93781031089;12540.372981350714;12756.553520626734;12169.148159629096;12399.318037508023;12745.10784245094;13198.80201796993;13206.867931320563;11008.944955275172;11027.558897644005;11050.226484146033;11097;11473.082153427538;10823.945880270863;10833.67498975032;10876.564937402733;10920.50857711389;10985.450727463754 04:31:11 INFO - PROCESS | 6876 | __end_tp_report 04:31:11 INFO - PROCESS | 6876 | __start_cc_report 04:31:11 INFO - PROCESS | 6876 | _x_x_mozilla_cycle_collect,344 04:31:11 INFO - PROCESS | 6876 | __end_cc_report 04:31:11 INFO - PROCESS | 6876 | __startTimestamp1461843071846__endTimestamp 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | ------- Summary: start ------- 04:31:11 INFO - PROCESS | 6876 | Number of tests: 6 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#0] dojo.html Cycles:165 Average:5265.40 Median:5514.70 stddev:688.61 (12.5%) stddev-sans-first:669.72 04:31:11 INFO - PROCESS | 6876 | Values: 3114.0 3160.9 3164.8 3204.6 3214.9 5260.5 5270.9 5277.3 5292.3 5304.0 5254.8 5338.2 5365.8 5392.3 5462.3 4820.1 4838.5 4870.9 4881.3 4922.4 838.7 4765.8 4778.1 4784.2 4818.9 4792.6 4811.9 4812.8 4842.3 4861.1 4757.9 4781.7 4793.6 4798.4 4879.6 4763.0 4814.3 4845.1 4861.4 4890.9 5217.7 5236.2 5242.5 5263.9 5291.5 5550.9 5701.9 5703.4 5710.4 5721.7 5680.8 5694.2 5708.4 5721.8 5770.3 5275.2 5291.7 5291.8 5297.3 5300.9 5536.8 5756.4 5766.3 5770.5 5819.0 5578.8 5585.1 5593.7 5602.8 5642.3 5633.6 5648.5 5653.2 5654.5 5661.3 5497.0 5559.2 5640.9 5643.7 5644.9 5694.7 5705.4 5706.1 5714.2 5716.9 4308.5 4330.2 4339.5 4339.9 4345.2 3773.1 3844.9 3906.3 3907.1 3928.6 5342.8 5402.6 5428.6 5436.3 5451.4 5700.5 5713.4 5714.1 5743.9 5762.3 5266.3 5376.6 5385.7 5393.2 5462.5 4909.2 4918.6 4946.8 4956.6 4983.6 5903.4 5916.1 5927.1 5932.5 5932.8 5739.7 5762.4 5763.0 5764.2 5769.9 5774.9 5905.5 5959.4 5993.9 6007.5 5618.0 5639.1 5642.7 5662.1 5678.9 5618.2 5798.1 5801.0 5804.1 5807.8 5520.4 5542.5 5576.8 5581.8 5635.5 5515.3 5536.4 5541.4 5542.0 5549.9 5320.5 5421.5 5438.0 5445.4 5492.1 5631.2 5638.1 5659.8 5677.5 5725.1 5493.9 5494.8 5514.7 5519.4 5535.1 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#1] ext.html Cycles:180 Average:53303.17 Median:20001.65 stddev:105538.51 (527.6%) stddev-sans-first:105760.42 04:31:11 INFO - PROCESS | 6876 | Values: 611.3 634.0 661.7 669.5 676.6 32153.2 38143.2 39282.8 39426.2 39430.6 41009.0 41187.4 41670.8 41719.0 41811.2 8677.8 8890.8 8897.1 8915.6 8926.5 8785.4 8915.0 8915.2 8954.8 8962.5 8918.5 8973.6 8995.8 9007.0 9007.3 8926.1 8990.6 8994.0 9001.8 9024.9 8787.7 8913.1 8913.1 8933.7 8937.7 40656.4 41094.8 41165.8 41193.0 41301.8 3131.5 3241.5 3344.4 3589.0 3606.9 31387.0 32078.5 32256.8 32257.2 32302.0 4092.2 4092.4 4092.7 4207.2 4231.3 322995.0 323008.0 324136.4 324892.0 325859.0 32976.3 33402.5 33767.7 33773.5 56883.7 34466.3 34673.0 34690.3 34791.3 34851.0 14303.4 14361.7 14475.6 14476.2 14494.7 11960.2 11990.5 11996.0 12026.5 12064.1 8548.8 8561.7 8577.6 8593.5 8641.5 3289.6 3310.5 3355.2 3368.8 3376.1 1092.5 1130.2 1185.2 1189.5 1262.0 31435.2 31541.0 31719.8 31843.7 32428.0 1134.3 1150.6 1186.9 1221.4 1234.1 16460.7 16948.8 17383.9 17501.6 17613.6 494454.1 505203.0 505398.0 507610.0 508352.0 47423.8 48077.8 48096.3 48109.3 48279.8 1369.9 1377.5 1395.5 1402.5 1517.9 31006.4 31207.0 31355.8 31583.7 32129.0 50046.5 50497.7 50625.5 50972.7 51047.0 332870.0 339000.0 341665.0 342817.0 343812.0 25146.7 25293.7 25298.0 25316.1 25322.5 47310.5 47337.0 47945.3 48514.8 49131.8 39546.2 40233.0 40553.8 40751.8 41090.0 39013.0 40948.4 41338.6 41452.0 41486.0 28938.0 36396.5 37429.0 37545.6 38087.2 31832.4 33324.5 33422.8 33617.7 33662.8 26801.5 27985.6 28017.7 28275.3 28327.4 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#2] jquery.html Cycles:180 Average:27902.71 Median:39069.40 stddev:74597.64 (190.9%) stddev-sans-first:74778.27 04:31:11 INFO - PROCESS | 6876 | Values: 376.3 377.2 378.8 383.8 390.0 17742.6 19067.5 19916.7 20007.8 20208.4 17557.6 17867.7 18319.1 18320.7 18624.1 5654.2 5755.4 5808.2 5849.1 5859.8 5555.3 5739.3 5752.0 5798.6 5800.3 5689.9 5693.4 5737.0 5743.1 5784.9 5577.2 5664.0 5683.3 5696.3 5746.1 4969.7 5046.6 5058.5 5101.0 5104.5 22289.1 22713.9 22875.3 22937.5 23050.4 2342.6 2366.7 2368.9 2385.9 2421.9 9101.0 9221.8 9396.5 9612.7 9795.1 1914.6 1974.2 1992.0 2031.2 2033.0 80033.6 83790.0 84920.2 85167.6 85916.3 10597.6 10851.3 10933.7 11018.4 11077.7 15339.4 15396.6 15424.3 15523.9 15533.1 7768.2 7826.2 7859.1 7931.4 7939.2 7091.6 7250.2 7252.3 7320.3 7503.4 4402.6 4510.1 4604.2 4774.2 4798.4 1833.8 1947.4 1974.4 1978.6 2015.3 982.6 982.6 1022.7 1108.3 1145.1 18097.8 18458.8 18848.2 19103.7 19238.1 997.5 1023.7 1025.4 1027.9 1080.9 9944.3 10559.7 10590.6 10594.0 10617.3 434675.0 449662.0 452870.0 455029.0 455688.0 90099.0 96490.0 96784.5 96847.0 97124.5 915.4 916.6 917.6 932.8 940.6 16165.4 16845.8 16852.6 16879.7 17193.7 37588.4 38002.1 38963.8 39175.0 39870.8 58840.1 60686.4 62781.4 63146.7 63508.7 7912.3 7989.9 8302.7 8342.4 8485.2 13161.3 13198.7 13207.3 13416.6 13435.7 11519.8 11577.1 11706.0 11901.1 12151.9 11552.6 11718.1 11808.8 11942.3 11962.3 6605.6 9740.3 11950.1 12008.4 12078.4 8329.1 8539.9 8551.2 8563.2 8692.8 8537.8 11608.1 12251.8 12260.4 12302.4 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#3] mootools.html Cycles:180 Average:5451.93 Median:5038.89 stddev:2996.27 (59.5%) stddev-sans-first:2989.57 04:31:11 INFO - PROCESS | 6876 | Values: 1448.4 1485.4 1661.5 1793.6 1808.8 7289.6 7869.8 7990.1 8157.1 8176.3 8056.3 8077.8 8130.1 8131.1 8140.0 2287.2 2299.3 2311.9 2312.5 2317.6 2245.6 2263.8 2307.1 2313.4 2319.9 2228.8 2236.3 2252.9 2299.8 2306.5 2250.3 2256.0 2259.0 2265.3 2269.1 2239.8 2241.0 2242.1 2253.8 2254.4 8058.8 8203.1 8204.2 8235.8 8245.0 4891.2 5031.2 5035.9 5041.9 5047.3 3088.0 3106.9 3225.1 3239.2 3249.5 1048.3 1048.8 1051.7 1058.6 1061.3 11070.0 11087.3 11092.6 11100.2 11113.2 4376.2 4516.1 4529.3 4572.1 4608.0 9469.8 9482.8 9485.0 9511.3 9526.8 5054.8 5063.0 5081.8 5097.6 5101.2 4102.2 4474.9 4544.0 4606.4 4619.5 3778.8 3895.2 3949.0 3962.9 4000.3 1234.5 1273.2 1287.5 1290.1 1294.8 863.9 909.2 979.0 1011.9 1023.5 5341.4 5442.9 5495.6 5633.6 5666.7 907.1 935.3 1002.3 1035.8 1041.8 4031.0 4102.3 4128.7 4129.7 4130.8 10113.9 10341.2 10355.6 10412.9 10431.2 10339.7 10342.5 10359.2 10365.3 10378.9 7438.1 7794.3 7839.8 7846.2 7862.0 5747.6 5879.2 5910.8 5944.5 6029.2 9220.3 9293.9 9369.6 9396.5 9587.6 9363.1 9528.7 9620.1 9621.7 9627.2 6358.4 6702.5 6883.3 7025.6 7121.8 7729.5 7766.0 7785.4 7795.1 7801.2 6894.5 7031.2 7121.4 7134.1 7217.3 6813.8 6822.6 6847.3 6972.1 6985.9 6301.4 6434.0 6442.7 6485.7 6526.3 4993.8 5074.4 5080.2 5091.9 5145.5 4806.7 4989.8 5112.4 5157.9 5249.7 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#4] prototype.html Cycles:180 Average:5026.20 Median:5809.46 stddev:1554.49 (26.8%) stddev-sans-first:1518.07 04:31:11 INFO - PROCESS | 6876 | Values: 313.4 314.6 315.5 316.7 316.9 5619.6 5639.4 5649.8 5657.5 5688.3 5562.9 5571.7 5580.4 5582.8 5586.8 4050.9 4106.8 4324.8 4336.9 4345.8 4243.0 4263.6 4264.3 4273.0 4343.5 4266.3 4286.4 4301.3 4301.6 4305.2 4050.8 4269.5 4280.3 4286.4 4290.9 3674.9 3690.6 3693.9 3701.7 3724.5 5362.9 5374.8 5376.1 5376.5 5402.6 4585.9 4819.9 4863.6 4868.1 4919.9 5807.5 5811.4 5816.6 5827.3 5844.6 4038.1 4045.4 4049.8 4053.0 4059.2 5939.8 5942.2 6036.9 6065.4 6102.5 4139.6 4154.3 4158.4 4160.3 4165.8 4201.2 4203.5 4204.9 4210.3 4232.3 4670.6 4846.2 4855.1 4862.8 4866.1 5857.5 5865.3 5882.8 5938.3 5940.6 1512.5 1535.6 1539.0 1542.6 1543.2 913.6 984.7 998.3 1007.3 1017.9 5991.3 6060.7 6098.7 6115.6 6120.7 6454.0 6457.6 6474.8 6477.4 6504.9 5876.8 6022.2 6060.2 6072.7 6098.1 3414.3 3449.8 3472.6 3473.4 3477.6 6433.9 6562.6 6654.8 6655.4 6662.4 6525.6 6559.8 6572.7 6576.7 6587.4 6540.8 6624.2 6706.7 6714.3 6731.3 6391.9 6413.4 6453.4 6480.0 6488.7 5823.7 6425.9 6427.9 6445.8 6449.3 6330.5 6387.7 6413.9 6418.6 6424.8 4119.4 4149.0 4201.0 4213.2 4217.2 5880.0 6199.0 6218.3 6221.3 6236.5 5957.2 5985.9 5993.8 6023.6 6075.6 5689.3 5971.9 5996.2 6010.7 6015.9 5726.9 5856.3 5902.2 5905.5 5915.8 5984.6 6032.4 6041.4 6063.5 6069.8 5479.0 5836.7 5879.9 5888.9 5906.4 04:31:11 INFO - PROCESS | 6876 | 04:31:11 INFO - PROCESS | 6876 | [#5] yui.html Cycles:180 Average:15113.86 Median:26400.76 stddev:18134.52 (68.7%) stddev-sans-first:18153.07 04:31:11 INFO - PROCESS | 6876 | Values: 694.8 738.1 739.5 752.6 765.7 13160.6 13455.2 14441.0 14485.1 14600.3 11806.2 11851.6 11861.9 11893.1 11895.4 683.3 792.4 808.4 822.8 823.5 806.2 806.3 808.4 810.8 811.8 850.8 857.9 858.5 860.8 860.9 854.4 854.4 857.8 858.4 858.8 620.5 622.3 623.8 624.6 625.7 13113.9 13199.9 13204.7 13264.7 13311.3 13739.4 13756.8 13950.2 13967.8 14318.9 10679.0 10821.2 10979.7 10988.6 10992.8 4379.9 4412.4 4442.1 4453.4 4520.0 53968.0 55395.7 56186.4 56590.2 56620.0 9244.8 9441.6 9459.2 9715.6 9739.7 17669.4 17795.4 17805.6 17808.7 17830.6 8121.9 8213.8 8345.2 8460.8 8648.0 4714.4 4734.7 4821.5 4824.7 4932.6 3040.5 3088.7 3097.5 3100.2 3121.4 591.5 596.5 612.8 613.0 616.0 583.2 653.1 661.2 676.2 702.0 9494.0 9514.2 9544.4 9762.5 9812.9 619.2 654.5 686.9 693.3 699.9 4543.4 4554.2 4560.2 4603.1 4646.0 66362.0 66573.7 66676.7 66763.3 66838.0 56440.0 58645.7 58801.7 59102.4 60031.4 54353.0 54791.5 55384.2 55395.7 56090.4 8913.4 8924.9 8949.7 8962.3 9064.5 36217.1 36226.0 36388.6 36412.0 36458.3 43346.6 43504.6 43628.3 47980.0 48432.0 11674.8 11733.6 11972.1 11977.2 12152.4 12611.7 12803.3 12879.9 13181.3 13628.1 12166.8 12277.9 12500.9 12562.6 12642.9 11793.5 12195.3 12437.9 12540.4 12756.6 12169.1 12399.3 12745.1 13198.8 13206.9 11008.9 11027.6 11050.2 11097.0 11473.1 10823.9 10833.7 10876.6 10920.5 10985.5 04:31:11 INFO - PROCESS | 6876 | -------- Summary: end -------- 04:31:11 INFO - PROCESS | 6876 | 04:31:12 INFO - TEST-INFO | 6876: exit 0 04:31:12 INFO - TEST-OK | dromaeo_css | took 1109153ms 04:31:12 INFO - TEST-START | kraken 04:31:12 INFO - operating with platform_type : linux_ 04:31:12 INFO - Initialising browser for kraken test... 04:31:12 INFO - TEST-INFO | started process 7109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWF_yz1/profile http://localhost:60749/getInfo.html) 04:31:16 INFO - PROCESS | 7109 | 04:31:16 INFO - PROCESS | 7109 | (process:7178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:17 INFO - PROCESS | 7109 | __metrics Screen width/height:1600/1200 04:31:17 INFO - PROCESS | 7109 | colorDepth:24 04:31:17 INFO - PROCESS | 7109 | Browser inner width/height: 1024/697 04:31:17 INFO - PROCESS | 7109 | __metrics 04:31:17 ERROR - PROCESS | 7109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:31:18 INFO - TEST-INFO | 7109: exit 0 04:31:18 INFO - Browser initialized. 04:31:18 INFO - Running cycle 1/1 for kraken test... 04:31:18 INFO - TEST-INFO | started process 7229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWF_yz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:20 INFO - PROCESS | 7229 | 04:31:20 INFO - PROCESS | 7229 | (process:7288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:30 INFO - PROCESS | 7229 | RSS: Main: 165224448 04:31:30 INFO - PROCESS | 7229 | 04:31:33 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60749/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:33 INFO - PROCESS | 7229 | RSS: Main: 169730048 04:31:33 INFO - PROCESS | 7229 | 04:31:36 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60749/tests/kraken/driver.html?testName=audio-dft) 04:31:37 INFO - PROCESS | 7229 | RSS: Main: 172728320 04:31:37 INFO - PROCESS | 7229 | 04:31:40 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60749/tests/kraken/driver.html?testName=audio-fft) 04:31:40 INFO - PROCESS | 7229 | RSS: Main: 163741696 04:31:40 INFO - PROCESS | 7229 | 04:31:43 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60749/tests/kraken/driver.html?testName=audio-oscillator) 04:31:43 INFO - PROCESS | 7229 | RSS: Main: 163364864 04:31:43 INFO - PROCESS | 7229 | 04:31:45 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:46 INFO - PROCESS | 7229 | RSS: Main: 164864000 04:31:46 INFO - PROCESS | 7229 | 04:31:49 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60749/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:50 INFO - PROCESS | 7229 | RSS: Main: 165494784 04:31:50 INFO - PROCESS | 7229 | 04:31:53 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60749/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:54 INFO - PROCESS | 7229 | RSS: Main: 164687872 04:31:54 INFO - PROCESS | 7229 | 04:31:57 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60749/tests/kraken/driver.html?testName=json-parse-financial) 04:31:57 INFO - PROCESS | 7229 | RSS: Main: 166002688 04:31:57 INFO - PROCESS | 7229 | 04:31:59 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:59 INFO - PROCESS | 7229 | RSS: Main: 165810176 04:31:59 INFO - PROCESS | 7229 | 04:32:01 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:02 INFO - PROCESS | 7229 | RSS: Main: 165662720 04:32:02 INFO - PROCESS | 7229 | 04:32:04 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:05 INFO - PROCESS | 7229 | RSS: Main: 166047744 04:32:05 INFO - PROCESS | 7229 | 04:32:07 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:08 INFO - PROCESS | 7229 | RSS: Main: 166408192 04:32:08 INFO - PROCESS | 7229 | 04:32:11 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:11 INFO - PROCESS | 7229 | RSS: Main: 166141952 04:32:11 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | Cycle 1(1): loaded http://localhost:60749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60749/tests/kraken/driver.html?testName=ai-astar) 04:32:13 INFO - PROCESS | 7229 | RSS: Main: 167907328 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | __start_tp_report 04:32:13 INFO - PROCESS | 7229 | _x_x_mozilla_page_load 04:32:13 INFO - PROCESS | 7229 | _x_x_mozilla_page_load_details 04:32:13 INFO - PROCESS | 7229 | |i|pagename|runs| 04:32:13 INFO - PROCESS | 7229 | |0;ai-astar;115;107;113;114;114;125;114;111;111;111 04:32:13 INFO - PROCESS | 7229 | |1;audio-beat-detection;156;129;154;183;131;165;158;129;186;135 04:32:13 INFO - PROCESS | 7229 | |2;audio-dft;161;164;163;162;166;167;167;163;164;163 04:32:13 INFO - PROCESS | 7229 | |3;audio-fft;76;73;76;171;74;76;74;78;176;74 04:32:13 INFO - PROCESS | 7229 | |4;audio-oscillator;93;93;148;93;93;93;147;93;93;150 04:32:13 INFO - PROCESS | 7229 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;117;118;118 04:32:13 INFO - PROCESS | 7229 | |6;imaging-darkroom;146;147;148;147;146;148;151;147;147;147 04:32:13 INFO - PROCESS | 7229 | |7;imaging-desaturate;96;96;96;95;95;96;96;95;95;95 04:32:13 INFO - PROCESS | 7229 | |8;json-parse-financial;59;60;59;58;64;59;60;87;56;57 04:32:13 INFO - PROCESS | 7229 | |9;json-stringify-tinderbox;62;63;62;63;62;61;63;62;62;62 04:32:13 INFO - PROCESS | 7229 | |10;stanford-crypto-aes;82;78;77;78;81;79;78;78;79;78 04:32:13 INFO - PROCESS | 7229 | |11;stanford-crypto-ccm;128;136;127;122;126;126;122;123;165;127 04:32:13 INFO - PROCESS | 7229 | |12;stanford-crypto-pbkdf2;173;169;169;175;169;169;170;172;170;169 04:32:13 INFO - PROCESS | 7229 | |13;stanford-crypto-sha256-iterative;70;75;68;76;69;70;69;68;67;72 04:32:13 INFO - PROCESS | 7229 | __end_tp_report 04:32:13 INFO - PROCESS | 7229 | __start_cc_report 04:32:13 INFO - PROCESS | 7229 | _x_x_mozilla_cycle_collect,859 04:32:13 INFO - PROCESS | 7229 | __end_cc_report 04:32:13 INFO - PROCESS | 7229 | __startTimestamp1461843133647__endTimestamp 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | ------- Summary: start ------- 04:32:13 INFO - PROCESS | 7229 | Number of tests: 14 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:4.67 (4.1%) stddev-sans-first:4.92 04:32:13 INFO - PROCESS | 7229 | Values: 115.0 107.0 113.0 114.0 114.0 125.0 114.0 111.0 111.0 111.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.00 stddev:21.41 (13.6%) stddev-sans-first:22.68 04:32:13 INFO - PROCESS | 7229 | Values: 156.0 129.0 154.0 183.0 131.0 165.0 158.0 129.0 186.0 135.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.05 (1.3%) stddev-sans-first:1.87 04:32:13 INFO - PROCESS | 7229 | Values: 161.0 164.0 163.0 162.0 166.0 167.0 167.0 163.0 164.0 163.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:41.52 (55.4%) stddev-sans-first:43.48 04:32:13 INFO - PROCESS | 7229 | Values: 76.0 73.0 76.0 171.0 74.0 76.0 74.0 78.0 176.0 74.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:26.74 (28.8%) stddev-sans-first:27.68 04:32:13 INFO - PROCESS | 7229 | Values: 93.0 93.0 148.0 93.0 93.0 93.0 147.0 93.0 93.0 150.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:32:13 INFO - PROCESS | 7229 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.42 04:32:13 INFO - PROCESS | 7229 | Values: 146.0 147.0 148.0 147.0 146.0 148.0 151.0 147.0 147.0 147.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:32:13 INFO - PROCESS | 7229 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:59.50 stddev:9.07 (15.2%) stddev-sans-first:9.56 04:32:13 INFO - PROCESS | 7229 | Values: 59.0 60.0 59.0 58.0 64.0 59.0 60.0 87.0 56.0 57.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:32:13 INFO - PROCESS | 7229 | Values: 62.0 63.0 62.0 63.0 62.0 61.0 63.0 62.0 62.0 62.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:1.55 (2.0%) stddev-sans-first:1.13 04:32:13 INFO - PROCESS | 7229 | Values: 82.0 78.0 77.0 78.0 81.0 79.0 78.0 78.0 79.0 78.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.00 stddev:12.87 (10.1%) stddev-sans-first:13.63 04:32:13 INFO - PROCESS | 7229 | Values: 128.0 136.0 127.0 122.0 126.0 126.0 122.0 123.0 165.0 127.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.00 stddev:2.12 (1.2%) stddev-sans-first:2.05 04:32:13 INFO - PROCESS | 7229 | Values: 173.0 169.0 169.0 175.0 169.0 169.0 170.0 172.0 170.0 169.0 04:32:13 INFO - PROCESS | 7229 | 04:32:13 INFO - PROCESS | 7229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:3.03 (4.3%) stddev-sans-first:3.21 04:32:13 INFO - PROCESS | 7229 | Values: 70.0 75.0 68.0 76.0 69.0 70.0 69.0 68.0 67.0 72.0 04:32:13 INFO - PROCESS | 7229 | -------- Summary: end -------- 04:32:13 INFO - PROCESS | 7229 | 04:32:14 INFO - TEST-INFO | 7229: exit 0 04:32:14 INFO - TEST-OK | kraken | took 62086ms 04:32:14 INFO - SUITE-END | took 1171s 04:32:14 INFO - Completed test suite (00:19:31) 04:32:14 INFO - javascript benchmark 04:32:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.98443007785, 3160.905172844814, 3164.8101113933153, 3204.551362809207, 3214.871405143793, 5260.500252476018, 5270.86822829429, 5277.3139491866095, 5292.338457692788, 5303.9734801325985, 5254.789808407659, 5338.199270109486, 5365.7585408656605, 5392.325959255093, 5462.262594549735, 4820.108279968217, 4838.491958344376, 4870.902581948359, 4881.292212629167, 4922.360093187881, 838.7367805804673, 4765.809367625291, 4778.068276686047, 4784.162771514988, 4818.855434336958, 4792.592629626469, 4811.855644330658, 4812.759362031902, 4842.29786680931, 4861.124997500448, 4757.904841903177, 4781.665283430161, 4793.616510679172, 4798.376211092535, 4879.56083952446, 4762.952370476286, 4814.2537906624175, 4845.079434907357, 4861.368022157132, 4890.877728056791, 5217.686938783685, 5236.188390799432, 5242.501962313574, 5263.921041184385, 5291.470852914677, 5550.888982220333, 5701.885962280731, 5703.429657034263, 5710.428957104256, 5721.684012677108, 5680.772769089232, 5694.202811606378, 5708.372079071299, 5721.828345149652, 5770.336411312711, 5275.208718692188, 5291.656042357273, 5291.841244762625, 5297.284866543006, 5300.867478313035, 5536.806211782568, 5756.395578464285, 5766.308043034863, 5770.509506691894, 5819.0, 5578.776848925998, 5585.078462053797, 5593.720313984284, 5602.803901863415, 5642.322921249476, 5633.605647604711, 5648.51987581052, 5653.180288858092, 5654.491095801398, 5661.34894487131, 5497.01053810318, 5559.166125081189, 5640.943590564042, 5643.746031428595, 5644.887102258014, 5694.743736531866, 5705.429457054344, 5706.144078388275, 5714.200011998323, 5716.885662286731, 4308.5045219799495, 4330.198913201068, 4339.544347843431, 4339.934900976488, 4345.152695224401, 3773.056735816046, 3844.884653460345, 3906.335922893115, 3907.1208977979727, 3928.607139286106, 5342.759575819097, 5402.648827826179, 5428.5928555358505, 5436.3476382834315, 5451.400345961941, 5700.486956173964, 5713.371529131792, 5714.142878568165, 5743.8851222976145, 5762.308522977186, 5266.315379000705, 5376.623636345418, 5385.7307134643115, 5393.2449457076045, 5462.508374246337, 4909.165441874889, 4918.5573298403315, 4946.802127914843, 4956.5786908112495, 4983.6013118950395, 5903.439173278532, 5916.053431451033, 5927.1405646181065, 5932.466078052909, 5932.822015339547, 5739.713014349266, 5762.394948530344, 5763.0, 5764.19301297827, 5769.94230057694, 5774.913376299275, 5905.527557795452, 5959.404059594006, 5993.910091348721, 6007.48936340416, 5617.9719101404235, 5639.069553523786, 5642.71786410686, 5662.122371032497, 5678.943210568007, 5618.185363122243, 5798.10129429939, 5800.970995144998, 5804.129380592776, 5807.82576522705, 5520.392756796829, 5542.528885044816, 5576.832695019156, 5581.832545023656, 5635.549156067586, 5515.25544051564, 5536.4186760389575, 5541.418151094077, 5541.972290138524, 5549.861253468695, 5320.467953204648, 5421.512063914267, 5437.9939711153565, 5445.428230035789, 5492.148716948879, 5631.183478395527, 5638.126090455986, 5659.801906933238, 5677.51741102011, 5725.112607545837, 5493.862653433696, 5494.752736126804, 5514.696691681996, 5519.3652729936575, 5535.114381698909], "value": 5221.289698040815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.2909025530386, 633.9936600633993, 661.7121552124826, 669.5413641655464, 676.5568552598048, 32153.196170095758, 38143.23713525728, 39282.80358598203, 39426.21147577047, 39430.60569394305, 41009.0, 41187.382189267184, 41670.791646041806, 41718.957026074364, 41811.16377672445, 8677.783055423617, 8890.822183556325, 8897.110288971084, 8915.55422228886, 8926.464412135292, 8785.38502304839, 8914.955425222897, 8915.1976322131, 8954.776130596721, 8962.462252264851, 8918.50948197852, 8973.551322433885, 8995.775105622379, 9006.954965225197, 9007.279417646572, 8926.062763409846, 8990.550472476383, 8994.010658827556, 9001.774955626097, 9024.909750902538, 8787.692430764957, 8913.064128266504, 8913.1086891311, 8933.731988040368, 8937.687180948635, 40656.39015414771, 41094.79452602718, 41165.79417102925, 41193.0, 41301.79349103265, 3131.451995900731, 3241.529978153178, 3344.3812894614575, 3589.0, 3606.855725770966, 31387.0, 32078.518822217684, 32256.838715806272, 32257.1935701607, 32302.0, 4092.242935057024, 4092.4270602115726, 4092.6521245694153, 4207.179599978005, 4231.344141658017, 322995.0, 323007.9999999977, 324136.37931810424, 324892.0, 325859.0, 32976.34047319088, 33402.49896251558, 33767.66232337694, 33773.49339759906, 56883.71558142183, 34466.31067378689, 34673.0, 34690.30619387598, 34791.30417391638, 34851.0, 14303.427862885575, 14361.712765744836, 14475.638109047359, 14476.203808790407, 14494.710105797825, 11960.222585531912, 11990.520379184734, 11996.0, 12026.458809353426, 12064.095192860395, 8548.786280343042, 8561.743147705578, 8577.614007369682, 8593.527355995355, 8641.481511109354, 3289.5723555938052, 3310.470324748029, 3355.198409328238, 3368.814715190639, 3376.139084533428, 1092.4919912240687, 1130.2257953302014, 1185.1881461199107, 1189.4766302826729, 1261.9810702839466, 31435.214119647193, 31541.0, 31719.84140079331, 31843.681563184535, 32428.0, 1134.262729225993, 1150.5685367987005, 1186.9169158158845, 1221.3587866370226, 1234.0929416878587, 16460.6707865842, 16948.83051169497, 17383.91308043452, 17501.649967000587, 17613.647727045645, 494454.0554594408, 505203.0, 505398.0, 507610.0, 508352.0, 47423.81440463947, 48077.75961120172, 48096.27855582169, 48109.27836082462, 48279.75860120677, 1369.869862363074, 1377.5178687459309, 1395.4766962389308, 1402.52314213168, 1517.9165145916859, 31006.37987240288, 31207.0, 31355.84322078375, 31583.684163158076, 32129.0, 50046.49953500564, 50497.747511263675, 50625.49374506355, 50972.74513627408, 51047.0, 332870.0, 339000.0, 341665.0, 342817.0, 343812.0, 25146.74853251444, 25293.74706252914, 25298.0, 25316.113936012152, 25322.493550128525, 47310.52689473061, 47337.0, 47945.280820788415, 48514.757426214055, 49131.754341228065, 39546.2090758189, 40233.0, 40553.797231013654, 40751.79624101861, 41090.0, 39013.0, 40948.38577421282, 41338.58661413348, 41452.0, 41486.0, 28938.0, 36396.45405318975, 37429.0, 37545.62454375421, 38087.23825523419, 31832.36335273235, 33324.50013249851, 33422.832885835414, 33617.66382336243, 33662.83168584239, 26801.463970720088, 27985.580216297178, 28017.71982280151, 28275.293117672223, 28327.43345133127], "value": 18157.326563117964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3075940269903, 377.24927394484973, 378.8162741070581, 383.75823231364234, 389.9922001559967, 17742.64514709705, 19067.523311917208, 19916.70124948125, 20007.799922000777, 20208.39374818756, 17557.561060973483, 17867.73198402025, 18319.084045797725, 18320.725189122175, 18624.068796560186, 5654.236678048463, 5755.366909639957, 5808.157817116516, 5849.122631605272, 5859.824205273849, 5555.250041244441, 5739.311282646067, 5751.971240143794, 5798.62308949919, 5800.303963524383, 5689.9146512802345, 5693.430656934315, 5736.971315143418, 5743.10981797822, 5784.942150578482, 5577.163425486169, 5663.9716801415725, 5683.318001839764, 5696.287964004499, 5746.138079288098, 4969.701817890902, 5046.596272298208, 5058.54473097423, 5101.0, 5104.4640312767, 22289.108435662554, 22713.886430567905, 22875.313740587808, 22937.541249174923, 23050.42373940648, 2342.5783358995373, 2366.7278262999803, 2368.9052437902465, 2385.9164929227395, 2421.9152329668555, 9101.0, 9221.815563688755, 9396.48319342436, 9612.66355677548, 9795.118439340422, 1914.5500807310411, 1974.2300502803919, 1991.980080199194, 2031.2281333093479, 2032.9796702032938, 80033.59983200105, 83790.0, 84920.15079849245, 85167.57416212879, 85916.26753592207, 10597.629082982214, 10851.294665846695, 10933.671989840317, 11018.449077546251, 11077.667669969915, 15339.386424543116, 15396.615084622974, 15424.305906234247, 15523.922380388025, 15533.145676987875, 7768.223177682186, 7826.178251283647, 7859.09620393662, 7931.365490760725, 7939.166387529342, 7091.574505529685, 7250.166230883516, 7252.274772522811, 7320.304571065741, 7503.362214211744, 4402.638187818571, 4510.143072816154, 4604.240300350471, 4774.21225497789, 4798.448178459522, 1833.7982821889582, 1947.3768394114031, 1974.3583335416047, 1978.5647157625299, 2015.2543558883308, 982.5725809272989, 982.626601891291, 1022.6983040003217, 1108.3239224073309, 1145.1010956399186, 18097.819021809875, 18458.81541184571, 18848.15183316754, 19103.713444298348, 19238.134283957257, 997.4962643864802, 1023.7133602591286, 1025.4206373399006, 1027.8817935937313, 1080.9297395669257, 9944.25418093646, 10559.736006599896, 10590.576376944837, 10594.023832811077, 10617.309874858109, 434675.0, 449662.0, 452870.0, 455029.0, 455688.0, 90099.0, 96490.0, 96784.51607741916, 96847.0, 97124.51437742908, 915.3546749541557, 916.6058594804165, 917.5916717060844, 932.7807965128189, 940.5673390240429, 16165.353385864433, 16845.831541684427, 16852.567531759938, 16879.7468037982, 17193.742093868354, 37588.436173457965, 38002.14983876276, 38963.80518097391, 39175.0, 39870.80064599658, 58840.11739823992, 60686.39313606984, 62781.37218627755, 63146.68426657837, 63508.68245658742, 7912.28789408956, 7989.920100798918, 8302.6678932842, 8342.374321926001, 8485.236328730443, 13161.341932903508, 13198.736025279633, 13207.273599952096, 13416.597502074954, 13435.664108397368, 11519.76960460803, 11577.131715121232, 11706.0, 11901.10741694359, 12151.878481215428, 11552.595659152226, 11718.051165841907, 11808.82286765682, 11942.283462992249, 11962.282263064244, 6605.636689981905, 9740.269479789185, 11950.103742219542, 12008.399580020789, 12078.396080196131, 8329.083800782031, 8539.8719019216, 8551.230389264996, 8563.229309362187, 8692.826143476968, 8537.82924341522, 11608.129390295593, 12251.816222756845, 12260.448279827608, 12302.446389912297], "value": 9057.308021089199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.3916754962916, 1485.435534496891, 1661.5264649574865, 1793.6323053773979, 1808.8010318864922, 7289.599072051035, 7869.80325491863, 7990.081140668824, 8157.061937877146, 8176.264136227738, 8056.315213206884, 8077.757667269977, 8130.105688374274, 8131.064927533335, 8140.023197216327, 2287.2337766848127, 2299.2642354446584, 2311.884405779704, 2312.5490529346785, 2317.571249318873, 2245.5733410651924, 2263.7736226377315, 2307.1002309099463, 2313.3869524576003, 2319.9072037118494, 2228.765979572146, 2236.284388995522, 2252.853564518301, 2299.793018628323, 2306.5271619318, 2250.324902529243, 2255.954880902381, 2258.954820903581, 2265.29775769512, 2269.0810221860174, 2239.8208143348493, 2240.9663855042186, 2242.1143648258844, 2253.8167462082374, 2254.425121593983, 8058.838823223561, 8203.05664848544, 8204.220599043081, 8235.83528329436, 8245.0, 4891.1685013547785, 5031.245313203049, 5035.874103147414, 5041.899162016776, 5047.318611987408, 3088.0, 3106.8912588059534, 3225.064731227941, 3239.2387788869596, 3249.52881832133, 1048.2609760119099, 1048.8374301983206, 1051.6634676903393, 1058.560697310615, 1061.3101484035362, 11070.003699667068, 11087.33475991435, 11092.55629774816, 11100.222984391015, 11113.166512511594, 4376.168527979674, 4516.096780643885, 4529.252673308867, 4572.1312950539295, 4608.0, 9469.810603788024, 9482.810343793086, 9485.0, 9511.286653500876, 9526.809463810685, 5054.7978080876355, 5062.974685126551, 5081.796728130834, 5097.592192624581, 5101.20931255656, 4102.2410853992105, 4474.888127796831, 4544.0, 4606.355110284563, 4619.514950930171, 3778.848846046182, 3895.2014836958356, 3948.9605103949166, 3962.920741585152, 4000.3399439092805, 1234.512367614787, 1273.2169715624825, 1287.5236162619703, 1290.0582574720506, 1294.825198598196, 863.9308855291562, 909.2135302962889, 978.9755256118511, 1011.9089281964658, 1023.5445226873969, 5341.412444631087, 5442.8911421771345, 5495.642783219078, 5633.605647604629, 5666.688332141689, 907.0974380491454, 935.3312381647155, 1002.2733518199248, 1035.7514196592763, 1041.8383502394774, 4031.0, 4102.261592913304, 4128.690348223895, 4129.690273229459, 4130.814113364906, 10113.94943025295, 10341.224408169417, 10355.637552685619, 10412.895871041193, 10431.16550675944, 10339.689809305733, 10342.534585943651, 10359.22305827066, 10365.326253793479, 10378.948105259426, 7438.107427108782, 7794.2985131338455, 7839.804004899923, 7846.215378462108, 7862.034491377156, 5747.626404283708, 5879.176915231957, 5910.822675319747, 5944.494717949023, 6029.155918171372, 9220.26237900953, 9293.86059209126, 9369.578368973276, 9396.530173491436, 9587.616495340108, 9363.063693630855, 9528.666496672584, 9620.086091821266, 9621.711348659552, 9627.181689556466, 6358.395952384516, 6702.463802895854, 6883.346082122191, 7025.6487175639995, 7121.786346409616, 7729.497582657109, 7765.961170194113, 7785.377169826514, 7795.103563090091, 7801.2198780121535, 6894.517383783087, 7031.156261248479, 7121.359077683033, 7134.143902731706, 7217.314355136254, 6813.7955861324235, 6822.590644561144, 6847.349501797321, 6972.09362782835, 6985.895211571932, 6301.4328710416285, 6434.034894765822, 6442.677866106582, 6485.675716214076, 6526.347365263626, 4993.80024799004, 5074.3657042869645, 5080.212567052113, 5091.87270318245, 5145.485451454824, 4806.687565308243, 4989.825356112518, 5112.412072611549, 5157.896842063213, 5249.6850188987255], "value": 4432.428826823202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.3967113306884, 314.60517051100874, 315.5424634280294, 316.73394348747047, 316.9255225022118, 5619.57853161013, 5639.379668236491, 5649.774009039638, 5657.490825825675, 5688.260526131602, 5562.86092847679, 5571.693556854371, 5580.358258800239, 5582.7766889324375, 5586.776528938848, 4050.8784736457956, 4106.79466026699, 4324.783760811947, 4336.91326173478, 4345.826166953318, 4242.984582323403, 4263.616274535291, 4264.339027450735, 4273.0, 4343.457067866517, 4266.2534056540135, 4286.378475121106, 4301.268784306675, 4301.6343610792965, 4305.225059489307, 4050.8379664813374, 4269.487661480643, 4280.293751530994, 4286.442762440863, 4290.914181716364, 3674.926501469982, 3690.6493883081066, 3693.8522459101605, 3701.6668499834873, 3724.5344331958504, 5362.91955620666, 5374.758135883894, 5376.11294136467, 5376.516113549799, 5402.621816472849, 4585.862424127282, 4819.879503012453, 4863.586595139417, 4868.103478430328, 4919.877003074952, 5807.506361959238, 5811.418858114154, 5816.563757718146, 5827.329857066449, 5844.620099693549, 4038.071243613985, 4045.4336392905016, 4049.7570145791346, 4053.0, 4059.2490389278078, 5939.762409503614, 5942.226686054343, 6036.909446358308, 6065.423784740443, 6102.51179905602, 4139.586041395896, 4154.335306350969, 4158.4178215049915, 4160.271952408317, 4165.812538435777, 4201.2017716634355, 4203.516595591485, 4204.894877628022, 4210.32634778434, 4232.30167022444, 4670.626349892001, 4846.224604063404, 4855.053264613366, 4862.781174847069, 4866.05112003156, 5857.531397488191, 5865.266841644794, 5882.794102206488, 5938.257717785277, 5940.554458415636, 1512.455516014234, 1535.5930678370241, 1538.96152596186, 1542.6066353079893, 1543.1975372806078, 913.5523593439167, 984.699666601679, 998.3460833154151, 1007.345225603349, 1017.9491025448698, 5991.310999235056, 6060.696965151725, 6098.69506524672, 6115.602485838495, 6120.693965301717, 6453.967730161319, 6457.580257283355, 6474.838129046717, 6477.449416799531, 6504.902426463606, 5876.7649294028615, 6022.2171117754415, 6060.151578778975, 6072.666003369769, 6098.0852872069545, 3414.2830005698584, 3449.8093710494018, 3472.618012018676, 3473.4095203815414, 3477.565304336958, 6433.903491447632, 6562.606243625398, 6654.800355989328, 6655.367740064686, 6662.367075127855, 6525.64108974011, 6559.8032059038305, 6572.671366431659, 6576.671166441659, 6587.4071333580205, 6540.836479087966, 6624.205095388488, 6706.664666766642, 6714.294999025032, 6731.2932142125355, 6391.93608063932, 6413.422791948747, 6453.386928241809, 6479.967600161969, 6488.708008139551, 5823.7379317929945, 6425.871482570229, 6427.935720642734, 6445.774397896051, 6449.290578036318, 6330.461910737639, 6387.680615969276, 6413.871722565429, 6418.6469744164515, 6424.839379015562, 4119.436687265434, 4148.979255103826, 4200.978995105005, 4213.199492096492, 4217.219814334358, 5879.970600147143, 6198.969005154945, 6218.315985241529, 6221.2845522765465, 6236.501079913505, 5957.195778569838, 5985.940140598713, 5993.820185394445, 6023.578349515492, 6075.605085669417, 5689.34572524165, 5971.880562388815, 5996.190514280516, 6010.729517171825, 6015.947209238453, 5726.914096288642, 5856.297244330707, 5902.2327097477055, 5905.498032667271, 5915.792947246826, 5984.551158663031, 6032.426919442646, 6041.365656605993, 6063.5452341073715, 6069.787557435468, 5478.972605136949, 5836.678982655825, 5879.853003674943, 5888.911666324922, 5906.350301466749], "value": 4520.97546390584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.7776711452334, 738.0847748791498, 739.4971419434786, 752.5522314223037, 765.663108232378, 13160.605181844536, 13455.192688438701, 14441.0, 14485.130892146466, 14600.269986500673, 11806.232594881327, 11851.585194518193, 11861.940690296537, 11893.108016898725, 11895.405229738522, 683.2654895986809, 792.4136139256966, 808.3573559020579, 822.7778499805049, 823.4688625836332, 806.1978331560106, 806.2904643913378, 808.3654331349892, 810.8135128920352, 811.7767613906163, 850.8468475674376, 857.8927634045745, 858.5149390594295, 860.8278344331128, 860.8708693695933, 854.3891117850735, 854.406187699549, 857.7855536115972, 858.4377232912452, 858.8282343531318, 620.5066971757464, 622.2843729710823, 623.8097380299007, 624.6283461340495, 625.680902739606, 13113.934430327883, 13199.934000329937, 13204.735905281841, 13264.668383290398, 13311.267880266581, 13739.381727822272, 13756.793648095287, 13950.23273719945, 13967.79048314276, 14318.928405357907, 10679.0, 10821.188410869216, 10979.670609881716, 10988.615398461096, 10992.780144397148, 4379.890502737425, 4412.382266482695, 4442.133783912139, 4453.398791163184, 4520.028193938286, 53968.0, 55395.72302138504, 56186.43813561894, 56590.15114773282, 56619.999999999585, 9244.768880778034, 9441.575129119206, 9459.24326053914, 9715.562799674031, 9739.659111931049, 17669.381571645186, 17795.377161799275, 17805.554861128574, 17808.732869006715, 17830.643387132186, 8121.878171827428, 8213.835723285501, 8345.248927596424, 8460.830783384421, 8647.956760216159, 4714.4106986626675, 4734.73958932262, 4821.5178482151505, 4824.734639594856, 4932.556069953722, 3040.543918412256, 3088.675689052662, 3097.4579448596405, 3100.162956001912, 3121.4069326828285, 591.4765432592101, 596.4542443664086, 612.7793994162098, 612.9785457508966, 615.9907601385983, 583.247610582344, 653.0824192010233, 661.2032500836481, 676.1818199977984, 702.0382076555152, 9493.952530237304, 9514.223500042288, 9544.37961532512, 9762.463064531377, 9812.90187098134, 619.1548536248079, 654.5418207254941, 686.8650722649621, 693.3032302535919, 699.867025265198, 4543.4093567836635, 4554.180247555471, 4560.179167749837, 4603.102395033004, 4645.976770116128, 66362.0, 66573.66713166403, 66676.66661666757, 66763.33236667668, 66838.0, 56440.0, 58645.70677146587, 58801.705991470626, 59102.40897590969, 60031.39968600345, 54353.0, 54791.45208547943, 55384.16923746147, 55395.723021384634, 56090.43909560934, 8913.37606367548, 8924.86612700823, 8949.731508054769, 8962.283017358726, 9064.546772661472, 36217.09457263589, 36226.0, 36388.636113638524, 36412.0, 36458.27083458263, 43346.566534334255, 43504.564954350055, 43628.345574815765, 47980.0, 48432.0, 11674.824877626672, 11733.589324373606, 11972.102092342935, 11977.221480604081, 12152.392380381123, 12611.684707882376, 12803.29581873006, 12879.935600321938, 13181.340932953122, 13628.114172578751, 12166.817497737364, 12277.938610306892, 12500.937495312466, 12562.623121306375, 12642.873571264538, 11793.52825886955, 12195.315208240198, 12437.93781031089, 12540.372981350714, 12756.553520626734, 12169.148159629096, 12399.318037508023, 12745.10784245094, 13198.80201796993, 13206.867931320563, 11008.944955275172, 11027.558897644005, 11050.226484146033, 11097.0, 11473.082153427538, 10823.945880270863, 10833.67498975032, 10876.564937402733, 10920.50857711389, 10985.450727463754], "value": 6689.753332947626, "unit": "score"}], "name": "dromaeo_css", "value": 6974.700157714473, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 113.0, 114.0, 114.0, 125.0, 114.0, 111.0, 111.0, 111.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 154.0, 183.0, 131.0, 165.0, 158.0, 129.0, 186.0, 135.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 162.0, 166.0, 167.0, 167.0, 163.0, 164.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 76.0, 171.0, 74.0, 76.0, 74.0, 78.0, 176.0, 74.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 93.0, 93.0, 93.0, 147.0, 93.0, 93.0, 150.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 148.0, 151.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 64.0, 59.0, 60.0, 87.0, 56.0, 57.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 77.0, 78.0, 81.0, 79.0, 78.0, 78.0, 79.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 136.0, 127.0, 122.0, 126.0, 126.0, 122.0, 123.0, 165.0, 127.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 169.0, 175.0, 169.0, 169.0, 170.0, 172.0, 170.0, 169.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 68.0, 76.0, 69.0, 70.0, 69.0, 68.0, 67.0, 72.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1568.9, "alertThreshold": 2.0}]} 04:32:14 INFO - Return code: 0 04:32:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:14 ERROR - # TBPL SUCCESS # 04:32:14 INFO - Running post-action listener: _resource_record_post_action 04:32:14 INFO - Running post-run listener: _resource_record_post_run 04:32:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 535625728; Read time: 0; Write time: 721556 04:32:16 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244826112; Read time: 0; Write time: 430776 04:32:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 290799616; Read time: 0; Write time: 290780 04:32:16 INFO - Running post-run listener: _upload_blobber_files 04:32:16 INFO - Blob upload gear active. 04:32:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:16 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 04:32:16 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:16 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:17 INFO - (blobuploader) - INFO - Done attempting. 04:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:19 INFO - (blobuploader) - INFO - Done attempting. 04:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:19 INFO - Return code: 0 04:32:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21f724cc4a9594a63a5417b5a0fad50e31ac13a06839588679bf55bbf8c76b02ac4343838cf50799d4bcd5bfe0b32d296f193820db22ef2db02ddbc93eaac5d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0421d3569a6482e3256915789aae4b5f64ac76043d13cb39d95b8d0c94962b9ddb96037483065564c7d49cd2b808d61c904763d6191c0c5c95e64a898a95c73"} 04:32:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:19 INFO - Contents: 04:32:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21f724cc4a9594a63a5417b5a0fad50e31ac13a06839588679bf55bbf8c76b02ac4343838cf50799d4bcd5bfe0b32d296f193820db22ef2db02ddbc93eaac5d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0421d3569a6482e3256915789aae4b5f64ac76043d13cb39d95b8d0c94962b9ddb96037483065564c7d49cd2b808d61c904763d6191c0c5c95e64a898a95c73"} 04:32:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:19 INFO - Copying logs to upload dir... 04:32:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.822153 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-28 04:32:18.735314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 04:32:18.738366) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 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/Mozilla-Inbound/sha512/21f724cc4a9594a63a5417b5a0fad50e31ac13a06839588679bf55bbf8c76b02ac4343838cf50799d4bcd5bfe0b32d296f193820db22ef2db02ddbc93eaac5d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0421d3569a6482e3256915789aae4b5f64ac76043d13cb39d95b8d0c94962b9ddb96037483065564c7d49cd2b808d61c904763d6191c0c5c95e64a898a95c73"} build_url:https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010253 build_url: 'https://queue.taskcluster.net/v1/task/GqncnQF6Rm-4k6-evjOQ-A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21f724cc4a9594a63a5417b5a0fad50e31ac13a06839588679bf55bbf8c76b02ac4343838cf50799d4bcd5bfe0b32d296f193820db22ef2db02ddbc93eaac5d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0421d3569a6482e3256915789aae4b5f64ac76043d13cb39d95b8d0c94962b9ddb96037483065564c7d49cd2b808d61c904763d6191c0c5c95e64a898a95c73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 04:32:18.761365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:32:18.761674) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461841751.740783-816371097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:32:18.846834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 04:32:18.847152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 04:32:18.847436) ========= ========= Total master_lag: 0.16 =========