builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1477916744.52 results: success (0) buildid: 20161031022521 builduid: 1450775bf61d47a490b6283ef9fef182 revision: 72abda1585a882494a9396a62648fe5c3132993b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.518657) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.519039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.519335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.536601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.536915) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 05:25:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.9M=0s 2016-10-31 05:25:44 (57.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.624540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.624862) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021693 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.711053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:44.711445) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 72abda1585a882494a9396a62648fe5c3132993b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 72abda1585a882494a9396a62648fe5c3132993b --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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 05:25:45,090 truncating revision to first 12 chars 2016-10-31 05:25:45,090 Setting DEBUG logging. 2016-10-31 05:25:45,090 attempt 1/10 2016-10-31 05:25:45,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/72abda1585a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 05:25:45,392 unpacking tar archive at: mozilla-beta-72abda1585a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:45.413123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:45.413412) ========= script_repo_revision: 72abda1585a882494a9396a62648fe5c3132993b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:45.413788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:45.414053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 05:25:45.424747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-31 05:25:45.425241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:45 INFO - MultiFileLogger online at 20161031 05:25:45 in /builds/slave/test 05:25:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:25:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:45 INFO - {'append_to_log': False, 05:25:45 INFO - 'base_work_dir': '/builds/slave/test', 05:25:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:25:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:45 INFO - 'branch': 'Mozilla-Beta', 05:25:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:45 INFO - 'config_files': ('talos/linux_config.py',), 05:25:45 INFO - 'default_actions': ('clobber', 05:25:45 INFO - 'read-buildbot-config', 05:25:45 INFO - 'download-and-extract', 05:25:45 INFO - 'populate-webroot', 05:25:45 INFO - 'create-virtualenv', 05:25:45 INFO - 'install', 05:25:45 INFO - 'run-tests'), 05:25:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:45 INFO - 'download_minidump_stackwalk': True, 05:25:45 INFO - 'download_symbols': 'ondemand', 05:25:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:45 INFO - 'installer_path': 'installer.exe', 05:25:45 INFO - 'log_level': 'info', 05:25:45 INFO - 'log_name': 'talos', 05:25:45 INFO - 'log_to_console': True, 05:25:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:45 INFO - 'opt_config_files': (), 05:25:45 INFO - 'pip_index': False, 05:25:45 INFO - 'sps_profile': False, 05:25:45 INFO - 'sps_profile_interval': 0, 05:25:45 INFO - 'suite': 'dromaeojs-e10s', 05:25:45 INFO - 'system_bits': '32', 05:25:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:45 INFO - 'title': 'talos-linux64-ix-047', 05:25:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:45 INFO - 'use_talos_json': True, 05:25:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:45 INFO - 'work_dir': 'build'} 05:25:45 INFO - [mozharness: 2016-10-31 12:25:45.890123Z] Running clobber step. 05:25:45 INFO - Running pre-action listener: _resource_record_pre_action 05:25:45 INFO - Running main action method: clobber 05:25:45 INFO - rmtree: /builds/slave/test/build 05:25:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - [mozharness: 2016-10-31 12:25:46.878129Z] Finished clobber step (success) 05:25:46 INFO - [mozharness: 2016-10-31 12:25:46.878231Z] Running read-buildbot-config step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: read_buildbot_config 05:25:46 INFO - Using buildbot properties: 05:25:46 INFO - { 05:25:46 INFO - "project": "", 05:25:46 INFO - "product": "firefox", 05:25:46 INFO - "script_repo_revision": "production", 05:25:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:25:46 INFO - "repository": "", 05:25:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:25:46 INFO - "buildid": "20161031022521", 05:25:46 INFO - "pgo_build": "True", 05:25:46 INFO - "basedir": "/builds/slave/test", 05:25:46 INFO - "buildnumber": 310, 05:25:46 INFO - "slavename": "talos-linux64-ix-047", 05:25:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:25:46 INFO - "platform": "ubuntu64_hw", 05:25:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:25:46 INFO - "branch": "mozilla-beta", 05:25:46 INFO - "repo_path": "releases/mozilla-beta", 05:25:46 INFO - "revision": "72abda1585a882494a9396a62648fe5c3132993b", 05:25:46 INFO - "stage_platform": "linux64-pgo", 05:25:46 INFO - "builduid": "1450775bf61d47a490b6283ef9fef182", 05:25:46 INFO - "slavebuilddir": "test" 05:25:46 INFO - } 05:25:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - [mozharness: 2016-10-31 12:25:46.880671Z] Finished read-buildbot-config step (success) 05:25:46 INFO - [mozharness: 2016-10-31 12:25:46.880761Z] Running download-and-extract step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: download_and_extract 05:25:46 INFO - mkdir: /builds/slave/test/build/tests 05:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:46 INFO - https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:25:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:25:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:25:46 INFO - retry: Failed, sleeping 30 seconds before retrying 05:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 05:26:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:26:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:26:16 INFO - retry: Failed, sleeping 60 seconds before retrying 05:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 05:27:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:27:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:27:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 05:27:16 INFO - Caught exception: HTTP Error 404: Not Found 05:27:16 INFO - Caught exception: HTTP Error 404: Not Found 05:27:16 INFO - Caught exception: HTTP Error 404: Not Found 05:27:16 INFO - trying https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:27:16 INFO - Downloading https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:27:17 INFO - Downloaded 1327 bytes. 05:27:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:27:17 INFO - Using the following test package requirements: 05:27:17 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 05:27:17 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:27:17 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 05:27:17 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'jsshell-linux-x86_64.zip'], 05:27:17 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:27:17 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 05:27:17 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 05:27:17 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 05:27:17 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:27:17 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:27:17 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:27:17 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:17 INFO - https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:27:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:27:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:27:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:27:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:27:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:27:17 INFO - retry: Failed, sleeping 30 seconds before retrying 05:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:27:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:27:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:27:47 INFO - retry: Failed, sleeping 60 seconds before retrying 05:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 05:28:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:28:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 05:28:47 INFO - Caught exception: HTTP Error 404: Not Found 05:28:47 INFO - Caught exception: HTTP Error 404: Not Found 05:28:47 INFO - Caught exception: HTTP Error 404: Not Found 05:28:47 INFO - trying https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:47 INFO - Downloading https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:48 INFO - Downloaded 21787849 bytes. 05:28:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:28:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:28:50 INFO - Return code: 0 05:28:50 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:28:50 INFO - https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:28:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:28:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:28:50 INFO - retry: Failed, sleeping 30 seconds before retrying 05:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:29:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:29:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:29:20 INFO - retry: Failed, sleeping 60 seconds before retrying 05:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 05:30:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:30:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 05:30:20 INFO - Caught exception: HTTP Error 404: Not Found 05:30:20 INFO - Caught exception: HTTP Error 404: Not Found 05:30:20 INFO - Caught exception: HTTP Error 404: Not Found 05:30:20 INFO - trying https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - Downloading https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:30:21 INFO - Downloaded 21787849 bytes. 05:30:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:30:22 INFO - Return code: 0 05:30: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')]} 05:30:22 INFO - https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:30:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:30:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:30:22 INFO - retry: Failed, sleeping 30 seconds before retrying 05:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 05:30:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:30:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:30:52 INFO - retry: Failed, sleeping 60 seconds before retrying 05:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 05:31:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:31:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:31:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 05:31:52 INFO - Caught exception: HTTP Error 404: Not Found 05:31:52 INFO - Caught exception: HTTP Error 404: Not Found 05:31:52 INFO - Caught exception: HTTP Error 404: Not Found 05:31:52 INFO - trying https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:31:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:31:54 INFO - Downloaded 14413770 bytes. 05:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:31:54 INFO - Return code: 0 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:54 INFO - https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:31:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:31:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:31:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:31:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:31:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:31:54 INFO - retry: Failed, sleeping 30 seconds before retrying 05:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 05:32:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:32:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:32:24 INFO - retry: Failed, sleeping 60 seconds before retrying 05:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 05:33:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:33:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:33:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 05:33:24 INFO - Caught exception: HTTP Error 404: Not Found 05:33:24 INFO - Caught exception: HTTP Error 404: Not Found 05:33:24 INFO - Caught exception: HTTP Error 404: Not Found 05:33:24 INFO - trying https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:33:24 INFO - Downloading https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:33:26 INFO - Downloaded 56802186 bytes. 05:33:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:33:26 INFO - mkdir: /builds/slave/test/properties 05:33:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:26 INFO - Contents: 05:33:26 INFO - build_url:https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:33:27 INFO - Running post-action listener: _resource_record_post_action 05:33:27 INFO - Running post-action listener: set_extra_try_arguments 05:33:27 INFO - [mozharness: 2016-10-31 12:33:27.366842Z] Finished download-and-extract step (success) 05:33:27 INFO - [mozharness: 2016-10-31 12:33:27.367075Z] Running populate-webroot step. 05:33:27 INFO - Running pre-action listener: _resource_record_pre_action 05:33:27 INFO - Running main action method: populate_webroot 05:33:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:27 INFO - '--tppagecycles', 05:33:27 INFO - '7'], 05:33:27 INFO - 'tests': ['tsvgm']}}, 05:33:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['damp', 'tps']}, 05:33:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'tests': ['damp', 'tps']}, 05:33:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['dromaeo_dom']}, 05:33:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['basic_compositor_video']}, 05:33:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:33:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['a11yr', 05:33:27 INFO - 'ts_paint', 05:33:27 INFO - 'tpaint', 05:33:27 INFO - 'sessionrestore', 05:33:27 INFO - 'sessionrestore_no_auto_restore', 05:33:27 INFO - 'tabpaint']}, 05:33:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['tsvgx', 05:33:27 INFO - 'tsvgr_opacity', 05:33:27 INFO - 'tart', 05:33:27 INFO - 'tscrollx', 05:33:27 INFO - 'cart']}, 05:33:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:27 INFO - 'tsvgr_opacity', 05:33:27 INFO - 'tart', 05:33:27 INFO - 'tscrollx', 05:33:27 INFO - 'cart']}, 05:33:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'talos_options': ['--disable-e10s'], 05:33:27 INFO - 'tests': ['tp5o']}, 05:33:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'tests': ['tp5o']}, 05:33:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'talos_options': ['--disable-e10s', 05:33:27 INFO - '--xperf_path', 05:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:27 INFO - 'tests': ['tp5n']}, 05:33:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:27 INFO - 'talos_options': ['--xperf_path', 05:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:27 INFO - 'tests': ['tp5n']}}, 05:33:27 INFO - 'talos.zip': {'path': '', 05:33:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:27 INFO - Running post-action listener: _resource_record_post_action 05:33:27 INFO - [mozharness: 2016-10-31 12:33:27.384552Z] Finished populate-webroot step (success) 05:33:27 INFO - [mozharness: 2016-10-31 12:33:27.384642Z] Running create-virtualenv step. 05:33:27 INFO - Running pre-action listener: _resource_record_pre_action 05:33:27 INFO - Running main action method: create_virtualenv 05:33:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:33:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:27 INFO - Using real prefix '/usr' 05:33:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:29 INFO - Installing pip.................done. 05:33:29 INFO - Return code: 0 05:33:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:29 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:29 INFO - Using env: {'DISPLAY': ':0', 05:33:29 INFO - 'HOME': '/home/cltbld', 05:33:29 INFO - 'LANG': 'en_US.UTF-8', 05:33:29 INFO - 'LANGUAGE': 'en_US:en', 05:33:29 INFO - 'LOGNAME': 'cltbld', 05:33:29 INFO - 'MAIL': '/var/mail/cltbld', 05:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:29 INFO - 'MOZ_NO_REMOTE': '1', 05:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:29 INFO - 'NO_EM_RESTART': '1', 05:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:29 INFO - 'PWD': '/builds/slave/test', 05:33:29 INFO - 'SHELL': '/bin/bash', 05:33:29 INFO - 'SHLVL': '1', 05:33:29 INFO - 'TERM': 'linux', 05:33:29 INFO - 'TMOUT': '86400', 05:33:29 INFO - 'USER': 'cltbld', 05:33:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:29 INFO - '_': '/tools/buildbot/bin/python'} 05:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:33:30 INFO - Cleaning up... 05:33:30 INFO - Return code: 0 05:33:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:30 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:30 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>=3.1.1'] in /builds/slave/test/build 05:33:30 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>=3.1.1 05:33:30 INFO - Using env: {'DISPLAY': ':0', 05:33:30 INFO - 'HOME': '/home/cltbld', 05:33:30 INFO - 'LANG': 'en_US.UTF-8', 05:33:30 INFO - 'LANGUAGE': 'en_US:en', 05:33:30 INFO - 'LOGNAME': 'cltbld', 05:33:30 INFO - 'MAIL': '/var/mail/cltbld', 05:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:30 INFO - 'MOZ_NO_REMOTE': '1', 05:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:30 INFO - 'NO_EM_RESTART': '1', 05:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:30 INFO - 'PWD': '/builds/slave/test', 05:33:30 INFO - 'SHELL': '/bin/bash', 05:33:30 INFO - 'SHLVL': '1', 05:33:30 INFO - 'TERM': 'linux', 05:33:30 INFO - 'TMOUT': '86400', 05:33:30 INFO - 'USER': 'cltbld', 05:33:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:30 INFO - '_': '/tools/buildbot/bin/python'} 05:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:30 INFO - Downloading/unpacking psutil>=3.1.1 05:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:32 INFO - Installing collected packages: psutil 05:33:32 INFO - Running setup.py install for psutil 05:33:32 INFO - building 'psutil._psutil_linux' extension 05:33:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:33:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:33:32 INFO - building 'psutil._psutil_posix' extension 05:33:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:33:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:32 INFO - Successfully installed psutil 05:33:32 INFO - Cleaning up... 05:33:32 INFO - Return code: 0 05:33:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:32 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:32 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.3'] in /builds/slave/test/build 05:33:32 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.3 05:33:32 INFO - Using env: {'DISPLAY': ':0', 05:33:32 INFO - 'HOME': '/home/cltbld', 05:33:32 INFO - 'LANG': 'en_US.UTF-8', 05:33:32 INFO - 'LANGUAGE': 'en_US:en', 05:33:32 INFO - 'LOGNAME': 'cltbld', 05:33:32 INFO - 'MAIL': '/var/mail/cltbld', 05:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:32 INFO - 'MOZ_NO_REMOTE': '1', 05:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:32 INFO - 'NO_EM_RESTART': '1', 05:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:32 INFO - 'PWD': '/builds/slave/test', 05:33:32 INFO - 'SHELL': '/bin/bash', 05:33:32 INFO - 'SHLVL': '1', 05:33:32 INFO - 'TERM': 'linux', 05:33:32 INFO - 'TMOUT': '86400', 05:33:32 INFO - 'USER': 'cltbld', 05:33:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:32 INFO - '_': '/tools/buildbot/bin/python'} 05:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:35 INFO - Installing collected packages: mozsystemmonitor 05:33:35 INFO - Running setup.py install for mozsystemmonitor 05:33:35 INFO - Successfully installed mozsystemmonitor 05:33:35 INFO - Cleaning up... 05:33:35 INFO - Return code: 0 05:33:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:35 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:35 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==2.5.1'] in /builds/slave/test/build 05:33:35 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==2.5.1 05:33:35 INFO - Using env: {'DISPLAY': ':0', 05:33:35 INFO - 'HOME': '/home/cltbld', 05:33:35 INFO - 'LANG': 'en_US.UTF-8', 05:33:35 INFO - 'LANGUAGE': 'en_US:en', 05:33:35 INFO - 'LOGNAME': 'cltbld', 05:33:35 INFO - 'MAIL': '/var/mail/cltbld', 05:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:35 INFO - 'MOZ_NO_REMOTE': '1', 05:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:35 INFO - 'NO_EM_RESTART': '1', 05:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:35 INFO - 'PWD': '/builds/slave/test', 05:33:35 INFO - 'SHELL': '/bin/bash', 05:33:35 INFO - 'SHLVL': '1', 05:33:35 INFO - 'TERM': 'linux', 05:33:35 INFO - 'TMOUT': '86400', 05:33:35 INFO - 'USER': 'cltbld', 05:33:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:35 INFO - '_': '/tools/buildbot/bin/python'} 05:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:37 INFO - warning: no files found matching '*.txt' 05:33:37 INFO - no previously-included directories found matching 'build' 05:33:37 INFO - no previously-included directories found matching 'dist' 05:33:37 INFO - no previously-included directories found matching '.git*' 05:33:37 INFO - Installing collected packages: jsonschema, functools32 05:33:37 INFO - Running setup.py install for functools32 05:33:37 INFO - warning: no files found matching '*.txt' 05:33:37 INFO - no previously-included directories found matching 'build' 05:33:37 INFO - no previously-included directories found matching 'dist' 05:33:37 INFO - no previously-included directories found matching '.git*' 05:33:37 INFO - Successfully installed jsonschema functools32 05:33:37 INFO - Cleaning up... 05:33:38 INFO - Return code: 0 05:33:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:38 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:33:38 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 functools32==3.2.3-2 05:33:38 INFO - Using env: {'DISPLAY': ':0', 05:33:38 INFO - 'HOME': '/home/cltbld', 05:33:38 INFO - 'LANG': 'en_US.UTF-8', 05:33:38 INFO - 'LANGUAGE': 'en_US:en', 05:33:38 INFO - 'LOGNAME': 'cltbld', 05:33:38 INFO - 'MAIL': '/var/mail/cltbld', 05:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:38 INFO - 'MOZ_NO_REMOTE': '1', 05:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:38 INFO - 'NO_EM_RESTART': '1', 05:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:38 INFO - 'PWD': '/builds/slave/test', 05:33:38 INFO - 'SHELL': '/bin/bash', 05:33:38 INFO - 'SHLVL': '1', 05:33:38 INFO - 'TERM': 'linux', 05:33:38 INFO - 'TMOUT': '86400', 05:33:38 INFO - 'USER': 'cltbld', 05:33:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:38 INFO - '_': '/tools/buildbot/bin/python'} 05:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:38 INFO - Cleaning up... 05:33:38 INFO - Return code: 0 05:33:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:33:38 INFO - Using env: {'DISPLAY': ':0', 05:33:38 INFO - 'HOME': '/home/cltbld', 05:33:38 INFO - 'LANG': 'en_US.UTF-8', 05:33:38 INFO - 'LANGUAGE': 'en_US:en', 05:33:38 INFO - 'LOGNAME': 'cltbld', 05:33:38 INFO - 'MAIL': '/var/mail/cltbld', 05:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:38 INFO - 'MOZ_NO_REMOTE': '1', 05:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:38 INFO - 'NO_EM_RESTART': '1', 05:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:38 INFO - 'PWD': '/builds/slave/test', 05:33:38 INFO - 'SHELL': '/bin/bash', 05:33:38 INFO - 'SHLVL': '1', 05:33:38 INFO - 'TERM': 'linux', 05:33:38 INFO - 'TMOUT': '86400', 05:33:38 INFO - 'USER': 'cltbld', 05:33:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:38 INFO - '_': '/tools/buildbot/bin/python'} 05:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:41 INFO - Downloading docopt-0.6.1.tar.gz 05:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:41 INFO - Running setup.py install for blobuploader 05:33:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:41 INFO - Running setup.py install for requests 05:33:41 INFO - Running setup.py install for docopt 05:33:41 INFO - Successfully installed blobuploader requests docopt 05:33:41 INFO - Cleaning up... 05:33:41 INFO - Return code: 0 05:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:41 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:41 INFO - Using env: {'DISPLAY': ':0', 05:33:41 INFO - 'HOME': '/home/cltbld', 05:33:41 INFO - 'LANG': 'en_US.UTF-8', 05:33:41 INFO - 'LANGUAGE': 'en_US:en', 05:33:41 INFO - 'LOGNAME': 'cltbld', 05:33:41 INFO - 'MAIL': '/var/mail/cltbld', 05:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:41 INFO - 'MOZ_NO_REMOTE': '1', 05:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:41 INFO - 'NO_EM_RESTART': '1', 05:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:41 INFO - 'PWD': '/builds/slave/test', 05:33:41 INFO - 'SHELL': '/bin/bash', 05:33:41 INFO - 'SHLVL': '1', 05:33:41 INFO - 'TERM': 'linux', 05:33:41 INFO - 'TMOUT': '86400', 05:33:41 INFO - 'USER': 'cltbld', 05:33:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:41 INFO - '_': '/tools/buildbot/bin/python'} 05:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:41 INFO - Running setup.py (path:/tmp/pip-ByjiV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:42 INFO - Running setup.py (path:/tmp/pip-VqBkEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:42 INFO - Running setup.py (path:/tmp/pip-h_Nncu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:42 INFO - Running setup.py (path:/tmp/pip-O684ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:42 INFO - Running setup.py (path:/tmp/pip-nsRuQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:42 INFO - Running setup.py (path:/tmp/pip-LCAr9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:42 INFO - Running setup.py (path:/tmp/pip-USQBcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:42 INFO - Running setup.py (path:/tmp/pip-37wvqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:42 INFO - Running setup.py (path:/tmp/pip-cJtaZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:42 INFO - Running setup.py (path:/tmp/pip-daEfkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:42 INFO - Running setup.py (path:/tmp/pip-OljZxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:42 INFO - Running setup.py (path:/tmp/pip-rqewTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:42 INFO - Running setup.py (path:/tmp/pip-dpWBOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:42 INFO - Running setup.py (path:/tmp/pip-l9pwOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:42 INFO - Running setup.py (path:/tmp/pip-IK3JNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:43 INFO - Running setup.py (path:/tmp/pip-s_ox28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:43 INFO - Running setup.py (path:/tmp/pip-8fuTBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:43 INFO - Running setup.py install for manifestparser 05:33:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Running setup.py install for mozcrash 05:33:43 INFO - Running setup.py install for mozdebug 05:33:43 INFO - Running setup.py install for mozdevice 05:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Running setup.py install for mozfile 05:33:43 INFO - Running setup.py install for mozhttpd 05:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Running setup.py install for mozinfo 05:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Running setup.py install for mozInstall 05:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Running setup.py install for mozleak 05:33:44 INFO - Running setup.py install for mozlog 05:33:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Running setup.py install for moznetwork 05:33:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Running setup.py install for mozprocess 05:33:44 INFO - Running setup.py install for mozprofile 05:33:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Running setup.py install for mozrunner 05:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Running setup.py install for mozscreenshot 05:33:44 INFO - Running setup.py install for moztest 05:33:44 INFO - Running setup.py install for mozversion 05:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:44 INFO - Cleaning up... 05:33:44 INFO - Return code: 0 05:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:45 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:45 INFO - Using env: {'DISPLAY': ':0', 05:33:45 INFO - 'HOME': '/home/cltbld', 05:33:45 INFO - 'LANG': 'en_US.UTF-8', 05:33:45 INFO - 'LANGUAGE': 'en_US:en', 05:33:45 INFO - 'LOGNAME': 'cltbld', 05:33:45 INFO - 'MAIL': '/var/mail/cltbld', 05:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:45 INFO - 'MOZ_NO_REMOTE': '1', 05:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:45 INFO - 'NO_EM_RESTART': '1', 05:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:45 INFO - 'PWD': '/builds/slave/test', 05:33:45 INFO - 'SHELL': '/bin/bash', 05:33:45 INFO - 'SHLVL': '1', 05:33:45 INFO - 'TERM': 'linux', 05:33:45 INFO - 'TMOUT': '86400', 05:33:45 INFO - 'USER': 'cltbld', 05:33:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:45 INFO - '_': '/tools/buildbot/bin/python'} 05:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:45 INFO - Running setup.py (path:/tmp/pip-14N5Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:45 INFO - Running setup.py (path:/tmp/pip-DyTNPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:45 INFO - Running setup.py (path:/tmp/pip-olk3iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:45 INFO - Running setup.py (path:/tmp/pip-fYmf5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:45 INFO - Running setup.py (path:/tmp/pip-9laTGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:45 INFO - Running setup.py (path:/tmp/pip-ddtE5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:45 INFO - Running setup.py (path:/tmp/pip-_Mybzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:45 INFO - Running setup.py (path:/tmp/pip-pgAKaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:45 INFO - Running setup.py (path:/tmp/pip-Evt1b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:45 INFO - Running setup.py (path:/tmp/pip-Qh4RuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:45 INFO - Running setup.py (path:/tmp/pip-ru7B8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:46 INFO - Running setup.py (path:/tmp/pip-bvhALZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:46 INFO - Running setup.py (path:/tmp/pip-vZpEKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:46 INFO - Running setup.py (path:/tmp/pip-CToOy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:46 INFO - Running setup.py (path:/tmp/pip-ar8huv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:46 INFO - Running setup.py (path:/tmp/pip-i48uYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:46 INFO - Running setup.py (path:/tmp/pip-UaH7UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:48 INFO - Downloading blessings-1.6.tar.gz 05:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:48 INFO - Installing collected packages: blessings 05:33:48 INFO - Running setup.py install for blessings 05:33:48 INFO - Successfully installed blessings 05:33:48 INFO - Cleaning up... 05:33:48 INFO - Return code: 0 05:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:48 INFO - Reading from file tmpfile_stdout 05:33:48 INFO - Current package versions: 05:33:48 INFO - argparse == 1.2.1 05:33:48 INFO - blessings == 1.6 05:33:48 INFO - blobuploader == 1.2.4 05:33:48 INFO - docopt == 0.6.1 05:33:48 INFO - functools32 == 3.2.3-2 05:33:48 INFO - jsonschema == 2.5.1 05:33:48 INFO - manifestparser == 1.1 05:33:48 INFO - mozInstall == 1.12 05:33:48 INFO - mozcrash == 0.17 05:33:48 INFO - mozdebug == 0.1 05:33:48 INFO - mozdevice == 0.48 05:33:48 INFO - mozfile == 1.2 05:33:48 INFO - mozhttpd == 0.7 05:33:48 INFO - mozinfo == 0.9 05:33:48 INFO - mozleak == 0.1 05:33:48 INFO - mozlog == 3.3 05:33:48 INFO - moznetwork == 0.27 05:33:48 INFO - mozprocess == 0.23 05:33:48 INFO - mozprofile == 0.28 05:33:48 INFO - mozrunner == 6.12 05:33:48 INFO - mozscreenshot == 0.1 05:33:48 INFO - mozsystemmonitor == 0.3 05:33:48 INFO - moztest == 0.7 05:33:48 INFO - mozversion == 1.4 05:33:48 INFO - psutil == 3.1.1 05:33:48 INFO - requests == 1.2.3 05:33:48 INFO - wsgiref == 0.1.2 05:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:48 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:48 INFO - Using env: {'DISPLAY': ':0', 05:33:48 INFO - 'HOME': '/home/cltbld', 05:33:48 INFO - 'LANG': 'en_US.UTF-8', 05:33:48 INFO - 'LANGUAGE': 'en_US:en', 05:33:48 INFO - 'LOGNAME': 'cltbld', 05:33:48 INFO - 'MAIL': '/var/mail/cltbld', 05:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:48 INFO - 'MOZ_NO_REMOTE': '1', 05:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:48 INFO - 'NO_EM_RESTART': '1', 05:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:48 INFO - 'PWD': '/builds/slave/test', 05:33:48 INFO - 'SHELL': '/bin/bash', 05:33:48 INFO - 'SHLVL': '1', 05:33:48 INFO - 'TERM': 'linux', 05:33:48 INFO - 'TMOUT': '86400', 05:33:48 INFO - 'USER': 'cltbld', 05:33:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:48 INFO - '_': '/tools/buildbot/bin/python'} 05:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:49 INFO - Cleaning up... 05:33:49 INFO - Return code: 0 05:33:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:49 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 0xf35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, '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': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:33:49 INFO - Using env: {'DISPLAY': ':0', 05:33:49 INFO - 'HOME': '/home/cltbld', 05:33:49 INFO - 'LANG': 'en_US.UTF-8', 05:33:49 INFO - 'LANGUAGE': 'en_US:en', 05:33:49 INFO - 'LOGNAME': 'cltbld', 05:33:49 INFO - 'MAIL': '/var/mail/cltbld', 05:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:49 INFO - 'MOZ_NO_REMOTE': '1', 05:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:49 INFO - 'NO_EM_RESTART': '1', 05:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:49 INFO - 'PWD': '/builds/slave/test', 05:33:49 INFO - 'SHELL': '/bin/bash', 05:33:49 INFO - 'SHLVL': '1', 05:33:49 INFO - 'TERM': 'linux', 05:33:49 INFO - 'TMOUT': '86400', 05:33:49 INFO - 'USER': 'cltbld', 05:33:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:49 INFO - '_': '/tools/buildbot/bin/python'} 05:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:49 INFO - Cleaning up... 05:33:49 INFO - Return code: 0 05:33:49 INFO - Running post-action listener: _resource_record_post_action 05:33:49 INFO - Running post-action listener: _start_resource_monitoring 05:33:49 INFO - Starting resource monitoring. 05:33:49 INFO - [mozharness: 2016-10-31 12:33:49.327675Z] Finished create-virtualenv step (success) 05:33:49 INFO - [mozharness: 2016-10-31 12:33:49.328148Z] Running install step. 05:33:49 INFO - Running pre-action listener: _resource_record_pre_action 05:33:49 INFO - Running main action method: install 05:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:49 INFO - Reading from file tmpfile_stdout 05:33:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:49 INFO - Reading from file tmpfile_stdout 05:33:49 INFO - Output received: 05:33:49 INFO - Usage: mozinstall [options] installer 05:33:49 INFO - Options: 05:33:49 INFO - -h, --help show this help message and exit 05:33:49 INFO - -d DEST, --destination=DEST 05:33:49 INFO - Directory to install application into. [default: 05:33:49 INFO - "/builds/slave/test"] 05:33:49 INFO - --app=APP Application being installed. [default: firefox] 05:33:49 INFO - mkdir: /builds/slave/test/build/application 05:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:34:03 INFO - Reading from file tmpfile_stdout 05:34:03 INFO - Output received: 05:34:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:34:03 INFO - Running post-action listener: _resource_record_post_action 05:34:03 INFO - [mozharness: 2016-10-31 12:34:03.133032Z] Finished install step (success) 05:34:03 INFO - [mozharness: 2016-10-31 12:34:03.133310Z] Running run-tests step. 05:34:03 INFO - Running pre-action listener: _resource_record_pre_action 05:34:03 INFO - Running main action method: run_tests 05:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:03 INFO - Python 2.7.3 05:34:03 INFO - Return code: 0 05:34:03 INFO - grabbing minidump binary from tooltool 05:34: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')]} 05:34:03 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f3570>, '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 0x11f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:34:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:34:03 INFO - Calling ['/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'] with output_timeout 600 05:34:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:03 INFO - Return code: 0 05:34:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:34:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:34:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:34:03 INFO - Using env: {'DISPLAY': ':0', 05:34:03 INFO - 'HOME': '/home/cltbld', 05:34:03 INFO - 'LANG': 'en_US.UTF-8', 05:34:03 INFO - 'LANGUAGE': 'en_US:en', 05:34:03 INFO - 'LOGNAME': 'cltbld', 05:34:03 INFO - 'MAIL': '/var/mail/cltbld', 05:34:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:03 INFO - 'MOZ_NO_REMOTE': '1', 05:34:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:03 INFO - 'NO_EM_RESTART': '1', 05:34:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:03 INFO - 'PWD': '/builds/slave/test', 05:34:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:03 INFO - 'SHELL': '/bin/bash', 05:34:03 INFO - 'SHLVL': '1', 05:34:03 INFO - 'TERM': 'linux', 05:34:03 INFO - 'TMOUT': '86400', 05:34:03 INFO - 'USER': 'cltbld', 05:34:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424', 05:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:03 INFO - '_': '/tools/buildbot/bin/python'} 05:34:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:34:03 INFO - mozversion application_buildid: 20161031022521 05:34:03 INFO - mozversion application_changeset: 72abda1585a882494a9396a62648fe5c3132993b 05:34:03 INFO - mozversion application_display_name: Firefox 05:34:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:03 INFO - mozversion application_name: Firefox 05:34:03 INFO - mozversion application_remotingname: firefox 05:34:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:34:03 INFO - mozversion application_vendor: Mozilla 05:34:03 INFO - mozversion application_version: 50.0 05:34:03 INFO - mozversion platform_buildid: 20161031022521 05:34:03 INFO - mozversion platform_changeset: 72abda1585a882494a9396a62648fe5c3132993b 05:34:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:34:03 INFO - mozversion platform_version: 50.0 05:34:03 INFO - using testdate: 1477917243 05:34:03 INFO - actual date: 1477917243 05:34:03 INFO - starting webserver on 'localhost:38181' 05:34:03 INFO - SUITE-START | Running 2 tests 05:34:03 INFO - TEST-START | dromaeo_css 05:34:03 INFO - operating with platform_type : linux_ 05:34:03 INFO - Initialising browser for dromaeo_css test... 05:34:03 INFO - TEST-INFO | started process 15951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQSYQUE/profile http://localhost:38181/getInfo.html) 05:34:07 INFO - PROCESS | 15951 | __metrics Screen width/height:1600/1200 05:34:07 INFO - PROCESS | 15951 | colorDepth:24 05:34:07 INFO - PROCESS | 15951 | Browser inner width/height: 1024/697 05:34:07 INFO - PROCESS | 15951 | __metrics 05:34:08 ERROR - PROCESS | 15951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:34:09 INFO - TEST-INFO | 15951: exit 0 05:34:09 INFO - Browser initialized. 05:34:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:09 INFO - TEST-INFO | started process 16080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQSYQUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:21 INFO - PROCESS | 16080 | RSS: Main: 150286336 05:34:21 INFO - PROCESS | 16080 | 05:35:10 INFO - PROCESS | 16080 | 1477917310583 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:37:19 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38181/tests/dromaeo/cssquery-ext.html) 05:37:20 INFO - PROCESS | 16080 | RSS: Main: 159326208 05:37:20 INFO - PROCESS | 16080 | 05:40:22 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-ext.html (next: http://localhost:38181/tests/dromaeo/cssquery-jquery.html) 05:40:22 INFO - PROCESS | 16080 | RSS: Main: 155750400 05:40:22 INFO - PROCESS | 16080 | 05:43:24 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38181/tests/dromaeo/cssquery-mootools.html) 05:43:25 INFO - PROCESS | 16080 | RSS: Main: 155066368 05:43:25 INFO - PROCESS | 16080 | 05:46:27 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38181/tests/dromaeo/cssquery-prototype.html) 05:46:27 INFO - PROCESS | 16080 | RSS: Main: 157028352 05:46:27 INFO - PROCESS | 16080 | 05:49:30 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38181/tests/dromaeo/cssquery-yui.html) 05:49:30 INFO - PROCESS | 16080 | RSS: Main: 158138368 05:49:30 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | Cycle 1(1): loaded http://localhost:38181/tests/dromaeo/cssquery-yui.html (next: http://localhost:38181/tests/dromaeo/cssquery-dojo.html) 05:52:33 INFO - PROCESS | 16080 | RSS: Main: 157970432 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | __start_tp_report 05:52:33 INFO - PROCESS | 16080 | _x_x_mozilla_page_load 05:52:33 INFO - PROCESS | 16080 | _x_x_mozilla_page_load_details 05:52:33 INFO - PROCESS | 16080 | |i|pagename|runs| 05:52:33 INFO - PROCESS | 16080 | |0;dojo.html;3333.999800059982;3356.0770788033287;3361.1093060339012;3384.2216290253255;3392.1858753899073;5827.941720582793;5848.356680765123;5914.64512129272;5926.762929482821;5930.940690593093;5828.504577110951;5872.853178670535;5874.735636896339;5877.059670452729;5884.235049443566;5294.841154765363;5367.865803354928;5377.220303056055;5389.622726409153;5416.756245968941;5410.783568657269;5418.078926582491;5419.349678038641;5421.159720243349;5421.295231619883;5222.869428264305;5291.074062039147;5382.434844341346;5383.569314454834;5418.729063546826;5349.3045904032615;5361.0618141825025;5378.515933565998;5416.945830541703;5494.81861399801;5277.419483856811;5341.545968592674;5353.544948679367;5369.060414427459;5380.677159370412;5635.239242702224;5752.0796672532615;5874.3244526879525;5943.167956486095;5958.285005799332;6178.38216178383;6294.181756371689;6295.96852015737;6309.0536419536975;6314.273858506284;6329.87340253197;6352.936470635327;6354.2692590352235;6367.044943258548;6370.235571731422;5694.857628559278;5792.565557583198;5918.023526118229;5921;5923.970380148115;6334.651594162273;6457.580257283262;6469.45009674183;6473.2232132144445;6475.384838440341;6134.38656134383;6172.4136207060255;6192.752289908353;6205.100260462208;6209.348018458088;6023.096535519707;6160.845978850564;6230.034344676583;6308.179936608211;6311.463525600376;6176.505879529627;6271.843203919939;6295.559310848196;6322.272938612118;6341.048842673544;6266.248050234001;6299.055141728777;6308.810735677937;6314.968425157845;6328.873422531616;4640.605548528413;4711.882202944886;4792.800855147027;4800.567948884617;4849.636277279218;4176.770277634699;4273.615374616237;4281.486221653421;4291.163223171452;4297.05464797744;6033.12519684652;6040.154378387029;6042.3655516170165;6058.606190597597;6067.271927368744;6032.969835150796;6126.30393285589;6348.396902294275;6354.459870911024;6356.110144579762;5959.28488581373;5980.22257106582;6020.036794112921;6030.065339872239;6070.878582428327;5335.519803217729;5349.358077030781;5379.085555455582;5384.730763461811;5410.945890541123;6297.4017468340435;6442.291347951722;6482.319356467598;6499.642519661369;6530.216374035146;6280.057991301342;6285.088662144055;6287.717052732546;6296.842578935563;6317.241930968313;6456.806295811133;6499.155109835691;6500.349965003462;6511.186101737283;6544.738210471528;5891.3224979126235;6066.666333351708;6073.180120683828;6151.138840562236;6191.907121393273;6272.310045895039;6283.49732021428;6296.961001434712;6303.9684801575695;6310.463610593151;6151.96924015377;6171.537134715004;6175.9073613894925;6177.752889884354;6188.319284878569;5934.287885453773;6034.939650603438;6036.849078773066;6156.26124865019;6170.722317495633;6098;6111.834843226386;6129.785457508966;6131.202943617302;6144.477719393902;6119.465329991759;6139.6009259398;6186.969065154645;6189.907151392823;6201.441870231701;5873.324567674772;5906.40935906406;5967.104934259895;6036.817404228457;6072.332043475302 05:52:33 INFO - PROCESS | 16080 | |1;ext.html;586.2349633727986;630.2027934662651;655.3086493749092;658.9769358072468;717.1107826295395;42458.575414245846;47288.05423891529;47313.52686473134;47408.28887566689;47512.762436187855;48283.275750863766;48976.75511622437;48982.755086224606;49041.264381034314;49147.26279105807;9132.95433522833;9303.162715355616;9317.394369366004;9333.346665733401;9336.393134446273;9173.816523669522;9237.214836738885;9257.120573545537;9265.166135047844;9280.211182049534;9315.161635452809;9325.347225694204;9337.579808908615;9348.298877584175;9371.578278977428;9228.16946474817;9263.444193348387;9280.118388753057;9284.257259419264;9290.860637090449;9190.908090919072;9191.678291259774;9256.6297348106;9257.583408746623;9263.768405789842;44464.110717785785;44606.33090503645;44758;44906.32640510395;44961;3648.872289469856;3948.960510394888;4012.4583181270445;4210.179015092058;4386.385905973167;35047.12382190466;35279.4708079379;35319.64680353189;35590.46614300788;35669.64330356689;4676.392069031004;4845.781939812717;4857.951420485785;4861.465238823726;4934.161192597231;381502;387949;389633;545176.999999996;555568;68412.3158768406;68637.65681171662;68641.31358686449;68794;68952;41274.79362603168;74727.62636186785;75125.62437187778;75324.24675753173;75462.6226868873;17452.389166379115;18152.183151758203;18171.818281817275;18191.63616727658;18214.45356639303;13741.793873091912;14011.299435028208;14049.086809357359;14076.366563504667;14570.927145364418;21025.68461473079;21116.89441552813;21271.78728212729;21274.680879786814;21341.46646333823;7335.926640733631;7426.331630153312;7580.241975802486;7587.62061896914;7697.648745448196;1063.4682658670665;1070.4059247117925;1102.1640414007848;1148.3798748675622;1182.395445587907;34441.31117377638;34571.82714086414;34875.12812179665;35058.474122888176;35117.47323790145;1147.971300717472;1164.6913567904512;1204.4700331853956;1218.9882397609963;1223.8347823043953;17762.822371776376;18424.907875460536;18447.16987735555;18500.16749246287;18640.440786776417;547308;548215;548420;551608;554561;67629;68722.65638671875;68914;68924.6553767238;69042.30957690459;1416.192770121021;1442.9567112986626;1450.6881020580627;1454.41096355976;1469.169918995764;32684.50973235356;34134.65865341315;34594.13514662053;34780.65219347774;34784.82607587047;60044.39955600388;60098.39901600928;60508.69745651243;60600.69699651474;60758;469524;473136;473285;473366;473749;32708.34583308368;33039.50440743343;33078;33124.834375828934;33392.49911251382;54741.178882316;55474;55836.72081639566;56712.43287567236;57401;46248;47622.09511619635;48149.27776083432;48368.27447588219;49096.263556045975;46715.29927051165;47806;48048.759756201;48637.27044094412;49019;39418.802905985285;45279;45714.31428528641;46269;47569.762151189025;38006.2398752029;39162;39278.6072139275;40001.59998400095;40499.797501012305;30626.693733062384;30708.692913070583;30734.231644209074;30999.535006974464;31224.687753123086 05:52:33 INFO - PROCESS | 16080 | |2;jquery.html;426.37748886625525;426.5940097848135;439.18092757008174;441.08129636083044;449.8448035427778;18423.263069477205;20088.196472141117;20286.087126079325;20655.586888262264;21242.25652102177;16506.587335316624;18317.542061448472;19625.565526032922;19670;19677.409677709657;5961.463468287853;6140.631562106266;6142.4778893793855;6147.938520614782;6182.938170618304;5756.913646295309;5990.281166260033;6013.278406591194;6025.517958563326;6038.882806680778;6048.727807248684;6090;6095.238095238095;6102.481289090432;6163;6493.902591461132;6504.934950650504;6563.57336773113;6573.30980247072;6576.605403675747;5278.287431196778;5486.396496385394;5531.419200983919;5607.439256074401;5617.466340697627;14678.119312841263;14855.851441485554;15194.392224311014;15323.693526129526;15362.692746145127;2387.78509934105;2451.252368027751;2461.88921498533;2483.3295010347106;2561.078011915709;10844.457777111193;10939.945300273528;11025.889741102566;11108.222424430292;12758.553450629184;1962.3033822992918;1999.6700544410155;2046.1508473983279;2103.6949642301934;2128.3934078787624;87252.56373718091;87268.56365718195;87904.56047719784;88927.55536222341;89517.55241223752;11513.251638643462;11547.76904461906;11751.588694395827;11872.762544749057;11906.226095303777;16879.07165105931;16888.662226755398;16919.492415227563;16971.91514042422;16983.83016169847;8505.350636956906;8684.826303473896;8783.868241976375;8913.969250454747;8963.596638151299;8415.200555947175;8547.57262136903;8580;8697.521636310064;8764.56177191138;5111.897762044739;5113.105206588906;5162.638615296968;5179.585633149339;5258.132408152612;2065.896705164736;2093.916243350249;2168.4036889855415;2174.2716190076185;2204.8787316697735;941.4680705401427;1045.717656232813;1057.2070946789909;1061.3207547169818;1084.3060441317564;20019.199232030845;20251.797482025286;20566.897165514376;20799.68800467994;20865.37403877886;1094.316052467208;1097.4951522299832;1102.9338239705644;1111.4776055254179;1113.3486910157487;10986.450677466095;11364.545418183345;11445.313281202987;11493.885061149449;11522.711932201762;407038;409563;414286;549541;558264;86284;96801.515992421;97675.51162244285;100998.49500752449;101643.4917825421;1054.778496515725;1061.9097376723066;1090.051655060087;1095.6548687163677;1107.2692023264767;17493.16321786245;17700.46898593044;17909.552261193054;18091.457256282334;18249;42041.36937945872;44260.11479770322;44677.329840051774;44734.55265447304;44812.551874480836;59710.40289597048;64683.35316646961;65005.67497162673;66165.33834661591;68362.31637683559;9189.310801690033;9404.52977351116;9466.52667366615;9474.14732674035;9627.085426884434;10660.413677247825;14073.718525629225;14220.36008379646;14409.13545187292;14631.195284259467;11021.83467248008;11570.652880413601;11603.767924641292;11765.64695060079;11852.229605075643;12268.631941041784;12371;12431.12982091281;12566;12737.87262127367;5965.70171491415;10032.398056116657;11680.591179308683;11761.705957351134;11772.293662380285;9223.723288301362;9353.39202951806;9365.438073715599;9383.671571494964;9634.084761947604;9015.819683606422;11439.59961401347;11786.646400607995;11807.822882656596;12031.879681203425 05:52:33 INFO - PROCESS | 16080 | |3;mootools.html;1522.2464879884458;1551.7051760165568;1723.517415123765;1841.640880028395;1871.457277389557;8567.828643427129;9322.20761235295;9431.339806213567;10089.747756306087;10096.495175241236;9511.857322140173;9918.404895706262;9918.85121723173;9932;9933.751656208598;2506.6114752213434;2533.783783783785;2536.6068259419726;2536.606825941982;2537.6954765428172;2436.5492383908945;2519.1560827122935;2521.2940376694555;2521.8612976286295;2524.469861329123;2475.579151544233;2498.1631153563576;2538;2541.8474891506476;2547.5669136246884;2424.3696638873844;2465.5315490056832;2477.9840265491152;2483.155727052793;2483.8758062096913;2450.1791899713617;2458.1150785717127;2459.3113928099983;2459.5818710819203;2504.1235567551394;9805.90194098057;9818;9927.851082233772;9932;9942.900570994341;5747.1666608341975;5866.384029676865;5871.706414679249;5874.353821079678;5881.529477641779;3481.35594914939;3533.9293214135573;3586.103474131467;3600.891973240807;3627.6009638939695;1103.6578660615235;1140.3841925360296;1146.3637681086993;1150.3155622404656;1161.3322339654733;13984.580462586138;14059.945504087133;14072.92963535186;14095.22476263805;14111.929440352835;4743.055347307587;4840.1287768201355;4899.58353539946;4938.308636790852;5073.264376665363;11647.6505704829;11740.295582265091;11755.647330580096;11784.88215117855;11811.704707382212;5760.452756988079;5774.0761478163295;5778.3643799182055;5784.913226301609;5790.10253410722;4594.563516465931;5182.896342073137;5285.497877701612;5305.151175811929;5351.063563876306;4490.685652004328;4491.079328737601;4569.680122391401;4586.3579098926175;4606.170889239969;1402.9088109272864;1415.9929200354138;1428.2073449235565;1428.8428272889973;1431.7279716853764;977.941323520591;1012.2559918459926;1076.6016573867719;1082.2965072702807;1086.5056399338441;6500.544961852719;6690.19717633887;6857.142857142857;6868.347506986828;6895.310468953065;482.6549017452538;484.4549881383444;499.0567826807337;500.0524007006775;501.77670936432935;4463.352813841975;4574.931376029363;4642.117997580449;4703.529647035269;4705.341252224691;11834.704132396759;12077.51689932393;12090.274583525017;12209.755804883853;12219.327936963553;12063.095267854946;12075.637730868088;12083.45624446902;12101.455434505293;12126.878731212752;8981.685641002534;9146.86279705805;9168;9174.633014679339;9205.401648892801;6657.700403481758;6715.429188518835;6722.361375669304;6728.192616886005;6836.897446538405;10928.235023548594;11006;11251.324920504796;11263.605773797877;11299.491522881326;11273.830892536454;11410.372429516456;11422.800605936258;11513.597024104116;11574.421278936188;7929.167437418988;8291.129431409616;8534.82930341402;8565.700200492953;8674;9561.474118923248;9633.08485693858;9717.465539395118;9717.708468745948;9721;8351.20663536963;8365.874511882448;8475;8628.39601227908;8650.264727498234;8307.252347288773;8313.542755148283;8507.744767656981;8593.011803642661;8615.22462978335;7521.4734968551675;7817.0619525657285;7839.25527074927;7860.253275939005;7884.093329266978;5665.3201615806365;5695.544356451557;5817.214676018683;5910.645361278337;5919.674417906885;5845.561582881216;5885.08781138907;5890.852728681817;5986.102084687158;6028.216331876828 05:52:33 INFO - PROCESS | 16080 | |4;prototype.html;359.57749644168103;365.7001258967646;367.46166865541977;368.9575698794638;370.0711214850726;5822.272215973004;5846.6199697019665;5849.853753656161;5866.120081987709;5872.236609240793;5347.946520534793;5733.283339582552;5750.453706897849;5756.251687280647;5780.248567686205;4469.508354081048;4472.172648060119;4484.376639665799;4487;4487.730736155825;4471.306947423154;4495.3931219285305;4497.370368148462;4506.256467682829;4511.52628973958;4380.8685739427865;4463.375127482155;4466.932996005046;4472.508024117345;4477.283634618461;4425.7565833879125;4448.2207117153075;4450.621697155713;4454.665900057476;4465.68740188187;3916.3342231820375;3927.8821635350987;3932.997085743117;3937.9015524611827;3968.4047392891007;5463.344398672145;5564.387917329091;5569.498745112919;5587.552995760329;5605.215269862222;5050.671706339113;5097.388313402378;5167.612429067797;5176.870578235575;5222.503862133091;6045.72794224261;6059.7273122709585;6059.878802423971;6070.8785824283705;6071.878562428727;4193.203291374629;4394.670399720002;4401.06353204589;4407.140607581523;4467.977660111711;6094.9390506094815;6279.466245369149;6301.8109456716375;6333;6355.8411039723915;4460.50934397216;4466.3523789050405;4466.709663871838;4471.697076005859;4473.910521789611;4539.84110556129;4563.498015218323;4567.862964111082;4574.124608910331;4580.7938642761155;4948.653594248368;5201;5217.50433708797;5239.685618862881;5264.6314757966575;6014.669193194329;6046.3349031606485;6049.304330002018;6065.848353791191;6121.602095863755;1538.8153421589482;1551.7517197248385;1569.968600627981;1570.9135997520018;1571.5128310223868;960.2270172511056;994.2990191914682;996.5948013301355;1006.4464544500496;1013.8986101389802;5203.5576975957465;5205.9219111713355;5226.503482169188;5246.685198888079;5248.947510524846;5417.512423881791;5437.945620543744;5450.373207081237;5487.341519017664;5524.3370795504;4917.385326834145;5165.483451654804;5168.844934651891;5219.660722053054;5226.268322434862;2916.3292442737866;2922.547005214195;2935.251510864716;2940.5001149804584;2948.3071478202605;5601.971990140023;5617.747201375948;5640.435956404327;5650.519705825051;5675.843179591811;5185.729496273361;5494.2857428534835;5564.693941833238;5578.8047418340975;5590.8043218487155;5543.334799823966;5585.916211256835;5588.944110558924;5626;5637.9718101409235;5104.69371837691;5437.199842081252;5461.563074954073;5467.289252397163;5505.889882202414;5359.330083739533;5382.327209098863;5441.7279136043835;5475.206095116266;5480.205370221375;6210.726801005873;6484.870302594016;6508.884612500861;6515.514199903029;6521.82607130702;4458.598726114666;4473.888152796076;4479.17135329965;4479.619232365155;4493.1238408511335;6139.57023008403;6301.338359472189;6301.936980630318;6321.367863213642;6332.52506062038;6117.663528505975;6118.143459915526;6121.387861213843;6143.6928153593035;6147.969260153671;5970.283565971938;6147.938520614915;6151.138840562415;6178.66017369049;6184.938150618436;6051.092336149437;6100.420460056288;6112.938870611237;6127.601705889103;6143.262808463013;6225.408586184305;6231.470325022243;6244.687765611792;6247.5939063960695;6260.186175797299;5771.9134212986;5986.580939334205;6021.638701677914;6033.366496517802;6034.78878239277 05:52:33 INFO - PROCESS | 16080 | |5;yui.html;782.6830133795811;810.4934415990007;864.7794812322857;876.2289185516746;879.4591326334304;14630.853691463082;15459.613509662264;15511.224438778045;15531.922340388297;15568.922155389222;14262.50081247154;14367.563243675628;14463.421463141462;14472.493462728806;14481.058731182466;693.2963042511855;850.7235148576707;863.8445079885618;865.3769286114019;868.4181598329135;875.9124087591222;877.4340550345056;878.767126711422;879.4723166100321;880.2561835249204;918.9264858811279;919.5586118663045;920.6639576554576;921.0237148622448;925.3846192282124;911.1890417528405;912.0514664748654;913.6071489259616;914.2731528434911;915.5651065743785;662.6918482905423;669.5714742564762;670.5641333133502;673.6631684157921;676.4757313082351;14198.290085495684;14200.431982720678;14252.572422827332;14253.501127460593;14350.856491435057;14851.257437128208;14864;14865.628359291104;15069.246537673072;15196.392144314214;11841.703957401134;12122.939385303105;12136.696582585419;12247.203931744409;12253.693657658541;4054.249963756685;4060.5736397678115;4112.650424713873;4145.129522800215;4162.354835000579;87356.5632171835;87401;87642.12357876467;88607;88679;11372.203945723886;11506.654800356002;11550.768984620261;11618.186726929203;11724.58963936258;21400;21531.569368612854;21670.566588668138;21677.78322216789;21815;8576.271016963503;8629.09394513567;8666.739997800076;8862.335324850663;8876.778080547909;5024.371953505812;5144.61415393847;5145.434002259748;5149.2276158576515;5202.583793296527;3648.945265821015;3760.4735337052834;3786.753860999026;3808.809559522013;3833.1950290438763;649.1625802714445;651.3811878715239;651.563452486835;682.566570227899;688.6694386694314;685.869684759894;731.5683746589538;759.7644730133676;776.9006855299688;808.5957021489255;10074.949625251973;10215.897841021644;10271.015709317735;10400.895991040145;10620.309679870783;719.9208087110413;753.7211231844253;767.4321002458141;783.2559068884583;784.196198896136;4812.735299558558;5095.923561146586;5097.158968770185;5117.309163262912;5119.436861945183;76979.23020769833;77916.22083779203;82703;131238;133887;67661.66169169123;68913;82893.17106828975;108789;116213;60719.089213662715;62575.37424625696;97211.51394243125;99394;99497;8986.86519702192;9331.906680933103;9840;10336.534855931352;10543.736406589896;55462.445375547344;55476.72261638666;56035.43964560302;56052.71973640106;57967.71016145061;80385;80930.59534702289;81051.59474202592;82965.58517207376;83963.5801820987;13238.205707657571;13308.667283317995;13391.598252052454;13396.866031339561;13428.127171734197;14886.255687215813;14899.404023838924;14899.776503352676;14954.925225373803;15591.454299099478;13643.931780341034;14270.072445291024;14531.78202326987;14767.483138090116;14920.328585213909;13536.323183840572;14111.506097286545;14245.430182792987;14784.63038424048;15092.094474331576;13260.602181934557;13599.932000339935;13961.092528985584;14166.78749818733;14587.34356953961;10262.281640285408;10476.214283928888;10591.311564748266;10601.734956626146;10781.51483183243;10456.215783816093;10619.30974486656;10627.36235825853;10781.784364312827;10818.080463160404 05:52:33 INFO - PROCESS | 16080 | __end_tp_report 05:52:33 INFO - PROCESS | 16080 | __start_cc_report 05:52:33 INFO - PROCESS | 16080 | _x_x_mozilla_cycle_collect,331 05:52:33 INFO - PROCESS | 16080 | __end_cc_report 05:52:33 INFO - PROCESS | 16080 | __startTimestamp1477918353399__endTimestamp 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | ------- Summary: start ------- 05:52:33 INFO - PROCESS | 16080 | Number of tests: 6 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#0] dojo.html Cycles:165 Average:5834.61 Median:6058.61 stddev:666.45 (11.0%) stddev-sans-first:638.97 05:52:33 INFO - PROCESS | 16080 | Values: 3334.0 3356.1 3361.1 3384.2 3392.2 5827.9 5848.4 5914.6 5926.8 5930.9 5828.5 5872.9 5874.7 5877.1 5884.2 5294.8 5367.9 5377.2 5389.6 5416.8 5410.8 5418.1 5419.3 5421.2 5421.3 5222.9 5291.1 5382.4 5383.6 5418.7 5349.3 5361.1 5378.5 5416.9 5494.8 5277.4 5341.5 5353.5 5369.1 5380.7 5635.2 5752.1 5874.3 5943.2 5958.3 6178.4 6294.2 6296.0 6309.1 6314.3 6329.9 6352.9 6354.3 6367.0 6370.2 5694.9 5792.6 5918.0 5921.0 5924.0 6334.7 6457.6 6469.5 6473.2 6475.4 6134.4 6172.4 6192.8 6205.1 6209.3 6023.1 6160.8 6230.0 6308.2 6311.5 6176.5 6271.8 6295.6 6322.3 6341.0 6266.2 6299.1 6308.8 6315.0 6328.9 4640.6 4711.9 4792.8 4800.6 4849.6 4176.8 4273.6 4281.5 4291.2 4297.1 6033.1 6040.2 6042.4 6058.6 6067.3 6033.0 6126.3 6348.4 6354.5 6356.1 5959.3 5980.2 6020.0 6030.1 6070.9 5335.5 5349.4 5379.1 5384.7 5410.9 6297.4 6442.3 6482.3 6499.6 6530.2 6280.1 6285.1 6287.7 6296.8 6317.2 6456.8 6499.2 6500.3 6511.2 6544.7 5891.3 6066.7 6073.2 6151.1 6191.9 6272.3 6283.5 6297.0 6304.0 6310.5 6152.0 6171.5 6175.9 6177.8 6188.3 5934.3 6034.9 6036.8 6156.3 6170.7 6098.0 6111.8 6129.8 6131.2 6144.5 6119.5 6139.6 6187.0 6189.9 6201.4 5873.3 5906.4 5967.1 6036.8 6072.3 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#1] ext.html Cycles:180 Average:67337.02 Median:473210.50 stddev:131252.60 (27.7%) stddev-sans-first:131525.11 05:52:33 INFO - PROCESS | 16080 | Values: 586.2 630.2 655.3 659.0 717.1 42458.6 47288.1 47313.5 47408.3 47512.8 48283.3 48976.8 48982.8 49041.3 49147.3 9133.0 9303.2 9317.4 9333.3 9336.4 9173.8 9237.2 9257.1 9265.2 9280.2 9315.2 9325.3 9337.6 9348.3 9371.6 9228.2 9263.4 9280.1 9284.3 9290.9 9190.9 9191.7 9256.6 9257.6 9263.8 44464.1 44606.3 44758.0 44906.3 44961.0 3648.9 3949.0 4012.5 4210.2 4386.4 35047.1 35279.5 35319.6 35590.5 35669.6 4676.4 4845.8 4858.0 4861.5 4934.2 381502.0 387949.0 389633.0 545177.0 555568.0 68412.3 68637.7 68641.3 68794.0 68952.0 41274.8 74727.6 75125.6 75324.2 75462.6 17452.4 18152.2 18171.8 18191.6 18214.5 13741.8 14011.3 14049.1 14076.4 14570.9 21025.7 21116.9 21271.8 21274.7 21341.5 7335.9 7426.3 7580.2 7587.6 7697.6 1063.5 1070.4 1102.2 1148.4 1182.4 34441.3 34571.8 34875.1 35058.5 35117.5 1148.0 1164.7 1204.5 1219.0 1223.8 17762.8 18424.9 18447.2 18500.2 18640.4 547308.0 548215.0 548420.0 551608.0 554561.0 67629.0 68722.7 68914.0 68924.7 69042.3 1416.2 1443.0 1450.7 1454.4 1469.2 32684.5 34134.7 34594.1 34780.7 34784.8 60044.4 60098.4 60508.7 60600.7 60758.0 469524.0 473136.0 473285.0 473366.0 473749.0 32708.3 33039.5 33078.0 33124.8 33392.5 54741.2 55474.0 55836.7 56712.4 57401.0 46248.0 47622.1 48149.3 48368.3 49096.3 46715.3 47806.0 48048.8 48637.3 49019.0 39418.8 45279.0 45714.3 46269.0 47569.8 38006.2 39162.0 39278.6 40001.6 40499.8 30626.7 30708.7 30734.2 30999.5 31224.7 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#2] jquery.html Cycles:180 Average:29061.15 Median:2148.40 stddev:78449.16 (3651.5%) stddev-sans-first:78639.77 05:52:33 INFO - PROCESS | 16080 | Values: 426.4 426.6 439.2 441.1 449.8 18423.3 20088.2 20286.1 20655.6 21242.3 16506.6 18317.5 19625.6 19670.0 19677.4 5961.5 6140.6 6142.5 6147.9 6182.9 5756.9 5990.3 6013.3 6025.5 6038.9 6048.7 6090.0 6095.2 6102.5 6163.0 6493.9 6504.9 6563.6 6573.3 6576.6 5278.3 5486.4 5531.4 5607.4 5617.5 14678.1 14855.9 15194.4 15323.7 15362.7 2387.8 2451.3 2461.9 2483.3 2561.1 10844.5 10939.9 11025.9 11108.2 12758.6 1962.3 1999.7 2046.2 2103.7 2128.4 87252.6 87268.6 87904.6 88927.6 89517.6 11513.3 11547.8 11751.6 11872.8 11906.2 16879.1 16888.7 16919.5 16971.9 16983.8 8505.4 8684.8 8783.9 8914.0 8963.6 8415.2 8547.6 8580.0 8697.5 8764.6 5111.9 5113.1 5162.6 5179.6 5258.1 2065.9 2093.9 2168.4 2174.3 2204.9 941.5 1045.7 1057.2 1061.3 1084.3 20019.2 20251.8 20566.9 20799.7 20865.4 1094.3 1097.5 1102.9 1111.5 1113.3 10986.5 11364.5 11445.3 11493.9 11522.7 407038.0 409563.0 414286.0 549541.0 558264.0 86284.0 96801.5 97675.5 100998.5 101643.5 1054.8 1061.9 1090.1 1095.7 1107.3 17493.2 17700.5 17909.6 18091.5 18249.0 42041.4 44260.1 44677.3 44734.6 44812.6 59710.4 64683.4 65005.7 66165.3 68362.3 9189.3 9404.5 9466.5 9474.1 9627.1 10660.4 14073.7 14220.4 14409.1 14631.2 11021.8 11570.7 11603.8 11765.6 11852.2 12268.6 12371.0 12431.1 12566.0 12737.9 5965.7 10032.4 11680.6 11761.7 11772.3 9223.7 9353.4 9365.4 9383.7 9634.1 9015.8 11439.6 11786.6 11807.8 12031.9 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#3] mootools.html Cycles:180 Average:6435.44 Median:4704.44 stddev:3741.80 (79.5%) stddev-sans-first:3734.08 05:52:33 INFO - PROCESS | 16080 | Values: 1522.2 1551.7 1723.5 1841.6 1871.5 8567.8 9322.2 9431.3 10089.7 10096.5 9511.9 9918.4 9918.9 9932.0 9933.8 2506.6 2533.8 2536.6 2536.6 2537.7 2436.5 2519.2 2521.3 2521.9 2524.5 2475.6 2498.2 2538.0 2541.8 2547.6 2424.4 2465.5 2478.0 2483.2 2483.9 2450.2 2458.1 2459.3 2459.6 2504.1 9805.9 9818.0 9927.9 9932.0 9942.9 5747.2 5866.4 5871.7 5874.4 5881.5 3481.4 3533.9 3586.1 3600.9 3627.6 1103.7 1140.4 1146.4 1150.3 1161.3 13984.6 14059.9 14072.9 14095.2 14111.9 4743.1 4840.1 4899.6 4938.3 5073.3 11647.7 11740.3 11755.6 11784.9 11811.7 5760.5 5774.1 5778.4 5784.9 5790.1 4594.6 5182.9 5285.5 5305.2 5351.1 4490.7 4491.1 4569.7 4586.4 4606.2 1402.9 1416.0 1428.2 1428.8 1431.7 977.9 1012.3 1076.6 1082.3 1086.5 6500.5 6690.2 6857.1 6868.3 6895.3 482.7 484.5 499.1 500.1 501.8 4463.4 4574.9 4642.1 4703.5 4705.3 11834.7 12077.5 12090.3 12209.8 12219.3 12063.1 12075.6 12083.5 12101.5 12126.9 8981.7 9146.9 9168.0 9174.6 9205.4 6657.7 6715.4 6722.4 6728.2 6836.9 10928.2 11006.0 11251.3 11263.6 11299.5 11273.8 11410.4 11422.8 11513.6 11574.4 7929.2 8291.1 8534.8 8565.7 8674.0 9561.5 9633.1 9717.5 9717.7 9721.0 8351.2 8365.9 8475.0 8628.4 8650.3 8307.3 8313.5 8507.7 8593.0 8615.2 7521.5 7817.1 7839.3 7860.3 7884.1 5665.3 5695.5 5817.2 5910.6 5919.7 5845.6 5885.1 5890.9 5986.1 6028.2 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#4] prototype.html Cycles:180 Average:4944.92 Median:5446.05 stddev:1438.66 (26.4%) stddev-sans-first:1400.92 05:52:33 INFO - PROCESS | 16080 | Values: 359.6 365.7 367.5 369.0 370.1 5822.3 5846.6 5849.9 5866.1 5872.2 5347.9 5733.3 5750.5 5756.3 5780.2 4469.5 4472.2 4484.4 4487.0 4487.7 4471.3 4495.4 4497.4 4506.3 4511.5 4380.9 4463.4 4466.9 4472.5 4477.3 4425.8 4448.2 4450.6 4454.7 4465.7 3916.3 3927.9 3933.0 3937.9 3968.4 5463.3 5564.4 5569.5 5587.6 5605.2 5050.7 5097.4 5167.6 5176.9 5222.5 6045.7 6059.7 6059.9 6070.9 6071.9 4193.2 4394.7 4401.1 4407.1 4468.0 6094.9 6279.5 6301.8 6333.0 6355.8 4460.5 4466.4 4466.7 4471.7 4473.9 4539.8 4563.5 4567.9 4574.1 4580.8 4948.7 5201.0 5217.5 5239.7 5264.6 6014.7 6046.3 6049.3 6065.8 6121.6 1538.8 1551.8 1570.0 1570.9 1571.5 960.2 994.3 996.6 1006.4 1013.9 5203.6 5205.9 5226.5 5246.7 5248.9 5417.5 5437.9 5450.4 5487.3 5524.3 4917.4 5165.5 5168.8 5219.7 5226.3 2916.3 2922.5 2935.3 2940.5 2948.3 5602.0 5617.7 5640.4 5650.5 5675.8 5185.7 5494.3 5564.7 5578.8 5590.8 5543.3 5585.9 5588.9 5626.0 5638.0 5104.7 5437.2 5461.6 5467.3 5505.9 5359.3 5382.3 5441.7 5475.2 5480.2 6210.7 6484.9 6508.9 6515.5 6521.8 4458.6 4473.9 4479.2 4479.6 4493.1 6139.6 6301.3 6301.9 6321.4 6332.5 6117.7 6118.1 6121.4 6143.7 6148.0 5970.3 6147.9 6151.1 6178.7 6184.9 6051.1 6100.4 6112.9 6127.6 6143.3 6225.4 6231.5 6244.7 6247.6 6260.2 5771.9 5986.6 6021.6 6033.4 6034.8 05:52:33 INFO - PROCESS | 16080 | 05:52:33 INFO - PROCESS | 16080 | [#5] yui.html Cycles:180 Average:20833.67 Median:4487.55 stddev:29740.55 (662.7%) stddev-sans-first:29785.87 05:52:33 INFO - PROCESS | 16080 | Values: 782.7 810.5 864.8 876.2 879.5 14630.9 15459.6 15511.2 15531.9 15568.9 14262.5 14367.6 14463.4 14472.5 14481.1 693.3 850.7 863.8 865.4 868.4 875.9 877.4 878.8 879.5 880.3 918.9 919.6 920.7 921.0 925.4 911.2 912.1 913.6 914.3 915.6 662.7 669.6 670.6 673.7 676.5 14198.3 14200.4 14252.6 14253.5 14350.9 14851.3 14864.0 14865.6 15069.2 15196.4 11841.7 12122.9 12136.7 12247.2 12253.7 4054.2 4060.6 4112.7 4145.1 4162.4 87356.6 87401.0 87642.1 88607.0 88679.0 11372.2 11506.7 11550.8 11618.2 11724.6 21400.0 21531.6 21670.6 21677.8 21815.0 8576.3 8629.1 8666.7 8862.3 8876.8 5024.4 5144.6 5145.4 5149.2 5202.6 3648.9 3760.5 3786.8 3808.8 3833.2 649.2 651.4 651.6 682.6 688.7 685.9 731.6 759.8 776.9 808.6 10074.9 10215.9 10271.0 10400.9 10620.3 719.9 753.7 767.4 783.3 784.2 4812.7 5095.9 5097.2 5117.3 5119.4 76979.2 77916.2 82703.0 131238.0 133887.0 67661.7 68913.0 82893.2 108789.0 116213.0 60719.1 62575.4 97211.5 99394.0 99497.0 8986.9 9331.9 9840.0 10336.5 10543.7 55462.4 55476.7 56035.4 56052.7 57967.7 80385.0 80930.6 81051.6 82965.6 83963.6 13238.2 13308.7 13391.6 13396.9 13428.1 14886.3 14899.4 14899.8 14954.9 15591.5 13643.9 14270.1 14531.8 14767.5 14920.3 13536.3 14111.5 14245.4 14784.6 15092.1 13260.6 13599.9 13961.1 14166.8 14587.3 10262.3 10476.2 10591.3 10601.7 10781.5 10456.2 10619.3 10627.4 10781.8 10818.1 05:52:33 INFO - PROCESS | 16080 | -------- Summary: end -------- 05:52:33 INFO - PROCESS | 16080 | 05:52:34 INFO - TEST-INFO | 16080: exit 0 05:52:34 INFO - TEST-OK | dromaeo_css | took 1110640ms 05:52:34 INFO - TEST-START | kraken 05:52:34 INFO - operating with platform_type : linux_ 05:52:34 INFO - Initialising browser for kraken test... 05:52:34 INFO - TEST-INFO | started process 16316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiY3E6a/profile http://localhost:38181/getInfo.html) 05:52:38 INFO - PROCESS | 16316 | __metrics Screen width/height:1600/1200 05:52:38 INFO - PROCESS | 16316 | colorDepth:24 05:52:38 INFO - PROCESS | 16316 | Browser inner width/height: 1024/697 05:52:38 INFO - PROCESS | 16316 | __metrics 05:52:38 ERROR - PROCESS | 16316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:52:39 INFO - TEST-INFO | 16316: exit 0 05:52:39 INFO - Browser initialized. 05:52:39 INFO - Running cycle 1/1 for kraken test... 05:52:39 INFO - TEST-INFO | started process 16440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiY3E6a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:51 INFO - PROCESS | 16440 | RSS: Main: 150859776 05:52:51 INFO - PROCESS | 16440 | 05:52:53 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38181/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:54 INFO - PROCESS | 16440 | RSS: Main: 157261824 05:52:54 INFO - PROCESS | 16440 | 05:52:57 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38181/tests/kraken/driver.html?testName=audio-dft) 05:52:57 INFO - PROCESS | 16440 | RSS: Main: 156016640 05:52:57 INFO - PROCESS | 16440 | 05:53:00 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38181/tests/kraken/driver.html?testName=audio-fft) 05:53:01 INFO - PROCESS | 16440 | RSS: Main: 156553216 05:53:01 INFO - PROCESS | 16440 | 05:53:03 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38181/tests/kraken/driver.html?testName=audio-oscillator) 05:53:04 INFO - PROCESS | 16440 | RSS: Main: 156020736 05:53:04 INFO - PROCESS | 16440 | 05:53:06 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:06 INFO - PROCESS | 16440 | RSS: Main: 156823552 05:53:06 INFO - PROCESS | 16440 | 05:53:09 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38181/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:10 INFO - PROCESS | 16440 | RSS: Main: 156622848 05:53:10 INFO - PROCESS | 16440 | 05:53:13 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38181/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:14 INFO - PROCESS | 16440 | RSS: Main: 156946432 05:53:14 INFO - PROCESS | 16440 | 05:53:17 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38181/tests/kraken/driver.html?testName=json-parse-financial) 05:53:18 INFO - PROCESS | 16440 | RSS: Main: 156721152 05:53:18 INFO - PROCESS | 16440 | 05:53:19 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:20 INFO - PROCESS | 16440 | RSS: Main: 156790784 05:53:20 INFO - PROCESS | 16440 | 05:53:21 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:22 INFO - PROCESS | 16440 | RSS: Main: 156405760 05:53:22 INFO - PROCESS | 16440 | 05:53:24 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:25 INFO - PROCESS | 16440 | RSS: Main: 156315648 05:53:25 INFO - PROCESS | 16440 | 05:53:27 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:28 INFO - PROCESS | 16440 | RSS: Main: 156385280 05:53:28 INFO - PROCESS | 16440 | 05:53:31 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:31 INFO - PROCESS | 16440 | RSS: Main: 156459008 05:53:31 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:38181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38181/tests/kraken/driver.html?testName=ai-astar) 05:53:33 INFO - PROCESS | 16440 | RSS: Main: 158814208 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | __start_tp_report 05:53:33 INFO - PROCESS | 16440 | _x_x_mozilla_page_load 05:53:33 INFO - PROCESS | 16440 | _x_x_mozilla_page_load_details 05:53:33 INFO - PROCESS | 16440 | |i|pagename|runs| 05:53:33 INFO - PROCESS | 16440 | |0;ai-astar;104;115;108;110;113;111;111;110;109;110 05:53:33 INFO - PROCESS | 16440 | |1;audio-beat-detection;142;118;143;170;117;150;146;119;181;118 05:53:33 INFO - PROCESS | 16440 | |2;audio-dft;163;160;163;161;162;162;163;162;161;163 05:53:33 INFO - PROCESS | 16440 | |3;audio-fft;75;76;76;187;76;74;76;76;159;76 05:53:33 INFO - PROCESS | 16440 | |4;audio-oscillator;87;84;154;84;85;84;141;86;85;143 05:53:33 INFO - PROCESS | 16440 | |5;imaging-gaussian-blur;117;118;118;117;118;117;116;117;118;118 05:53:33 INFO - PROCESS | 16440 | |6;imaging-darkroom;147;147;146;147;147;148;147;148;147;147 05:53:33 INFO - PROCESS | 16440 | |7;imaging-desaturate;95;95;96;97;96;95;95;95;96;95 05:53:33 INFO - PROCESS | 16440 | |8;json-parse-financial;51;51;50;50;51;51;54;52;50;53 05:53:33 INFO - PROCESS | 16440 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;66;61 05:53:33 INFO - PROCESS | 16440 | |10;stanford-crypto-aes;74;73;75;83;73;77;74;75;77;74 05:53:33 INFO - PROCESS | 16440 | |11;stanford-crypto-ccm;127;121;135;121;128;125;128;130;155;132 05:53:33 INFO - PROCESS | 16440 | |12;stanford-crypto-pbkdf2;155;157;157;157;159;152;161;155;155;154 05:53:33 INFO - PROCESS | 16440 | |13;stanford-crypto-sha256-iterative;64;63;64;66;63;65;64;64;63;67 05:53:33 INFO - PROCESS | 16440 | __end_tp_report 05:53:33 INFO - PROCESS | 16440 | __start_cc_report 05:53:33 INFO - PROCESS | 16440 | _x_x_mozilla_cycle_collect,876 05:53:33 INFO - PROCESS | 16440 | __end_cc_report 05:53:33 INFO - PROCESS | 16440 | __startTimestamp1477918413599__endTimestamp 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | ------- Summary: start ------- 05:53:33 INFO - PROCESS | 16440 | Number of tests: 14 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.92 (2.6%) stddev-sans-first:2.11 05:53:33 INFO - PROCESS | 16440 | Values: 104.0 115.0 108.0 110.0 113.0 111.0 111.0 110.0 109.0 110.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:144.50 stddev:22.77 (15.8%) stddev-sans-first:24.14 05:53:33 INFO - PROCESS | 16440 | Values: 142.0 118.0 143.0 170.0 117.0 150.0 146.0 119.0 181.0 118.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 05:53:33 INFO - PROCESS | 16440 | Values: 163.0 160.0 163.0 161.0 162.0 162.0 163.0 162.0 161.0 163.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:41.59 (54.7%) stddev-sans-first:43.47 05:53:33 INFO - PROCESS | 16440 | Values: 75.0 76.0 76.0 187.0 76.0 74.0 76.0 76.0 159.0 76.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.50 stddev:29.66 (35.1%) stddev-sans-first:30.87 05:53:33 INFO - PROCESS | 16440 | Values: 87.0 84.0 154.0 84.0 85.0 84.0 141.0 86.0 85.0 143.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:53:33 INFO - PROCESS | 16440 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 116.0 117.0 118.0 118.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:53:33 INFO - PROCESS | 16440 | Values: 147.0 147.0 146.0 147.0 147.0 148.0 147.0 148.0 147.0 147.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:53:33 INFO - PROCESS | 16440 | Values: 95.0 95.0 96.0 97.0 96.0 95.0 95.0 95.0 96.0 95.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.34 (2.6%) stddev-sans-first:1.41 05:53:33 INFO - PROCESS | 16440 | Values: 51.0 51.0 50.0 50.0 51.0 51.0 54.0 52.0 50.0 53.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 05:53:33 INFO - PROCESS | 16440 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 66.0 61.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.99 (4.0%) stddev-sans-first:3.12 05:53:33 INFO - PROCESS | 16440 | Values: 74.0 73.0 75.0 83.0 73.0 77.0 74.0 75.0 77.0 74.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:129.00 stddev:9.76 (7.6%) stddev-sans-first:10.28 05:53:33 INFO - PROCESS | 16440 | Values: 127.0 121.0 135.0 121.0 128.0 125.0 128.0 130.0 155.0 132.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.00 stddev:2.57 (1.6%) stddev-sans-first:2.69 05:53:33 INFO - PROCESS | 16440 | Values: 155.0 157.0 157.0 157.0 159.0 152.0 161.0 155.0 155.0 154.0 05:53:33 INFO - PROCESS | 16440 | 05:53:33 INFO - PROCESS | 16440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 05:53:33 INFO - PROCESS | 16440 | Values: 64.0 63.0 64.0 66.0 63.0 65.0 64.0 64.0 63.0 67.0 05:53:33 INFO - PROCESS | 16440 | -------- Summary: end -------- 05:53:33 INFO - PROCESS | 16440 | 05:53:34 INFO - TEST-INFO | 16440: exit 0 05:53:34 INFO - TEST-OK | kraken | took 60456ms 05:53:34 INFO - SUITE-END | took 1171s 05:53:34 INFO - Completed test suite (00:19:31) 05:53:34 INFO - javascript benchmark 05:53:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.275605698886, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.999800059982, 3356.0770788033287, 3361.1093060339012, 3384.2216290253255, 3392.1858753899073, 5827.941720582793, 5848.356680765123, 5914.64512129272, 5926.762929482821, 5930.940690593093, 5828.504577110951, 5872.853178670535, 5874.735636896339, 5877.059670452729, 5884.235049443566, 5294.841154765363, 5367.865803354928, 5377.220303056055, 5389.622726409153, 5416.756245968941, 5410.783568657269, 5418.078926582491, 5419.349678038641, 5421.159720243349, 5421.295231619883, 5222.869428264305, 5291.074062039147, 5382.434844341346, 5383.569314454834, 5418.729063546826, 5349.3045904032615, 5361.0618141825025, 5378.515933565998, 5416.945830541703, 5494.81861399801, 5277.419483856811, 5341.545968592674, 5353.544948679367, 5369.060414427459, 5380.677159370412, 5635.239242702224, 5752.0796672532615, 5874.3244526879525, 5943.167956486095, 5958.285005799332, 6178.38216178383, 6294.181756371689, 6295.96852015737, 6309.0536419536975, 6314.273858506284, 6329.87340253197, 6352.936470635327, 6354.2692590352235, 6367.044943258548, 6370.235571731422, 5694.857628559278, 5792.565557583198, 5918.023526118229, 5921.0, 5923.970380148115, 6334.651594162273, 6457.580257283262, 6469.45009674183, 6473.2232132144445, 6475.384838440341, 6134.38656134383, 6172.4136207060255, 6192.752289908353, 6205.100260462208, 6209.348018458088, 6023.096535519707, 6160.845978850564, 6230.034344676583, 6308.179936608211, 6311.463525600376, 6176.505879529627, 6271.843203919939, 6295.559310848196, 6322.272938612118, 6341.048842673544, 6266.248050234001, 6299.055141728777, 6308.810735677937, 6314.968425157845, 6328.873422531616, 4640.605548528413, 4711.882202944886, 4792.800855147027, 4800.567948884617, 4849.636277279218, 4176.770277634699, 4273.615374616237, 4281.486221653421, 4291.163223171452, 4297.05464797744, 6033.12519684652, 6040.154378387029, 6042.3655516170165, 6058.606190597597, 6067.271927368744, 6032.969835150796, 6126.30393285589, 6348.396902294275, 6354.459870911024, 6356.110144579762, 5959.28488581373, 5980.22257106582, 6020.036794112921, 6030.065339872239, 6070.878582428327, 5335.519803217729, 5349.358077030781, 5379.085555455582, 5384.730763461811, 5410.945890541123, 6297.4017468340435, 6442.291347951722, 6482.319356467598, 6499.642519661369, 6530.216374035146, 6280.057991301342, 6285.088662144055, 6287.717052732546, 6296.842578935563, 6317.241930968313, 6456.806295811133, 6499.155109835691, 6500.349965003462, 6511.186101737283, 6544.738210471528, 5891.3224979126235, 6066.666333351708, 6073.180120683828, 6151.138840562236, 6191.907121393273, 6272.310045895039, 6283.49732021428, 6296.961001434712, 6303.9684801575695, 6310.463610593151, 6151.96924015377, 6171.537134715004, 6175.9073613894925, 6177.752889884354, 6188.319284878569, 5934.287885453773, 6034.939650603438, 6036.849078773066, 6156.26124865019, 6170.722317495633, 6098.0, 6111.834843226386, 6129.785457508966, 6131.202943617302, 6144.477719393902, 6119.465329991759, 6139.6009259398, 6186.969065154645, 6189.907151392823, 6201.441870231701, 5873.324567674772, 5906.40935906406, 5967.104934259895, 6036.817404228457, 6072.332043475302], "value": 5789.050446058617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2349633727986, 630.2027934662651, 655.3086493749092, 658.9769358072468, 717.1107826295395, 42458.575414245846, 47288.05423891529, 47313.52686473134, 47408.28887566689, 47512.762436187855, 48283.275750863766, 48976.75511622437, 48982.755086224606, 49041.264381034314, 49147.26279105807, 9132.95433522833, 9303.162715355616, 9317.394369366004, 9333.346665733401, 9336.393134446273, 9173.816523669522, 9237.214836738885, 9257.120573545537, 9265.166135047844, 9280.211182049534, 9315.161635452809, 9325.347225694204, 9337.579808908615, 9348.298877584175, 9371.578278977428, 9228.16946474817, 9263.444193348387, 9280.118388753057, 9284.257259419264, 9290.860637090449, 9190.908090919072, 9191.678291259774, 9256.6297348106, 9257.583408746623, 9263.768405789842, 44464.110717785785, 44606.33090503645, 44758.0, 44906.32640510395, 44961.0, 3648.872289469856, 3948.960510394888, 4012.4583181270445, 4210.179015092058, 4386.385905973167, 35047.12382190466, 35279.4708079379, 35319.64680353189, 35590.46614300788, 35669.64330356689, 4676.392069031004, 4845.781939812717, 4857.951420485785, 4861.465238823726, 4934.161192597231, 381502.0, 387949.0, 389633.0, 545176.999999996, 555568.0, 68412.3158768406, 68637.65681171662, 68641.31358686449, 68794.0, 68952.0, 41274.79362603168, 74727.62636186785, 75125.62437187778, 75324.24675753173, 75462.6226868873, 17452.389166379115, 18152.183151758203, 18171.818281817275, 18191.63616727658, 18214.45356639303, 13741.793873091912, 14011.299435028208, 14049.086809357359, 14076.366563504667, 14570.927145364418, 21025.68461473079, 21116.89441552813, 21271.78728212729, 21274.680879786814, 21341.46646333823, 7335.926640733631, 7426.331630153312, 7580.241975802486, 7587.62061896914, 7697.648745448196, 1063.4682658670665, 1070.4059247117925, 1102.1640414007848, 1148.3798748675622, 1182.395445587907, 34441.31117377638, 34571.82714086414, 34875.12812179665, 35058.474122888176, 35117.47323790145, 1147.971300717472, 1164.6913567904512, 1204.4700331853956, 1218.9882397609963, 1223.8347823043953, 17762.822371776376, 18424.907875460536, 18447.16987735555, 18500.16749246287, 18640.440786776417, 547308.0, 548215.0, 548420.0, 551608.0, 554561.0, 67629.0, 68722.65638671875, 68914.0, 68924.6553767238, 69042.30957690459, 1416.192770121021, 1442.9567112986626, 1450.6881020580627, 1454.41096355976, 1469.169918995764, 32684.50973235356, 34134.65865341315, 34594.13514662053, 34780.65219347774, 34784.82607587047, 60044.39955600388, 60098.39901600928, 60508.69745651243, 60600.69699651474, 60758.0, 469524.0, 473136.0, 473285.0, 473366.0, 473749.0, 32708.34583308368, 33039.50440743343, 33078.0, 33124.834375828934, 33392.49911251382, 54741.178882316, 55474.0, 55836.72081639566, 56712.43287567236, 57401.0, 46248.0, 47622.09511619635, 48149.27776083432, 48368.27447588219, 49096.263556045975, 46715.29927051165, 47806.0, 48048.759756201, 48637.27044094412, 49019.0, 39418.802905985285, 45279.0, 45714.31428528641, 46269.0, 47569.762151189025, 38006.2398752029, 39162.0, 39278.6072139275, 40001.59998400095, 40499.797501012305, 30626.693733062384, 30708.692913070583, 30734.231644209074, 30999.535006974464, 31224.687753123086], "value": 22178.20578328782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.37748886625525, 426.5940097848135, 439.18092757008174, 441.08129636083044, 449.8448035427778, 18423.263069477205, 20088.196472141117, 20286.087126079325, 20655.586888262264, 21242.25652102177, 16506.587335316624, 18317.542061448472, 19625.565526032922, 19670.0, 19677.409677709657, 5961.463468287853, 6140.631562106266, 6142.4778893793855, 6147.938520614782, 6182.938170618304, 5756.913646295309, 5990.281166260033, 6013.278406591194, 6025.517958563326, 6038.882806680778, 6048.727807248684, 6090.0, 6095.238095238095, 6102.481289090432, 6163.0, 6493.902591461132, 6504.934950650504, 6563.57336773113, 6573.30980247072, 6576.605403675747, 5278.287431196778, 5486.396496385394, 5531.419200983919, 5607.439256074401, 5617.466340697627, 14678.119312841263, 14855.851441485554, 15194.392224311014, 15323.693526129526, 15362.692746145127, 2387.78509934105, 2451.252368027751, 2461.88921498533, 2483.3295010347106, 2561.078011915709, 10844.457777111193, 10939.945300273528, 11025.889741102566, 11108.222424430292, 12758.553450629184, 1962.3033822992918, 1999.6700544410155, 2046.1508473983279, 2103.6949642301934, 2128.3934078787624, 87252.56373718091, 87268.56365718195, 87904.56047719784, 88927.55536222341, 89517.55241223752, 11513.251638643462, 11547.76904461906, 11751.588694395827, 11872.762544749057, 11906.226095303777, 16879.07165105931, 16888.662226755398, 16919.492415227563, 16971.91514042422, 16983.83016169847, 8505.350636956906, 8684.826303473896, 8783.868241976375, 8913.969250454747, 8963.596638151299, 8415.200555947175, 8547.57262136903, 8580.0, 8697.521636310064, 8764.56177191138, 5111.897762044739, 5113.105206588906, 5162.638615296968, 5179.585633149339, 5258.132408152612, 2065.896705164736, 2093.916243350249, 2168.4036889855415, 2174.2716190076185, 2204.8787316697735, 941.4680705401427, 1045.717656232813, 1057.2070946789909, 1061.3207547169818, 1084.3060441317564, 20019.199232030845, 20251.797482025286, 20566.897165514376, 20799.68800467994, 20865.37403877886, 1094.316052467208, 1097.4951522299832, 1102.9338239705644, 1111.4776055254179, 1113.3486910157487, 10986.450677466095, 11364.545418183345, 11445.313281202987, 11493.885061149449, 11522.711932201762, 407038.0, 409563.0, 414286.0, 549541.0, 558264.0, 86284.0, 96801.515992421, 97675.51162244285, 100998.49500752449, 101643.4917825421, 1054.778496515725, 1061.9097376723066, 1090.051655060087, 1095.6548687163677, 1107.2692023264767, 17493.16321786245, 17700.46898593044, 17909.552261193054, 18091.457256282334, 18249.0, 42041.36937945872, 44260.11479770322, 44677.329840051774, 44734.55265447304, 44812.551874480836, 59710.40289597048, 64683.35316646961, 65005.67497162673, 66165.33834661591, 68362.31637683559, 9189.310801690033, 9404.52977351116, 9466.52667366615, 9474.14732674035, 9627.085426884434, 10660.413677247825, 14073.718525629225, 14220.36008379646, 14409.13545187292, 14631.195284259467, 11021.83467248008, 11570.652880413601, 11603.767924641292, 11765.64695060079, 11852.229605075643, 12268.631941041784, 12371.0, 12431.12982091281, 12566.0, 12737.87262127367, 5965.70171491415, 10032.398056116657, 11680.591179308683, 11761.705957351134, 11772.293662380285, 9223.723288301362, 9353.39202951806, 9365.438073715599, 9383.671571494964, 9634.084761947604, 9015.819683606422, 11439.59961401347, 11786.646400607995, 11807.822882656596, 12031.879681203425], "value": 9592.220920525058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.2464879884458, 1551.7051760165568, 1723.517415123765, 1841.640880028395, 1871.457277389557, 8567.828643427129, 9322.20761235295, 9431.339806213567, 10089.747756306087, 10096.495175241236, 9511.857322140173, 9918.404895706262, 9918.85121723173, 9932.0, 9933.751656208598, 2506.6114752213434, 2533.783783783785, 2536.6068259419726, 2536.606825941982, 2537.6954765428172, 2436.5492383908945, 2519.1560827122935, 2521.2940376694555, 2521.8612976286295, 2524.469861329123, 2475.579151544233, 2498.1631153563576, 2538.0, 2541.8474891506476, 2547.5669136246884, 2424.3696638873844, 2465.5315490056832, 2477.9840265491152, 2483.155727052793, 2483.8758062096913, 2450.1791899713617, 2458.1150785717127, 2459.3113928099983, 2459.5818710819203, 2504.1235567551394, 9805.90194098057, 9818.0, 9927.851082233772, 9932.0, 9942.900570994341, 5747.1666608341975, 5866.384029676865, 5871.706414679249, 5874.353821079678, 5881.529477641779, 3481.35594914939, 3533.9293214135573, 3586.103474131467, 3600.891973240807, 3627.6009638939695, 1103.6578660615235, 1140.3841925360296, 1146.3637681086993, 1150.3155622404656, 1161.3322339654733, 13984.580462586138, 14059.945504087133, 14072.92963535186, 14095.22476263805, 14111.929440352835, 4743.055347307587, 4840.1287768201355, 4899.58353539946, 4938.308636790852, 5073.264376665363, 11647.6505704829, 11740.295582265091, 11755.647330580096, 11784.88215117855, 11811.704707382212, 5760.452756988079, 5774.0761478163295, 5778.3643799182055, 5784.913226301609, 5790.10253410722, 4594.563516465931, 5182.896342073137, 5285.497877701612, 5305.151175811929, 5351.063563876306, 4490.685652004328, 4491.079328737601, 4569.680122391401, 4586.3579098926175, 4606.170889239969, 1402.9088109272864, 1415.9929200354138, 1428.2073449235565, 1428.8428272889973, 1431.7279716853764, 977.941323520591, 1012.2559918459926, 1076.6016573867719, 1082.2965072702807, 1086.5056399338441, 6500.544961852719, 6690.19717633887, 6857.142857142857, 6868.347506986828, 6895.310468953065, 482.6549017452538, 484.4549881383444, 499.0567826807337, 500.0524007006775, 501.77670936432935, 4463.352813841975, 4574.931376029363, 4642.117997580449, 4703.529647035269, 4705.341252224691, 11834.704132396759, 12077.51689932393, 12090.274583525017, 12209.755804883853, 12219.327936963553, 12063.095267854946, 12075.637730868088, 12083.45624446902, 12101.455434505293, 12126.878731212752, 8981.685641002534, 9146.86279705805, 9168.0, 9174.633014679339, 9205.401648892801, 6657.700403481758, 6715.429188518835, 6722.361375669304, 6728.192616886005, 6836.897446538405, 10928.235023548594, 11006.0, 11251.324920504796, 11263.605773797877, 11299.491522881326, 11273.830892536454, 11410.372429516456, 11422.800605936258, 11513.597024104116, 11574.421278936188, 7929.167437418988, 8291.129431409616, 8534.82930341402, 8565.700200492953, 8674.0, 9561.474118923248, 9633.08485693858, 9717.465539395118, 9717.708468745948, 9721.0, 8351.20663536963, 8365.874511882448, 8475.0, 8628.39601227908, 8650.264727498234, 8307.252347288773, 8313.542755148283, 8507.744767656981, 8593.011803642661, 8615.22462978335, 7521.4734968551675, 7817.0619525657285, 7839.25527074927, 7860.253275939005, 7884.093329266978, 5665.3201615806365, 5695.544356451557, 5817.214676018683, 5910.645361278337, 5919.674417906885, 5845.561582881216, 5885.08781138907, 5890.852728681817, 5986.102084687158, 6028.216331876828], "value": 5016.834867738621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.57749644168103, 365.7001258967646, 367.46166865541977, 368.9575698794638, 370.0711214850726, 5822.272215973004, 5846.6199697019665, 5849.853753656161, 5866.120081987709, 5872.236609240793, 5347.946520534793, 5733.283339582552, 5750.453706897849, 5756.251687280647, 5780.248567686205, 4469.508354081048, 4472.172648060119, 4484.376639665799, 4487.0, 4487.730736155825, 4471.306947423154, 4495.3931219285305, 4497.370368148462, 4506.256467682829, 4511.52628973958, 4380.8685739427865, 4463.375127482155, 4466.932996005046, 4472.508024117345, 4477.283634618461, 4425.7565833879125, 4448.2207117153075, 4450.621697155713, 4454.665900057476, 4465.68740188187, 3916.3342231820375, 3927.8821635350987, 3932.997085743117, 3937.9015524611827, 3968.4047392891007, 5463.344398672145, 5564.387917329091, 5569.498745112919, 5587.552995760329, 5605.215269862222, 5050.671706339113, 5097.388313402378, 5167.612429067797, 5176.870578235575, 5222.503862133091, 6045.72794224261, 6059.7273122709585, 6059.878802423971, 6070.8785824283705, 6071.878562428727, 4193.203291374629, 4394.670399720002, 4401.06353204589, 4407.140607581523, 4467.977660111711, 6094.9390506094815, 6279.466245369149, 6301.8109456716375, 6333.0, 6355.8411039723915, 4460.50934397216, 4466.3523789050405, 4466.709663871838, 4471.697076005859, 4473.910521789611, 4539.84110556129, 4563.498015218323, 4567.862964111082, 4574.124608910331, 4580.7938642761155, 4948.653594248368, 5201.0, 5217.50433708797, 5239.685618862881, 5264.6314757966575, 6014.669193194329, 6046.3349031606485, 6049.304330002018, 6065.848353791191, 6121.602095863755, 1538.8153421589482, 1551.7517197248385, 1569.968600627981, 1570.9135997520018, 1571.5128310223868, 960.2270172511056, 994.2990191914682, 996.5948013301355, 1006.4464544500496, 1013.8986101389802, 5203.5576975957465, 5205.9219111713355, 5226.503482169188, 5246.685198888079, 5248.947510524846, 5417.512423881791, 5437.945620543744, 5450.373207081237, 5487.341519017664, 5524.3370795504, 4917.385326834145, 5165.483451654804, 5168.844934651891, 5219.660722053054, 5226.268322434862, 2916.3292442737866, 2922.547005214195, 2935.251510864716, 2940.5001149804584, 2948.3071478202605, 5601.971990140023, 5617.747201375948, 5640.435956404327, 5650.519705825051, 5675.843179591811, 5185.729496273361, 5494.2857428534835, 5564.693941833238, 5578.8047418340975, 5590.8043218487155, 5543.334799823966, 5585.916211256835, 5588.944110558924, 5626.0, 5637.9718101409235, 5104.69371837691, 5437.199842081252, 5461.563074954073, 5467.289252397163, 5505.889882202414, 5359.330083739533, 5382.327209098863, 5441.7279136043835, 5475.206095116266, 5480.205370221375, 6210.726801005873, 6484.870302594016, 6508.884612500861, 6515.514199903029, 6521.82607130702, 4458.598726114666, 4473.888152796076, 4479.17135329965, 4479.619232365155, 4493.1238408511335, 6139.57023008403, 6301.338359472189, 6301.936980630318, 6321.367863213642, 6332.52506062038, 6117.663528505975, 6118.143459915526, 6121.387861213843, 6143.6928153593035, 6147.969260153671, 5970.283565971938, 6147.938520614915, 6151.138840562415, 6178.66017369049, 6184.938150618436, 6051.092336149437, 6100.420460056288, 6112.938870611237, 6127.601705889103, 6143.262808463013, 6225.408586184305, 6231.470325022243, 6244.687765611792, 6247.5939063960695, 6260.186175797299, 5771.9134212986, 5986.580939334205, 6021.638701677914, 6033.366496517802, 6034.78878239277], "value": 4491.0513568901615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.6830133795811, 810.4934415990007, 864.7794812322857, 876.2289185516746, 879.4591326334304, 14630.853691463082, 15459.613509662264, 15511.224438778045, 15531.922340388297, 15568.922155389222, 14262.50081247154, 14367.563243675628, 14463.421463141462, 14472.493462728806, 14481.058731182466, 693.2963042511855, 850.7235148576707, 863.8445079885618, 865.3769286114019, 868.4181598329135, 875.9124087591222, 877.4340550345056, 878.767126711422, 879.4723166100321, 880.2561835249204, 918.9264858811279, 919.5586118663045, 920.6639576554576, 921.0237148622448, 925.3846192282124, 911.1890417528405, 912.0514664748654, 913.6071489259616, 914.2731528434911, 915.5651065743785, 662.6918482905423, 669.5714742564762, 670.5641333133502, 673.6631684157921, 676.4757313082351, 14198.290085495684, 14200.431982720678, 14252.572422827332, 14253.501127460593, 14350.856491435057, 14851.257437128208, 14864.0, 14865.628359291104, 15069.246537673072, 15196.392144314214, 11841.703957401134, 12122.939385303105, 12136.696582585419, 12247.203931744409, 12253.693657658541, 4054.249963756685, 4060.5736397678115, 4112.650424713873, 4145.129522800215, 4162.354835000579, 87356.5632171835, 87401.0, 87642.12357876467, 88607.0, 88679.0, 11372.203945723886, 11506.654800356002, 11550.768984620261, 11618.186726929203, 11724.58963936258, 21400.0, 21531.569368612854, 21670.566588668138, 21677.78322216789, 21815.0, 8576.271016963503, 8629.09394513567, 8666.739997800076, 8862.335324850663, 8876.778080547909, 5024.371953505812, 5144.61415393847, 5145.434002259748, 5149.2276158576515, 5202.583793296527, 3648.945265821015, 3760.4735337052834, 3786.753860999026, 3808.809559522013, 3833.1950290438763, 649.1625802714445, 651.3811878715239, 651.563452486835, 682.566570227899, 688.6694386694314, 685.869684759894, 731.5683746589538, 759.7644730133676, 776.9006855299688, 808.5957021489255, 10074.949625251973, 10215.897841021644, 10271.015709317735, 10400.895991040145, 10620.309679870783, 719.9208087110413, 753.7211231844253, 767.4321002458141, 783.2559068884583, 784.196198896136, 4812.735299558558, 5095.923561146586, 5097.158968770185, 5117.309163262912, 5119.436861945183, 76979.23020769833, 77916.22083779203, 82703.0, 131238.0, 133887.0, 67661.66169169123, 68913.0, 82893.17106828975, 108789.0, 116213.0, 60719.089213662715, 62575.37424625696, 97211.51394243125, 99394.0, 99497.0, 8986.86519702192, 9331.906680933103, 9840.0, 10336.534855931352, 10543.736406589896, 55462.445375547344, 55476.72261638666, 56035.43964560302, 56052.71973640106, 57967.71016145061, 80385.0, 80930.59534702289, 81051.59474202592, 82965.58517207376, 83963.5801820987, 13238.205707657571, 13308.667283317995, 13391.598252052454, 13396.866031339561, 13428.127171734197, 14886.255687215813, 14899.404023838924, 14899.776503352676, 14954.925225373803, 15591.454299099478, 13643.931780341034, 14270.072445291024, 14531.78202326987, 14767.483138090116, 14920.328585213909, 13536.323183840572, 14111.506097286545, 14245.430182792987, 14784.63038424048, 15092.094474331576, 13260.602181934557, 13599.932000339935, 13961.092528985584, 14166.78749818733, 14587.34356953961, 10262.281640285408, 10476.214283928888, 10591.311564748266, 10601.734956626146, 10781.51483183243, 10456.215783816093, 10619.30974486656, 10627.36235825853, 10781.784364312827, 10818.080463160404], "value": 7803.570680688375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 108.0, 110.0, 113.0, 111.0, 111.0, 110.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 143.0, 170.0, 117.0, 150.0, 146.0, 119.0, 181.0, 118.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 187.0, 76.0, 74.0, 76.0, 76.0, 159.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 154.0, 84.0, 85.0, 84.0, 141.0, 86.0, 85.0, 143.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 51.0, 51.0, 54.0, 52.0, 50.0, 53.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 66.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 83.0, 73.0, 77.0, 74.0, 75.0, 77.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 135.0, 121.0, 128.0, 125.0, 128.0, 130.0, 155.0, 132.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 157.0, 157.0, 159.0, 152.0, 161.0, 155.0, 155.0, 154.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 66.0, 63.0, 65.0, 64.0, 64.0, 63.0, 67.0], "value": 64.3, "unit": "score"}]}]} 05:53:34 INFO - Return code: 0 05:53:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:34 ERROR - # TBPL SUCCESS # 05:53:34 INFO - Running post-action listener: _resource_record_post_action 05:53:34 INFO - [mozharness: 2016-10-31 12:53:34.920416Z] Finished run-tests step (success) 05:53:34 INFO - Running post-run listener: _resource_record_post_run 05:53:34 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1871872; Write bytes: 290947072; Read time: 160; Write time: 191396 05:53:34 INFO - TinderboxPrint: CPU usage
13.2% 05:53:34 INFO - TinderboxPrint: I/O read bytes / time
1,871,872 / 160 05:53:34 INFO - TinderboxPrint: I/O write bytes / time
290,947,072 / 191,396 05:53:34 INFO - TinderboxPrint: CPU idle
8,204.7 (86.8%) 05:53:34 INFO - TinderboxPrint: CPU user
1,197.2 (12.7%) 05:53:34 INFO - TinderboxPrint: Swap in / out
0 / 0 05:53:35 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71450624; Read time: 0; Write time: 82664 05:53:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219496448; Read time: 16; Write time: 108732 05:53:35 INFO - Running post-run listener: _upload_blobber_files 05:53:35 INFO - Blob upload gear active. 05:53:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:35 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 05:53:35 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:35 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:39 INFO - (blobuploader) - INFO - Done attempting. 05:53:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:40 INFO - (blobuploader) - INFO - Done attempting. 05:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:41 INFO - (blobuploader) - INFO - Done attempting. 05:53:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:41 INFO - Return code: 0 05:53:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76041c0689c2a2a72c8496366a646091fb43a556a3e66fe871714053ad30d3fd59fa3d0acd485a52d967a780d1b6666722ee1681366c534e993ac57cd8f1ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e3263629adca5dfcc7565efe082b673d6b4293e9ac322269b141b2a7cbb98d9e179d935f99eec7e9832da6cbf1de093b69a9e547aaa6c09270e20e332225047", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2415a0507e11fcf97661a6876e335207a0e064c25357b8cb7a2c27a404abf51e50dc61f9a80bdc03ed3a4075025621b9e5ccd3380737be415ecf177f97edf247"} 05:53:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:41 INFO - Contents: 05:53:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76041c0689c2a2a72c8496366a646091fb43a556a3e66fe871714053ad30d3fd59fa3d0acd485a52d967a780d1b6666722ee1681366c534e993ac57cd8f1ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e3263629adca5dfcc7565efe082b673d6b4293e9ac322269b141b2a7cbb98d9e179d935f99eec7e9832da6cbf1de093b69a9e547aaa6c09270e20e332225047", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2415a0507e11fcf97661a6876e335207a0e064c25357b8cb7a2c27a404abf51e50dc61f9a80bdc03ed3a4075025621b9e5ccd3380737be415ecf177f97edf247"} 05:53:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:41 INFO - Copying logs to upload dir... 05:53:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.357178 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-31 05:53:40.816667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 05:53:40.821148) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 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-Beta/sha512/76041c0689c2a2a72c8496366a646091fb43a556a3e66fe871714053ad30d3fd59fa3d0acd485a52d967a780d1b6666722ee1681366c534e993ac57cd8f1ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e3263629adca5dfcc7565efe082b673d6b4293e9ac322269b141b2a7cbb98d9e179d935f99eec7e9832da6cbf1de093b69a9e547aaa6c09270e20e332225047", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2415a0507e11fcf97661a6876e335207a0e064c25357b8cb7a2c27a404abf51e50dc61f9a80bdc03ed3a4075025621b9e5ccd3380737be415ecf177f97edf247"} build_url:https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/SH8Fj5DnTm2XsTPzpQUvZQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76041c0689c2a2a72c8496366a646091fb43a556a3e66fe871714053ad30d3fd59fa3d0acd485a52d967a780d1b6666722ee1681366c534e993ac57cd8f1ccec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e3263629adca5dfcc7565efe082b673d6b4293e9ac322269b141b2a7cbb98d9e179d935f99eec7e9832da6cbf1de093b69a9e547aaa6c09270e20e332225047", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2415a0507e11fcf97661a6876e335207a0e064c25357b8cb7a2c27a404abf51e50dc61f9a80bdc03ed3a4075025621b9e5ccd3380737be415ecf177f97edf247"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 05:53:40.846850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:53:40.847194) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477912709.745872-1709532424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 05:53:40.934127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 05:53:40.934595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 05:53:40.934901) ========= ========= Total master_lag: 0.22 =========