builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1475755071.65 results: success (0) buildid: 20161006020700 builduid: a21a442ea5344537ac53fefee23c694e revision: 37417e763286faffc6d50d93fe0fee3da795dee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.652881) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.653337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.653613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.668218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.668497) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 04:57:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-10-06 04:57:51 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.821792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.822105) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.871507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:51.871873) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 37417e763286faffc6d50d93fe0fee3da795dee7 --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 37417e763286faffc6d50d93fe0fee3da795dee7 --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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 04:57:51,997 truncating revision to first 12 chars 2016-10-06 04:57:51,997 Setting DEBUG logging. 2016-10-06 04:57:51,997 attempt 1/10 2016-10-06 04:57:51,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/37417e763286?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 04:57:52,298 unpacking tar archive at: mozilla-beta-37417e763286/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:52.527006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:52.527323) ========= script_repo_revision: 37417e763286faffc6d50d93fe0fee3da795dee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:52.527726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:52.528017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:57:52.538564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-06 04:57:52.538843) ========= /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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:52 INFO - MultiFileLogger online at 20161006 04:57:52 in /builds/slave/test 04:57:52 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 04:57:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:52 INFO - {'append_to_log': False, 04:57:52 INFO - 'base_work_dir': '/builds/slave/test', 04:57:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:57:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:52 INFO - 'branch': 'Mozilla-Beta', 04:57:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:52 INFO - 'config_files': ('talos/linux_config.py',), 04:57:52 INFO - 'default_actions': ('clobber', 04:57:52 INFO - 'read-buildbot-config', 04:57:52 INFO - 'download-and-extract', 04:57:52 INFO - 'populate-webroot', 04:57:52 INFO - 'create-virtualenv', 04:57:52 INFO - 'install', 04:57:52 INFO - 'run-tests'), 04:57:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:52 INFO - 'download_minidump_stackwalk': True, 04:57:52 INFO - 'download_symbols': 'ondemand', 04:57:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:52 INFO - 'installer_path': 'installer.exe', 04:57:52 INFO - 'log_level': 'info', 04:57:52 INFO - 'log_name': 'talos', 04:57:52 INFO - 'log_to_console': True, 04:57:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:52 INFO - 'opt_config_files': (), 04:57:52 INFO - 'pip_index': False, 04:57:52 INFO - 'sps_profile': False, 04:57:52 INFO - 'sps_profile_interval': 0, 04:57:52 INFO - 'suite': 'dromaeojs-e10s', 04:57:52 INFO - 'system_bits': '32', 04:57:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:52 INFO - 'title': 'talos-linux64-ix-001', 04:57:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:52 INFO - 'use_talos_json': True, 04:57:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:52 INFO - 'work_dir': 'build'} 04:57:52 INFO - [mozharness: 2016-10-06 11:57:52.755992Z] Running clobber step. 04:57:52 INFO - Running pre-action listener: _resource_record_pre_action 04:57:52 INFO - Running main action method: clobber 04:57:52 INFO - rmtree: /builds/slave/test/build 04:57:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:53 INFO - Running post-action listener: _resource_record_post_action 04:57:53 INFO - [mozharness: 2016-10-06 11:57:53.249575Z] Finished clobber step (success) 04:57:53 INFO - [mozharness: 2016-10-06 11:57:53.249677Z] Running read-buildbot-config step. 04:57:53 INFO - Running pre-action listener: _resource_record_pre_action 04:57:53 INFO - Running main action method: read_buildbot_config 04:57:53 INFO - Using buildbot properties: 04:57:53 INFO - { 04:57:53 INFO - "project": "", 04:57:53 INFO - "product": "firefox", 04:57:53 INFO - "script_repo_revision": "production", 04:57:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:57:53 INFO - "repository": "", 04:57:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:57:53 INFO - "buildid": "20161006020700", 04:57:53 INFO - "pgo_build": "True", 04:57:53 INFO - "basedir": "/builds/slave/test", 04:57:53 INFO - "buildnumber": 277, 04:57:53 INFO - "slavename": "talos-linux64-ix-001", 04:57:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:57:53 INFO - "platform": "ubuntu64_hw", 04:57:53 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:57:53 INFO - "branch": "mozilla-beta", 04:57:53 INFO - "repo_path": "releases/mozilla-beta", 04:57:53 INFO - "revision": "37417e763286faffc6d50d93fe0fee3da795dee7", 04:57:53 INFO - "stage_platform": "linux64-pgo", 04:57:53 INFO - "builduid": "a21a442ea5344537ac53fefee23c694e", 04:57:53 INFO - "slavebuilddir": "test" 04:57:53 INFO - } 04:57:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 04:57:53 INFO - Running post-action listener: _resource_record_post_action 04:57:53 INFO - [mozharness: 2016-10-06 11:57:53.252154Z] Finished read-buildbot-config step (success) 04:57:53 INFO - [mozharness: 2016-10-06 11:57:53.252244Z] Running download-and-extract step. 04:57:53 INFO - Running pre-action listener: _resource_record_pre_action 04:57:53 INFO - Running main action method: download_and_extract 04:57:53 INFO - mkdir: /builds/slave/test/build/tests 04:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:53 INFO - https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:57:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:57:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:57:53 INFO - retry: Failed, sleeping 30 seconds before retrying 04:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:58:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:58:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:58:23 INFO - retry: Failed, sleeping 60 seconds before retrying 04:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:59:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:59:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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! 04:59:23 INFO - Caught exception: HTTP Error 404: Not Found 04:59:23 INFO - Caught exception: HTTP Error 404: Not Found 04:59:23 INFO - Caught exception: HTTP Error 404: Not Found 04:59:23 INFO - trying https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:59:23 INFO - Downloading https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:23 INFO - Downloaded 1327 bytes. 04:59:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 04:59:23 INFO - Using the following test package requirements: 04:59:23 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 04:59:23 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:23 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 04:59:23 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'jsshell-linux-x86_64.zip'], 04:59:23 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:23 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 04:59:23 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 04:59:23 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 04:59:23 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:23 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 04:59:23 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:23 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:23 INFO - https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:59:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:59:23 INFO - retry: Failed, sleeping 30 seconds before retrying 04:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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 04:59:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 04:59:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:59:53 INFO - retry: Failed, sleeping 60 seconds before retrying 05:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:00:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:00:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:54 INFO - Caught exception: HTTP Error 404: Not Found 05:00:54 INFO - Caught exception: HTTP Error 404: Not Found 05:00:54 INFO - Caught exception: HTTP Error 404: Not Found 05:00:54 INFO - trying https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:54 INFO - Downloaded 21773250 bytes. 05:00:54 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:00:54 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:00:56 INFO - Return code: 0 05:00:56 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:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:56 INFO - https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:00:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:00:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:00:56 INFO - retry: Failed, sleeping 30 seconds before retrying 05:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:01:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:01:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:01:26 INFO - retry: Failed, sleeping 60 seconds before retrying 05:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:02:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:02:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:26 INFO - Caught exception: HTTP Error 404: Not Found 05:02:26 INFO - Caught exception: HTTP Error 404: Not Found 05:02:26 INFO - Caught exception: HTTP Error 404: Not Found 05:02:26 INFO - trying https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:02:26 INFO - Downloading https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:26 INFO - Downloaded 21773250 bytes. 05:02:26 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:02:26 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:02:28 INFO - Return code: 0 05:02:28 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:02:28 INFO - https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:02:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:02:28 INFO - retry: Failed, sleeping 30 seconds before retrying 05:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:02:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:02:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:02:58 INFO - retry: Failed, sleeping 60 seconds before retrying 05:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:03:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:03:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:58 INFO - Caught exception: HTTP Error 404: Not Found 05:03:58 INFO - Caught exception: HTTP Error 404: Not Found 05:03:58 INFO - Caught exception: HTTP Error 404: Not Found 05:03:58 INFO - trying https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:03:58 INFO - Downloading https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:59 INFO - Downloaded 14413740 bytes. 05:03:59 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:03:59 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:03:59 INFO - Return code: 0 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:59 INFO - https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:03:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:03:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:03:59 INFO - retry: Failed, sleeping 30 seconds before retrying 05:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:04:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:04:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:04:29 INFO - retry: Failed, sleeping 60 seconds before retrying 05:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:05:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:05:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:05:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:05:29 INFO - Caught exception: HTTP Error 404: Not Found 05:05:29 INFO - Caught exception: HTTP Error 404: Not Found 05:05:29 INFO - Caught exception: HTTP Error 404: Not Found 05:05:29 INFO - trying https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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:05:30 INFO - Downloaded 56779209 bytes. 05:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:05:30 INFO - mkdir: /builds/slave/test/properties 05:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:30 INFO - Contents: 05:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:05:31 INFO - Running post-action listener: _resource_record_post_action 05:05:31 INFO - Running post-action listener: set_extra_try_arguments 05:05:31 INFO - [mozharness: 2016-10-06 12:05:31.302777Z] Finished download-and-extract step (success) 05:05:31 INFO - [mozharness: 2016-10-06 12:05:31.303013Z] Running populate-webroot step. 05:05:31 INFO - Running pre-action listener: _resource_record_pre_action 05:05:31 INFO - Running main action method: populate_webroot 05:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:31 INFO - '--tppagecycles', 05:05:31 INFO - '7'], 05:05:31 INFO - 'tests': ['tsvgm']}}, 05:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['damp', 'tps']}, 05:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['damp', 'tps']}, 05:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['dromaeo_dom']}, 05:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['basic_compositor_video']}, 05:05:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['a11yr', 05:05:31 INFO - 'ts_paint', 05:05:31 INFO - 'tpaint', 05:05:31 INFO - 'sessionrestore', 05:05:31 INFO - 'sessionrestore_no_auto_restore', 05:05:31 INFO - 'tabpaint']}, 05:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tsvgx', 05:05:31 INFO - 'tsvgr_opacity', 05:05:31 INFO - 'tart', 05:05:31 INFO - 'tscrollx', 05:05:31 INFO - 'cart']}, 05:05:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:31 INFO - 'tsvgr_opacity', 05:05:31 INFO - 'tart', 05:05:31 INFO - 'tscrollx', 05:05:31 INFO - 'cart']}, 05:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s'], 05:05:31 INFO - 'tests': ['tp5o']}, 05:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'tests': ['tp5o']}, 05:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--disable-e10s', 05:05:31 INFO - '--xperf_path', 05:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:31 INFO - 'tests': ['tp5n']}, 05:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:31 INFO - 'talos_options': ['--xperf_path', 05:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:31 INFO - 'tests': ['tp5n']}}, 05:05:31 INFO - 'talos.zip': {'path': '', 05:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:31 INFO - Running post-action listener: _resource_record_post_action 05:05:31 INFO - [mozharness: 2016-10-06 12:05:31.321775Z] Finished populate-webroot step (success) 05:05:31 INFO - [mozharness: 2016-10-06 12:05:31.321865Z] Running create-virtualenv step. 05:05:31 INFO - Running pre-action listener: _resource_record_pre_action 05:05:31 INFO - Running main action method: create_virtualenv 05:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:31 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:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:31 INFO - Using real prefix '/usr' 05:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:33 INFO - Installing pip.................done. 05:05:33 INFO - Return code: 0 05:05:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:33 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:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:33 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:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:33 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:33 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:05:33 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:05:33 INFO - Using env: {'DISPLAY': ':0', 05:05:33 INFO - 'HOME': '/home/cltbld', 05:05:33 INFO - 'LANG': 'en_US.UTF-8', 05:05:33 INFO - 'LANGUAGE': 'en_US:en', 05:05:33 INFO - 'LOGNAME': 'cltbld', 05:05:33 INFO - 'MAIL': '/var/mail/cltbld', 05:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:33 INFO - 'MOZ_NO_REMOTE': '1', 05:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:33 INFO - 'NO_EM_RESTART': '1', 05:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:33 INFO - 'PWD': '/builds/slave/test', 05:05:33 INFO - 'SHELL': '/bin/bash', 05:05:33 INFO - 'SHLVL': '1', 05:05:33 INFO - 'TERM': 'linux', 05:05:33 INFO - 'TMOUT': '86400', 05:05:33 INFO - 'USER': 'cltbld', 05:05:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:33 INFO - '_': '/tools/buildbot/bin/python'} 05:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:34 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:05:34 INFO - Cleaning up... 05:05:34 INFO - Return code: 0 05:05:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:34 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:05:34 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:05:34 INFO - Using env: {'DISPLAY': ':0', 05:05:34 INFO - 'HOME': '/home/cltbld', 05:05:34 INFO - 'LANG': 'en_US.UTF-8', 05:05:34 INFO - 'LANGUAGE': 'en_US:en', 05:05:34 INFO - 'LOGNAME': 'cltbld', 05:05:34 INFO - 'MAIL': '/var/mail/cltbld', 05:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:34 INFO - 'MOZ_NO_REMOTE': '1', 05:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:34 INFO - 'NO_EM_RESTART': '1', 05:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:34 INFO - 'PWD': '/builds/slave/test', 05:05:34 INFO - 'SHELL': '/bin/bash', 05:05:34 INFO - 'SHLVL': '1', 05:05:34 INFO - 'TERM': 'linux', 05:05:34 INFO - 'TMOUT': '86400', 05:05:34 INFO - 'USER': 'cltbld', 05:05:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:34 INFO - '_': '/tools/buildbot/bin/python'} 05:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:34 INFO - Downloading/unpacking psutil>=3.1.1 05:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:36 INFO - Installing collected packages: psutil 05:05:36 INFO - Running setup.py install for psutil 05:05:36 INFO - building 'psutil._psutil_linux' extension 05:05:36 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:05:36 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:05:36 INFO - building 'psutil._psutil_posix' extension 05:05:36 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:05:36 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:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:36 INFO - Successfully installed psutil 05:05:36 INFO - Cleaning up... 05:05:36 INFO - Return code: 0 05:05:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:36 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:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:36 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:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:36 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:36 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:05:36 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:05:36 INFO - Using env: {'DISPLAY': ':0', 05:05:36 INFO - 'HOME': '/home/cltbld', 05:05:36 INFO - 'LANG': 'en_US.UTF-8', 05:05:36 INFO - 'LANGUAGE': 'en_US:en', 05:05:36 INFO - 'LOGNAME': 'cltbld', 05:05:36 INFO - 'MAIL': '/var/mail/cltbld', 05:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:36 INFO - 'MOZ_NO_REMOTE': '1', 05:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:36 INFO - 'NO_EM_RESTART': '1', 05:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:36 INFO - 'PWD': '/builds/slave/test', 05:05:36 INFO - 'SHELL': '/bin/bash', 05:05:36 INFO - 'SHLVL': '1', 05:05:36 INFO - 'TERM': 'linux', 05:05:36 INFO - 'TMOUT': '86400', 05:05:36 INFO - 'USER': 'cltbld', 05:05:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:36 INFO - '_': '/tools/buildbot/bin/python'} 05:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05: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:05: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:05: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:05: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:05: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:05: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:05:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:38 INFO - Installing collected packages: mozsystemmonitor 05:05:38 INFO - Running setup.py install for mozsystemmonitor 05:05:39 INFO - Successfully installed mozsystemmonitor 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:39 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:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 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:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:39 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:05:39 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:05:39 INFO - Using env: {'DISPLAY': ':0', 05:05:39 INFO - 'HOME': '/home/cltbld', 05:05:39 INFO - 'LANG': 'en_US.UTF-8', 05:05:39 INFO - 'LANGUAGE': 'en_US:en', 05:05:39 INFO - 'LOGNAME': 'cltbld', 05:05:39 INFO - 'MAIL': '/var/mail/cltbld', 05:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:39 INFO - 'MOZ_NO_REMOTE': '1', 05:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:39 INFO - 'NO_EM_RESTART': '1', 05:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:39 INFO - 'PWD': '/builds/slave/test', 05:05:39 INFO - 'SHELL': '/bin/bash', 05:05:39 INFO - 'SHLVL': '1', 05:05:39 INFO - 'TERM': 'linux', 05:05:39 INFO - 'TMOUT': '86400', 05:05:39 INFO - 'USER': 'cltbld', 05:05:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:39 INFO - '_': '/tools/buildbot/bin/python'} 05:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:39 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:05:39 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:05:39 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:05:39 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:05:39 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:05:39 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:05:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:41 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:05:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:41 INFO - warning: no files found matching '*.txt' 05:05:41 INFO - no previously-included directories found matching 'build' 05:05:41 INFO - no previously-included directories found matching 'dist' 05:05:41 INFO - no previously-included directories found matching '.git*' 05:05:41 INFO - Installing collected packages: jsonschema, functools32 05:05:41 INFO - Running setup.py install for functools32 05:05:41 INFO - warning: no files found matching '*.txt' 05:05:41 INFO - no previously-included directories found matching 'build' 05:05:41 INFO - no previously-included directories found matching 'dist' 05:05:41 INFO - no previously-included directories found matching '.git*' 05:05:41 INFO - Successfully installed jsonschema functools32 05:05:41 INFO - Cleaning up... 05:05:41 INFO - Return code: 0 05:05:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05: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:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:41 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:41 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:05:41 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:05:41 INFO - Using env: {'DISPLAY': ':0', 05:05:41 INFO - 'HOME': '/home/cltbld', 05:05:41 INFO - 'LANG': 'en_US.UTF-8', 05:05:41 INFO - 'LANGUAGE': 'en_US:en', 05:05:41 INFO - 'LOGNAME': 'cltbld', 05:05:41 INFO - 'MAIL': '/var/mail/cltbld', 05:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:41 INFO - 'MOZ_NO_REMOTE': '1', 05:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:41 INFO - 'NO_EM_RESTART': '1', 05:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:41 INFO - 'PWD': '/builds/slave/test', 05:05:41 INFO - 'SHELL': '/bin/bash', 05:05:41 INFO - 'SHLVL': '1', 05:05:41 INFO - 'TERM': 'linux', 05:05:41 INFO - 'TMOUT': '86400', 05:05:41 INFO - 'USER': 'cltbld', 05:05:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:41 INFO - '_': '/tools/buildbot/bin/python'} 05:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:41 INFO - Cleaning up... 05:05:41 INFO - Return code: 0 05:05:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05: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:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:41 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:41 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:05:41 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:05:41 INFO - Using env: {'DISPLAY': ':0', 05:05:41 INFO - 'HOME': '/home/cltbld', 05:05:41 INFO - 'LANG': 'en_US.UTF-8', 05:05:41 INFO - 'LANGUAGE': 'en_US:en', 05:05:41 INFO - 'LOGNAME': 'cltbld', 05:05:41 INFO - 'MAIL': '/var/mail/cltbld', 05:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:41 INFO - 'MOZ_NO_REMOTE': '1', 05:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:41 INFO - 'NO_EM_RESTART': '1', 05:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:41 INFO - 'PWD': '/builds/slave/test', 05:05:41 INFO - 'SHELL': '/bin/bash', 05:05:41 INFO - 'SHLVL': '1', 05:05:41 INFO - 'TERM': 'linux', 05:05:41 INFO - 'TMOUT': '86400', 05:05:41 INFO - 'USER': 'cltbld', 05:05:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:41 INFO - '_': '/tools/buildbot/bin/python'} 05:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 INFO - Downloading docopt-0.6.1.tar.gz 05:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:44 INFO - Running setup.py install for blobuploader 05:05:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:44 INFO - Running setup.py install for requests 05:05:45 INFO - Running setup.py install for docopt 05:05:45 INFO - Successfully installed blobuploader requests docopt 05:05:45 INFO - Cleaning up... 05:05:45 INFO - Return code: 0 05:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:45 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:45 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:05:45 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:05:45 INFO - Using env: {'DISPLAY': ':0', 05:05:45 INFO - 'HOME': '/home/cltbld', 05:05:45 INFO - 'LANG': 'en_US.UTF-8', 05:05:45 INFO - 'LANGUAGE': 'en_US:en', 05:05:45 INFO - 'LOGNAME': 'cltbld', 05:05:45 INFO - 'MAIL': '/var/mail/cltbld', 05:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:45 INFO - 'MOZ_NO_REMOTE': '1', 05:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:45 INFO - 'NO_EM_RESTART': '1', 05:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:45 INFO - 'PWD': '/builds/slave/test', 05:05:45 INFO - 'SHELL': '/bin/bash', 05:05:45 INFO - 'SHLVL': '1', 05:05:45 INFO - 'TERM': 'linux', 05:05:45 INFO - 'TMOUT': '86400', 05:05:45 INFO - 'USER': 'cltbld', 05:05:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:45 INFO - '_': '/tools/buildbot/bin/python'} 05:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:45 INFO - Running setup.py (path:/tmp/pip-moffYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:45 INFO - Running setup.py (path:/tmp/pip-eS7QDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:45 INFO - Running setup.py (path:/tmp/pip-aqy9de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:45 INFO - Running setup.py (path:/tmp/pip-tXnLvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:45 INFO - Running setup.py (path:/tmp/pip-avQAfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:45 INFO - Running setup.py (path:/tmp/pip-ztuQkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:46 INFO - Running setup.py (path:/tmp/pip-Hq7ztH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:46 INFO - Running setup.py (path:/tmp/pip-ARH1QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:46 INFO - Running setup.py (path:/tmp/pip-7qzQnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:46 INFO - Running setup.py (path:/tmp/pip-RwKsyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:46 INFO - Running setup.py (path:/tmp/pip-xJXTkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:46 INFO - Running setup.py (path:/tmp/pip-z_v72N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:46 INFO - Running setup.py (path:/tmp/pip-1MmXS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:46 INFO - Running setup.py (path:/tmp/pip-BRSVeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:46 INFO - Running setup.py (path:/tmp/pip-qpCO4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:46 INFO - Running setup.py (path:/tmp/pip-da4xIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:46 INFO - Running setup.py (path:/tmp/pip-klLH2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:46 INFO - Running setup.py install for manifestparser 05:05:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:46 INFO - Running setup.py install for mozcrash 05:05:47 INFO - Running setup.py install for mozdebug 05:05:47 INFO - Running setup.py install for mozdevice 05:05:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozfile 05:05:47 INFO - Running setup.py install for mozhttpd 05:05:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozinfo 05:05:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozInstall 05:05:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozleak 05:05:47 INFO - Running setup.py install for mozlog 05:05:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for moznetwork 05:05:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:47 INFO - Running setup.py install for mozprocess 05:05:48 INFO - Running setup.py install for mozprofile 05:05:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:48 INFO - Running setup.py install for mozrunner 05:05:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:48 INFO - Running setup.py install for mozscreenshot 05:05:48 INFO - Running setup.py install for moztest 05:05:48 INFO - Running setup.py install for mozversion 05:05:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:48 INFO - Cleaning up... 05:05:48 INFO - Return code: 0 05:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05: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:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:48 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:48 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:05:48 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:05:48 INFO - Using env: {'DISPLAY': ':0', 05:05:48 INFO - 'HOME': '/home/cltbld', 05:05:48 INFO - 'LANG': 'en_US.UTF-8', 05:05:48 INFO - 'LANGUAGE': 'en_US:en', 05:05:48 INFO - 'LOGNAME': 'cltbld', 05:05:48 INFO - 'MAIL': '/var/mail/cltbld', 05:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:48 INFO - 'MOZ_NO_REMOTE': '1', 05:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:48 INFO - 'NO_EM_RESTART': '1', 05:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:48 INFO - 'PWD': '/builds/slave/test', 05:05:48 INFO - 'SHELL': '/bin/bash', 05:05:48 INFO - 'SHLVL': '1', 05:05:48 INFO - 'TERM': 'linux', 05:05:48 INFO - 'TMOUT': '86400', 05:05:48 INFO - 'USER': 'cltbld', 05:05:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:48 INFO - '_': '/tools/buildbot/bin/python'} 05:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:48 INFO - Running setup.py (path:/tmp/pip-2Gx8Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:48 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:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:48 INFO - Running setup.py (path:/tmp/pip-5pij2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:48 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:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:48 INFO - Running setup.py (path:/tmp/pip-MB43aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:49 INFO - Running setup.py (path:/tmp/pip-9xaG0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:49 INFO - Running setup.py (path:/tmp/pip-EnxWpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:49 INFO - Running setup.py (path:/tmp/pip-0dsKk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:49 INFO - Running setup.py (path:/tmp/pip-c6278G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:49 INFO - Running setup.py (path:/tmp/pip-iSkHI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:49 INFO - Running setup.py (path:/tmp/pip-p0bRBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:49 INFO - Running setup.py (path:/tmp/pip-I3EF0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:49 INFO - Running setup.py (path:/tmp/pip-mAjh_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:49 INFO - Running setup.py (path:/tmp/pip-XtgwfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:49 INFO - Running setup.py (path:/tmp/pip-xFllCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:49 INFO - Running setup.py (path:/tmp/pip-TmTN5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:49 INFO - Running setup.py (path:/tmp/pip-Q2Lrse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:49 INFO - Running setup.py (path:/tmp/pip-n8GH5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:49 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:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:49 INFO - Running setup.py (path:/tmp/pip-eimCRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:50 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:05:51 INFO - Downloading blessings-1.6.tar.gz 05:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:52 INFO - Installing collected packages: blessings 05:05:52 INFO - Running setup.py install for blessings 05:05:52 INFO - Successfully installed blessings 05:05:52 INFO - Cleaning up... 05:05:52 INFO - Return code: 0 05:05:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:52 INFO - Reading from file tmpfile_stdout 05:05:52 INFO - Current package versions: 05:05:52 INFO - argparse == 1.2.1 05:05:52 INFO - blessings == 1.6 05:05:52 INFO - blobuploader == 1.2.4 05:05:52 INFO - docopt == 0.6.1 05:05:52 INFO - functools32 == 3.2.3-2 05:05:52 INFO - jsonschema == 2.5.1 05:05:52 INFO - manifestparser == 1.1 05:05:52 INFO - mozInstall == 1.12 05:05:52 INFO - mozcrash == 0.17 05:05:52 INFO - mozdebug == 0.1 05:05:52 INFO - mozdevice == 0.48 05:05:52 INFO - mozfile == 1.2 05:05:52 INFO - mozhttpd == 0.7 05:05:52 INFO - mozinfo == 0.9 05:05:52 INFO - mozleak == 0.1 05:05:52 INFO - mozlog == 3.3 05:05:52 INFO - moznetwork == 0.27 05:05:52 INFO - mozprocess == 0.23 05:05:52 INFO - mozprofile == 0.28 05:05:52 INFO - mozrunner == 6.12 05:05:52 INFO - mozscreenshot == 0.1 05:05:52 INFO - mozsystemmonitor == 0.3 05:05:52 INFO - moztest == 0.7 05:05:52 INFO - mozversion == 1.4 05:05:52 INFO - psutil == 3.1.1 05:05:52 INFO - requests == 1.2.3 05:05:52 INFO - wsgiref == 0.1.2 05:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:52 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:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 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:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:52 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:05:52 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:05:52 INFO - Using env: {'DISPLAY': ':0', 05:05:52 INFO - 'HOME': '/home/cltbld', 05:05:52 INFO - 'LANG': 'en_US.UTF-8', 05:05:52 INFO - 'LANGUAGE': 'en_US:en', 05:05:52 INFO - 'LOGNAME': 'cltbld', 05:05:52 INFO - 'MAIL': '/var/mail/cltbld', 05:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:52 INFO - 'MOZ_NO_REMOTE': '1', 05:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:52 INFO - 'NO_EM_RESTART': '1', 05:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:52 INFO - 'PWD': '/builds/slave/test', 05:05:52 INFO - 'SHELL': '/bin/bash', 05:05:52 INFO - 'SHLVL': '1', 05:05:52 INFO - 'TERM': 'linux', 05:05:52 INFO - 'TMOUT': '86400', 05:05:52 INFO - 'USER': 'cltbld', 05:05:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:52 INFO - '_': '/tools/buildbot/bin/python'} 05:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 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:05:52 INFO - Cleaning up... 05:05:52 INFO - Return code: 0 05:05:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:52 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:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 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:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:52 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 0x157b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, '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': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', '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:05:52 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:05:52 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:05:52 INFO - Using env: {'DISPLAY': ':0', 05:05:52 INFO - 'HOME': '/home/cltbld', 05:05:52 INFO - 'LANG': 'en_US.UTF-8', 05:05:52 INFO - 'LANGUAGE': 'en_US:en', 05:05:52 INFO - 'LOGNAME': 'cltbld', 05:05:52 INFO - 'MAIL': '/var/mail/cltbld', 05:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:52 INFO - 'MOZ_NO_REMOTE': '1', 05:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:52 INFO - 'NO_EM_RESTART': '1', 05:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:52 INFO - 'PWD': '/builds/slave/test', 05:05:52 INFO - 'SHELL': '/bin/bash', 05:05:52 INFO - 'SHLVL': '1', 05:05:52 INFO - 'TERM': 'linux', 05:05:52 INFO - 'TMOUT': '86400', 05:05:52 INFO - 'USER': 'cltbld', 05:05:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:52 INFO - '_': '/tools/buildbot/bin/python'} 05:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:52 INFO - Cleaning up... 05:05:52 INFO - Return code: 0 05:05:52 INFO - Running post-action listener: _resource_record_post_action 05:05:52 INFO - Running post-action listener: _start_resource_monitoring 05:05:52 INFO - Starting resource monitoring. 05:05:52 INFO - [mozharness: 2016-10-06 12:05:52.904579Z] Finished create-virtualenv step (success) 05:05:52 INFO - [mozharness: 2016-10-06 12:05:52.905055Z] Running install step. 05:05:52 INFO - Running pre-action listener: _resource_record_pre_action 05:05:52 INFO - Running main action method: install 05:05:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:53 INFO - Reading from file tmpfile_stdout 05:05:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:53 INFO - Reading from file tmpfile_stdout 05:05:53 INFO - Output received: 05:05:53 INFO - Usage: mozinstall [options] installer 05:05:53 INFO - Options: 05:05:53 INFO - -h, --help show this help message and exit 05:05:53 INFO - -d DEST, --destination=DEST 05:05:53 INFO - Directory to install application into. [default: 05:05:53 INFO - "/builds/slave/test"] 05:05:53 INFO - --app=APP Application being installed. [default: firefox] 05:05:53 INFO - mkdir: /builds/slave/test/build/application 05:05:53 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:05:53 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:06:07 INFO - Reading from file tmpfile_stdout 05:06:07 INFO - Output received: 05:06:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:07 INFO - Running post-action listener: _resource_record_post_action 05:06:07 INFO - [mozharness: 2016-10-06 12:06:07.211595Z] Finished install step (success) 05:06:07 INFO - [mozharness: 2016-10-06 12:06:07.211876Z] Running run-tests step. 05:06:07 INFO - Running pre-action listener: _resource_record_pre_action 05:06:07 INFO - Running main action method: run_tests 05:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:07 INFO - Python 2.7.3 05:06:07 INFO - Return code: 0 05:06:07 INFO - grabbing minidump binary from tooltool 05:06:07 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:06:07 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 0x1839570>, '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 0x183a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:07 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:06:07 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:06:07 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:06:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:07 INFO - Return code: 0 05:06:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:07 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/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:06:07 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/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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:06:07 INFO - Using env: {'DISPLAY': ':0', 05:06:07 INFO - 'HOME': '/home/cltbld', 05:06:07 INFO - 'LANG': 'en_US.UTF-8', 05:06:07 INFO - 'LANGUAGE': 'en_US:en', 05:06:07 INFO - 'LOGNAME': 'cltbld', 05:06:07 INFO - 'MAIL': '/var/mail/cltbld', 05:06:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:07 INFO - 'MOZ_NO_REMOTE': '1', 05:06:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:07 INFO - 'NO_EM_RESTART': '1', 05:06:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:07 INFO - 'PWD': '/builds/slave/test', 05:06:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:07 INFO - 'SHELL': '/bin/bash', 05:06:07 INFO - 'SHLVL': '1', 05:06:07 INFO - 'TERM': 'linux', 05:06:07 INFO - 'TMOUT': '86400', 05:06:07 INFO - 'USER': 'cltbld', 05:06:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806', 05:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:07 INFO - '_': '/tools/buildbot/bin/python'} 05:06:07 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/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:06:07 INFO - mozversion application_buildid: 20161006020700 05:06:07 INFO - mozversion application_changeset: 37417e763286faffc6d50d93fe0fee3da795dee7 05:06:07 INFO - mozversion application_display_name: Firefox 05:06:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:07 INFO - mozversion application_name: Firefox 05:06:07 INFO - mozversion application_remotingname: firefox 05:06:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:06:07 INFO - mozversion application_vendor: Mozilla 05:06:07 INFO - mozversion application_version: 50.0 05:06:07 INFO - mozversion platform_buildid: 20161006020700 05:06:07 INFO - mozversion platform_changeset: 37417e763286faffc6d50d93fe0fee3da795dee7 05:06:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:06:07 INFO - mozversion platform_version: 50.0 05:06:07 INFO - using testdate: 1475755567 05:06:07 INFO - actual date: 1475755567 05:06:07 INFO - starting webserver on 'localhost:38158' 05:06:07 INFO - SUITE-START | Running 2 tests 05:06:07 INFO - TEST-START | dromaeo_css 05:06:07 INFO - operating with platform_type : linux_ 05:06:07 INFO - Initialising browser for dromaeo_css test... 05:06:07 INFO - TEST-INFO | started process 29101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFfuFI/profile http://localhost:38158/getInfo.html) 05:06:11 INFO - PROCESS | 29101 | __metrics Screen width/height:1600/1200 05:06:11 INFO - PROCESS | 29101 | colorDepth:24 05:06:11 INFO - PROCESS | 29101 | Browser inner width/height: 1024/697 05:06:11 INFO - PROCESS | 29101 | __metrics 05:06:12 ERROR - PROCESS | 29101 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:06:13 INFO - TEST-INFO | 29101: exit 0 05:06:13 INFO - Browser initialized. 05:06:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:13 INFO - TEST-INFO | started process 29223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFfuFI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:25 INFO - PROCESS | 29223 | RSS: Main: 150134784 05:06:25 INFO - PROCESS | 29223 | 05:07:14 INFO - PROCESS | 29223 | 1475755634715 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:09:23 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38158/tests/dromaeo/cssquery-ext.html) 05:09:24 INFO - PROCESS | 29223 | RSS: Main: 158076928 05:09:24 INFO - PROCESS | 29223 | 05:12:26 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-ext.html (next: http://localhost:38158/tests/dromaeo/cssquery-jquery.html) 05:12:26 INFO - PROCESS | 29223 | RSS: Main: 155189248 05:12:26 INFO - PROCESS | 29223 | 05:15:28 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38158/tests/dromaeo/cssquery-mootools.html) 05:15:29 INFO - PROCESS | 29223 | RSS: Main: 154537984 05:15:29 INFO - PROCESS | 29223 | 05:18:30 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38158/tests/dromaeo/cssquery-prototype.html) 05:18:31 INFO - PROCESS | 29223 | RSS: Main: 156327936 05:18:31 INFO - PROCESS | 29223 | 05:21:33 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38158/tests/dromaeo/cssquery-yui.html) 05:21:34 INFO - PROCESS | 29223 | RSS: Main: 157278208 05:21:34 INFO - PROCESS | 29223 | 05:24:36 INFO - PROCESS | 29223 | Cycle 1(1): loaded http://localhost:38158/tests/dromaeo/cssquery-yui.html (next: http://localhost:38158/tests/dromaeo/cssquery-dojo.html) 05:24:37 INFO - PROCESS | 29223 | RSS: Main: 157601792 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | __start_tp_report 05:24:37 INFO - PROCESS | 29223 | _x_x_mozilla_page_load 05:24:37 INFO - PROCESS | 29223 | _x_x_mozilla_page_load_details 05:24:37 INFO - PROCESS | 29223 | |i|pagename|runs| 05:24:37 INFO - PROCESS | 29223 | |0;dojo.html;3254.5280934264533;3266.4447044002522;3279.966810454707;3294.6046474423074;3299.977007127791;5739.167820666001;5811.941880581204;5812.825615231539;5839.299284085911;5854.736536855847;5872.677002764846;5894.49896758775;5905.291365036191;5913.852153696149;5928.5553583481305;5285.920711189336;5342.946570534284;5351.170568561879;5402.540784033362;5437.02133615951;5386.1920711893135;5390.326209223847;5395.460453954613;5403.351597808269;5405.081136206854;5268.5521730652945;5279.260903473517;5400.78396864125;5411.512963833255;5440.483154100354;5228.633995620289;5283.128283833163;5331.333583302087;5408.2698835657275;5411.350637923474;5248.763805628756;5335.573154147698;5337.653052551611;5357.464253574651;5359.115745901921;5819.912701309484;5821.825345239649;5877.324107727581;5923.763049478016;5932.3474417814;6043;6144.740328232746;6154.107654390134;6189.659568723719;6339.619622822645;6346.174997250328;6352.809415717536;6354.523410744213;6355.8411039723915;6359.745610175587;5916.556258280646;5921.585489015728;5922.703864806743;5925.525957923356;5939.316978547479;6146.5390095743;6216.564840461215;6293.874122517615;6308.463780578702;6409.647469389229;6128.78549250783;6161.907571386433;6179.752809887644;6180.81457556274;6191.040388739752;6241.812745617639;6288.811335659938;6301.6219026858535;6315.96842015787;6316.210473690789;6030.065339872327;6083.695815209222;6115.510759139258;6134.202553668084;6185.84535386619;6127.632342059402;6138.263408390932;6157.353477884847;6172.660503672251;6178.783742568989;4699.083678682624;4700.036492519025;4706.670533062653;4712.858614241578;4734.644901632391;4125.401816736557;4178.770167640809;4203.117345357448;4221.261279276176;4284.721493102938;6000.789972350947;6060.727267272983;6086.056661217518;6090.269167699905;6096.969515152396;6312;6334.493240540745;6347.333529979378;6352.777652782131;6366.6180029198395;5754.769809207585;5964.7315870785915;6005.159277701126;6013.067974463965;6094.268687757498;5202.03762303975;5216;5222.947770522323;5233.188855727369;5264.921026184534;6282.18331616896;6529.673516324165;6540.640264785482;6542.182227221598;6581.539292249592;6114.205153330038;6123.44595874501;6128.411459112376;6239.344868788893;6247.187865577446;6386.584871983307;6430.935690643221;6434.935650643433;6443.6133831968355;6450.451711604378;5919.881602367843;6139.754409823736;6145.784897528565;6146.416090471398;6152.077188421773;6113.3546859767275;6131.877362452815;6153.969230153821;6237.282712488122;6243.282022567281;6088.878222435438;6089.056196289582;6091.0558863376245;6097.0317869630835;6138.815835524942;5986.341502434641;6068.362821903636;6086.482648974887;6091.086337049478;6095.695215239309;6000.399960003964;6025.337212906665;6075.1191077294425;6145.740123274807;6154.261488621215;6185.6907154641185;6204.689765511796;6226.25284965807;6251.937480625317;6252.562320637694;5833.737481813413;6014.097885317237;6036.6679832609625;6075.3317135115985;6090.025595904634 05:24:37 INFO - PROCESS | 29223 | |1;ext.html;598.892199404107;643.9130717353157;672.6771149848073;681.3765404654739;721.3543878228982;41750.58249417505;46330.53669463305;46381.30428043582;46745.29882051767;46825.8293542662;47529;48253.7587312063;48502.757486212606;48595.27107093388;48599.51400486003;9047.230985366252;9190.724278271662;9203;9204.263658907272;9217;9141.040190779971;9198;9228.723138305862;9241.260699144086;9259.444433333987;9199.310051746146;9262;9276.933152687427;9280.443173409583;9290.1174388433;9247.6300947962;9255.028222036657;9258.120478554527;9292.53537323131;9294.163525282724;9119.544022798833;9192.172704456563;9207.631694732203;9211.907880921239;9219.078092190794;43520;43621.781891090344;43705.56294437047;44017;44091;3667.174885650734;3741.28915506053;3845.730798844082;3877.1082650990147;3929.292727309083;35324.11689707778;35646.46530302048;35742.642573574194;35823.10442238939;35901.64098359009;4162.188373267214;4291.849785257532;4295.506016808075;4332;4508.504064552896;380476;381174.9999999972;382176;382973;384241;67038.32961670321;67659;67896.32103678999;68044;68103;41737.373939390935;42261.57738422638;42634.57365426368;42662.57337426648;72564.27435725575;18175.818241817677;18309.45071647853;18359;18381.08094595265;18401.90799045996;13576.660583485493;13630.795538066937;13647;13715.588532344045;13717;21259.149634014466;21487.570248595253;21574.78425215759;21664.458388540414;21678.783212167993;7459.179490256068;7715.92284077152;7819.139894611588;7860.371170306362;7936.444448888637;1049.8897615750236;1088.2926098036182;1109.434188563822;1121.1367247219596;1142.605800998654;34457.655423445445;34483.13792155216;34860.30279394398;34898.302033959684;35083.824580876935;1193.0813273779315;1206.324458303353;1240.0513607090584;1242.8322176506056;1255.8681338459512;18133.546661333574;18281;18295.817041829676;18416;18465;617293;628431;629002;630379;630572;64477.677611611645;64903.675481623235;65054.34945650578;65242;65543.34456655373;1447.3703938786662;1449.8042764226905;1463.1806188534667;1465.2087872548705;1478.4529724001973;32025.67974320227;33510;33523.48525575861;33827;33956;56105;56239;56390.154147687;56604.88673123018;56803;492311;494590;496518;497000;498978;31365.21586960253;31569;31741;31918.202044949063;32015.199620009687;53345;53517;53773.462265376846;54033;54157.72921135369;44501;46335.536644633125;46875.29687054765;47344.28983565318;47384.05231895274;46332.53667463417;47568.286475703586;47834;48178.27732584084;48380.51619483901;38886.222275554894;44282;44766;44773.776131119135;46733.532664672915;38858.4171237426;38889;39627.405588916765;39720.602793972845;39865.60134398735;30260;30589.23526911845;30620.114539329414;31304.843475782476;31349.68650313559 05:24:37 INFO - PROCESS | 29223 | |2;jquery.html;420.2121023081722;427.76045414567835;430.9845000193268;436.53727049327716;437.5318409302048;19139.234430622775;20290.18839246432;20771.584568308645;20964.8951755241;21073.57852842942;19359.612807743837;20065.89967050163;20600.484987875312;20873.165073397045;20936.057877395517;5959.106134079891;6176.876462470748;6178.783742569011;6193.7832175873855;6196.87606247877;6060.757569697207;6105.419985101408;6137.9079313810325;6140.631562106288;6152.753889844401;6075.817725468243;6102.633841969496;6114.541409394291;6124.112003759475;6125;6001.87996240075;6017.608855424405;6028.517718582503;6062.514998800129;6091.786787462417;5180;5464;5470.152126420371;5488.807891723811;5489.066858634002;14923.925380373028;15107.848921510755;15157.545273641808;15450.227488625524;15472.845271547252;2366.432056306491;2397.7961873240797;2490.6139548370033;2593.4424098818654;2847.729465700755;10114.848277275847;10246.18030557561;10421.218408619308;10664.626738064131;10906.345619262791;2005.7091721700272;2056.5372791122027;2106.9051892664716;2231.1967691631;2250.1336985260627;81896;93522;95005;95806.52096739471;99663.50168249184;18950;19130.426087217405;19485.318013869448;19710.211591536463;20043.799562004486;34949;35172.29655406877;35428.29143417117;35508.82245588807;35994;10372.948135259276;10446.791064178673;10576.94711526453;10584.417857017937;10865.45672716361;8734.781630459162;8852.336074794417;8867.68963086289;9080.772980675536;9093.590788414538;9555.27674612732;9735.805283894282;9746.658866939764;9918.25613079022;9935.155511781435;3675.9816200918826;3711.4247291669835;3714.0714821294678;3821.4840996465678;3858.305505009125;899.9415038022507;1023.8157131716214;1032.1691038713907;1086.2342048855537;1098.9725256868483;20490;20741;20827.8958605206;20929.790702093087;20943.581128377347;997.9401235925868;1047.9580816767395;1048.6749107776461;1050.1388861133796;1102;11312.321260724382;11382.089432845352;11768;11776.646700598996;11792.587259445878;514962;516739;524094;529017;532311;94285;96895;97507.51246243865;97755.51122244485;99182;990.4453506036642;993.895640957689;1001.7645853224486;1007.4056306779036;1053.594366169015;18024.909875451063;18171.727424088385;18541.516678665943;18546.81453185505;18773;28730.281742956595;34514.82742586271;41043.38434923419;44403;44720.32919506275;56021.87956240771;59459;60137.39862601318;61143.38856611377;61304;7998.120206777134;8465.238128568459;8557.400981931205;9230.584623692084;9517.381370210915;13023.739525209632;13721.176729396268;13868.098573592684;14141.363638636492;14295.642608934444;12127.454264558293;12130.93934530357;12137.69655758613;12311;12487.500499979898;12058;12284.877151228373;12387.256764594153;12421.130520863453;12542.310172940211;12328.876711233132;12411.503539858304;12561.656040176566;12652.051096167641;12662.873371266169;8493.702720405003;8514.574271286287;8539.359548034046;8680.739577812676;8770.07914169003;11567.190296679151;12278;12526.624201273977;12839.614811555668;12845.614631561068 05:24:37 INFO - PROCESS | 29223 | |3;mootools.html;1560.758082497213;1574.197159448681;1743.1545700335334;1854.9258029678813;1897.6963685810274;8680.8697869532;9298.395604285724;9426.905730942688;10023;10029.799404011916;9537.95231023844;9952.303338766289;9954.253430992669;9972.202223822076;9977.151942084913;2587.534243836104;2637.749413805695;2640.0627777139125;2642.6432431621774;2643.1145566235236;2553.5148321818797;2593.442409881875;2594.6367508548724;2600.0769726747017;2616.751408616178;2568.858712770806;2571.1643715792347;2573.794096472278;2585.6380106785064;2592.844429334246;2519.86140762258;2525.4065294655743;2535.4168541235617;2538.073603134861;2549.4008907906627;2483.6398722185363;2487.5522405966917;2498.5877330240487;2532.050481069599;2537.0232460502657;9898.703038908845;9949.20406367496;10019;10049.196064314838;10056.044675755791;5880.882382352372;5986.2217911671205;6011.75952961881;6015.157877897098;6017.939820601781;3479.460683594047;3607.1703508193;3620.8956268338147;3650.8539658413633;3663.7069034477177;1084.078533246742;1121.472907733364;1122.1752012270974;1136.3920302638132;1154.1459320103147;13963.79054314186;14006.71986560263;14054.437822487089;14073.929630351988;14086.506972255922;5211;5260.736963151827;5356.3572371315695;5424.186372044225;5470.398256191816;11762.470688819023;11867.643970680894;11871.703207419883;11887.821682674767;11902.464389102512;6077.301110372276;6079.05774604937;6089.1779609753;6097.298810636834;6138.355472675394;4885.41375034991;5319;5528.9723551381985;5533;5541.9168712469345;4476.768888555674;4509.458864936229;4555.612772914273;4565.863024109282;4568.428946381702;1416.3414012484038;1452.5424491285212;1455.3669153918079;1458.4385011770332;1467.0317590390505;1046.220565678559;1050.0654417568371;1056.3767377247461;1065.658989123473;1066.8933106689424;6441.935580644227;6535.281119076898;6693.397594216543;6729.798106056826;6766.72933082681;480.2028632470083;487.43214155509145;1053.1732589916878;1066.7013236293851;1073.7154654016692;4307.164392256459;4338.891527711769;4449.221386257392;4479.417675702138;4545.159145558082;12276.140670153181;12644.241345519298;12659.746805064031;12665;12702.237865728086;12151.635450936486;12377.876221237853;12448.31534265606;12474;12589.370531473389;8712.259457946146;8788.8681669775;8906.198442140108;8908.10918908117;8923.687670931617;6341.112244285711;6355.52333574993;6446.065320528403;6546.24718157418;6571.539992200691;10622.309549879234;10715.35707857531;10738.463076846283;10777;10855.891441085803;10791.838122428013;10962.232643714864;11042.834357484804;11057.723556911142;11091.889081109086;8342.83314333722;8379.95810020946;8420.452670576393;8484.745457636282;8546.829063418572;9479.431234125974;9480;9498.667546635834;9547.093026162504;9630.903690963001;8337.08292087882;8557.700480483154;8564.272036876686;8603.65585376603;8726.171013753683;8145.389095817719;8161.265486106042;8185.30424913889;8260.463069900437;8399.286060684666;7251.746188883575;7437.51656142349;7489;7618.238176182559;7645.159032506309;5555.805546805843;5616.747246374005;5636.351819540805;5690.9430905690415;5833.270841144857;5785.797497087582;5897.852553686193;5906;5985.042393217064;6010.398960103955 05:24:37 INFO - PROCESS | 29223 | |4;prototype.html;359.175691787348;359.32626325639427;366.12678761154655;367.89882782234866;369.95375578052744;5780.219670344502;5801.8106288210865;5807.303123625165;5830.766769329232;5850.795222167225;5516.24187906047;5672.68800215988;5738.942610573893;5749.281339832521;5766.606858153871;4503.369528266046;4503.864884053467;4507.842225522108;4541.114482675879;4561.270196768518;4514.097180563884;4530.524294949032;4535.977320113395;4558.2251017327135;4560.1335746208115;4419.558044195571;4496.2581174106235;4502.549745025504;4504.7747612619405;4532.705374150686;4453;4466.620337271336;4470.240059189946;4473.329000649896;4495.932561011571;3980.86066987654;3989.7606143631474;3991.98004009981;4011.4785077939973;4019.075612609087;5470.152126420411;5505.229267902497;5597.44025597441;5597.944020559783;5612.186232996192;5109.667871588372;5113.2330150477355;5121.385433747974;5158.123119069767;5197.922031169535;5919.0404797601195;5943.970280148615;5973.402659734035;5984.790532331391;5989.730462129215;4311.935320970188;4363.956360436387;4374.993751437156;4423.778811059434;4457.754823484707;5941.346451890288;6137.938620613826;6152.87694246117;6156.230471191101;6162.582606000645;4353.4122893408985;4387.210302145644;4405.449318835145;4426.3581780641625;4426.605619229932;4467.865964021084;4474.821007159742;4478.708883922534;4486.237339652267;4493.146302202571;4953.910139769245;5063.341765570526;5098.719570423662;5117.948820511821;5131.717755523482;5987.520998320124;5990.9700451497465;6009.1587177795145;6009.188759517497;6103.633781973096;1537.8769698424098;1553.5339398180502;1554.6657468644296;1556.9610759730872;1557.2603013568464;933.6229062133299;990.0544979544518;990.3513198854762;994.1649014827435;999.7900440907491;5149.910053967665;5159.871003224949;5195.740212989335;5195.766190521435;5218.321618189611;5410.864728381822;5416.0792665247;5461.972690136603;5466.72666366688;5489.752961116759;4954.6374746944875;5126.79492820283;5157.226416037624;5162.586993040548;5213.2701421800975;2856.043225519433;2900.8259504429802;2908.022544669645;2908.476474234658;2918.9854050730037;5495.862603434946;5561.360443548962;5587.451968000349;5589.692566908859;5596.496315331558;5075.462268865567;5409.864753381197;5427.29445172133;5452.890942181213;5491.901619676001;5543.417941116206;5562.527185189223;5586.944130558642;5612.382637909826;5623.104101387788;5176.498815343508;5378.515933565841;5386.596005299697;5405.567554595702;5414.810481633124;5296.443873393392;5318.228856815817;5330.360356757214;5334.732738586163;5344.545713614386;6188;6446.806595802133;6462.676866156579;6474.838129046811;6483.967580162069;4430.3575981483145;4493.404841281298;4499.775011249359;4512.706674066307;4529.637628989607;6113.480354169767;6264.590467144856;6296.496280297473;6329.461995730415;6337.904931426125;6087.386842486656;6100.145979562776;6107.297660769068;6131.9269127903335;6144.678894037804;5901.822945311647;6084.170860549865;6112.755489780359;6121.969390153021;6178.691065446799;5998.7300571473515;6052.243469566304;6053.549476798183;6064.909026364697;6068.757249710139;6113.29697084841;6135.202423684892;6143.447089761943;6150.292716337678;6213.65824879636;5772.480476757112;5906.675132867734;5959.642421454727;5978.953683105527;5985.970070149621 05:24:37 INFO - PROCESS | 29223 | |5;yui.html;786;819.4509678515398;831.3640065350006;858.6479543387211;885.3625389719408;14419.495317663885;14682;14834.109953402804;14836.777448338271;14891;14561.126332420035;14839.109653420803;14855;14856.48002319919;14893.329800158992;739.6560599321315;858.2275951643539;872.1235158665532;877.3156937588675;882.4925667741043;894.2309613732185;897.878786363839;900.9369344145913;903.8192361527688;903.9954800225989;932.9877083364557;941.7080704981444;942.3215284994827;944.1361154543584;944.9574769135405;933.5378987401245;933.9626414943394;935.1536859142487;939.3143005605912;940.1209868772719;686.9862602747917;688.7761477519776;690.7513295213719;691.1982100763091;692.1728534401392;13728.862711372958;13804.102733322303;13826.101303415346;13839.169649821042;13851.238181899991;14297.213653249068;15915.920420397939;16528;16706.665866682597;16997.915010424993;13652.24912629805;13881.930590347085;13979.23114228717;14021.719565608733;14137.293135343192;4160.958390416087;4193.895152621179;4280.079782846703;4904.509549045067;4994.625403094782;81249.59375203087;82509;82808.58595706982;83963.5801820987;83969;12647.620571382873;12685.873141268654;12783.744325113446;12796.680082997813;12844.743105138032;22628.660570091462;22669.2065777697;22714.772852271264;22747.545049098924;22842.54314913726;8202.794930126794;8505.82988340242;8605.13948605147;9086.36395452312;9176.44941303524;4833.9033219335415;5039.496050394931;5131.794728210904;5137.794488220429;5203.245529398292;3934.1934903344745;4001.0197501612292;4047.7571345719352;4081.89795255121;4086.0806318578084;672.5729161982176;676.4047638078459;680.5089888870164;688.5386790850142;688.5421194905332;791.7070683847013;835.9874601880977;840.6385254340693;858.1375717404094;867.2714919467552;10507.947460262803;10602.562765920575;10811.56753729842;10901.454927253606;11727.35499547516;688.5042769206163;749.5240522268399;770.9190534993857;825.8018075661918;854.9358798090168;5074.3657042869645;5180.585553155738;5212.609054320941;5270.815521456807;5284.445133260952;75225.24774752292;75503;76472.61763691145;95425.52287238519;123281.76718232883;112671;117449.47651570466;119448;119510.4024479872;120878.3956080214;56960.43039569551;58759.70620146872;62033.689831551455;80874;95905.5204723972;10164;10566.26036177491;10647.733806654896;10986.294433882134;11198.552057917592;49327.50672493373;56552.717236413555;56990.71504642616;57578.7121064392;57926.420735792104;49265;51866.48133518767;52138.73930630474;61355.386446134966;74652;13757.656058598215;13824.170549767046;14631.414743410145;14837.92581037088;15880.761788572949;15361.6159596011;15527.767083493982;15575.299111539782;15771.132587707327;16576.917115414344;15356.846431535989;15406.897441111507;15471.303791329192;15841.68316633684;16139;15304.158271295186;15493.380264789283;15534.067955922681;15853.603659908595;15999.040057596581;15119.622009449851;15194.544163675107;15418.922905385401;15685.843141568896;16134.838651613334;11537.043495590788;11782;11960.880391196324;12049.698757531132;12271.631851044483;12779;13116;13213.655970751468;13480;13730.519431820238 05:24:37 INFO - PROCESS | 29223 | __end_tp_report 05:24:37 INFO - PROCESS | 29223 | __start_cc_report 05:24:37 INFO - PROCESS | 29223 | _x_x_mozilla_cycle_collect,340 05:24:37 INFO - PROCESS | 29223 | __end_cc_report 05:24:37 INFO - PROCESS | 29223 | __startTimestamp1475756677099__endTimestamp 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | ------- Summary: start ------- 05:24:37 INFO - PROCESS | 29223 | Number of tests: 6 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#0] dojo.html Cycles:165 Average:5802.22 Median:6075.33 stddev:674.44 (11.1%) stddev-sans-first:646.22 05:24:37 INFO - PROCESS | 29223 | Values: 3254.5 3266.4 3280.0 3294.6 3300.0 5739.2 5811.9 5812.8 5839.3 5854.7 5872.7 5894.5 5905.3 5913.9 5928.6 5285.9 5342.9 5351.2 5402.5 5437.0 5386.2 5390.3 5395.5 5403.4 5405.1 5268.6 5279.3 5400.8 5411.5 5440.5 5228.6 5283.1 5331.3 5408.3 5411.4 5248.8 5335.6 5337.7 5357.5 5359.1 5819.9 5821.8 5877.3 5923.8 5932.3 6043.0 6144.7 6154.1 6189.7 6339.6 6346.2 6352.8 6354.5 6355.8 6359.7 5916.6 5921.6 5922.7 5925.5 5939.3 6146.5 6216.6 6293.9 6308.5 6409.6 6128.8 6161.9 6179.8 6180.8 6191.0 6241.8 6288.8 6301.6 6316.0 6316.2 6030.1 6083.7 6115.5 6134.2 6185.8 6127.6 6138.3 6157.4 6172.7 6178.8 4699.1 4700.0 4706.7 4712.9 4734.6 4125.4 4178.8 4203.1 4221.3 4284.7 6000.8 6060.7 6086.1 6090.3 6097.0 6312.0 6334.5 6347.3 6352.8 6366.6 5754.8 5964.7 6005.2 6013.1 6094.3 5202.0 5216.0 5222.9 5233.2 5264.9 6282.2 6529.7 6540.6 6542.2 6581.5 6114.2 6123.4 6128.4 6239.3 6247.2 6386.6 6430.9 6434.9 6443.6 6450.5 5919.9 6139.8 6145.8 6146.4 6152.1 6113.4 6131.9 6154.0 6237.3 6243.3 6088.9 6089.1 6091.1 6097.0 6138.8 5986.3 6068.4 6086.5 6091.1 6095.7 6000.4 6025.3 6075.1 6145.7 6154.3 6185.7 6204.7 6226.3 6251.9 6252.6 5833.7 6014.1 6036.7 6075.3 6090.0 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#1] ext.html Cycles:180 Average:67120.71 Median:44391.50 stddev:135999.98 (306.4%) stddev-sans-first:136289.78 05:24:37 INFO - PROCESS | 29223 | Values: 598.9 643.9 672.7 681.4 721.4 41750.6 46330.5 46381.3 46745.3 46825.8 47529.0 48253.8 48502.8 48595.3 48599.5 9047.2 9190.7 9203.0 9204.3 9217.0 9141.0 9198.0 9228.7 9241.3 9259.4 9199.3 9262.0 9276.9 9280.4 9290.1 9247.6 9255.0 9258.1 9292.5 9294.2 9119.5 9192.2 9207.6 9211.9 9219.1 43520.0 43621.8 43705.6 44017.0 44091.0 3667.2 3741.3 3845.7 3877.1 3929.3 35324.1 35646.5 35742.6 35823.1 35901.6 4162.2 4291.8 4295.5 4332.0 4508.5 380476.0 381175.0 382176.0 382973.0 384241.0 67038.3 67659.0 67896.3 68044.0 68103.0 41737.4 42261.6 42634.6 42662.6 72564.3 18175.8 18309.5 18359.0 18381.1 18401.9 13576.7 13630.8 13647.0 13715.6 13717.0 21259.1 21487.6 21574.8 21664.5 21678.8 7459.2 7715.9 7819.1 7860.4 7936.4 1049.9 1088.3 1109.4 1121.1 1142.6 34457.7 34483.1 34860.3 34898.3 35083.8 1193.1 1206.3 1240.1 1242.8 1255.9 18133.5 18281.0 18295.8 18416.0 18465.0 617293.0 628431.0 629002.0 630379.0 630572.0 64477.7 64903.7 65054.3 65242.0 65543.3 1447.4 1449.8 1463.2 1465.2 1478.5 32025.7 33510.0 33523.5 33827.0 33956.0 56105.0 56239.0 56390.2 56604.9 56803.0 492311.0 494590.0 496518.0 497000.0 498978.0 31365.2 31569.0 31741.0 31918.2 32015.2 53345.0 53517.0 53773.5 54033.0 54157.7 44501.0 46335.5 46875.3 47344.3 47384.1 46332.5 47568.3 47834.0 48178.3 48380.5 38886.2 44282.0 44766.0 44773.8 46733.5 38858.4 38889.0 39627.4 39720.6 39865.6 30260.0 30589.2 30620.1 31304.8 31349.7 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#2] jquery.html Cycles:180 Average:31553.63 Median:15789.01 stddev:86293.17 (546.5%) stddev-sans-first:86503.58 05:24:37 INFO - PROCESS | 29223 | Values: 420.2 427.8 431.0 436.5 437.5 19139.2 20290.2 20771.6 20964.9 21073.6 19359.6 20065.9 20600.5 20873.2 20936.1 5959.1 6176.9 6178.8 6193.8 6196.9 6060.8 6105.4 6137.9 6140.6 6152.8 6075.8 6102.6 6114.5 6124.1 6125.0 6001.9 6017.6 6028.5 6062.5 6091.8 5180.0 5464.0 5470.2 5488.8 5489.1 14923.9 15107.8 15157.5 15450.2 15472.8 2366.4 2397.8 2490.6 2593.4 2847.7 10114.8 10246.2 10421.2 10664.6 10906.3 2005.7 2056.5 2106.9 2231.2 2250.1 81896.0 93522.0 95005.0 95806.5 99663.5 18950.0 19130.4 19485.3 19710.2 20043.8 34949.0 35172.3 35428.3 35508.8 35994.0 10372.9 10446.8 10576.9 10584.4 10865.5 8734.8 8852.3 8867.7 9080.8 9093.6 9555.3 9735.8 9746.7 9918.3 9935.2 3676.0 3711.4 3714.1 3821.5 3858.3 899.9 1023.8 1032.2 1086.2 1099.0 20490.0 20741.0 20827.9 20929.8 20943.6 997.9 1048.0 1048.7 1050.1 1102.0 11312.3 11382.1 11768.0 11776.6 11792.6 514962.0 516739.0 524094.0 529017.0 532311.0 94285.0 96895.0 97507.5 97755.5 99182.0 990.4 993.9 1001.8 1007.4 1053.6 18024.9 18171.7 18541.5 18546.8 18773.0 28730.3 34514.8 41043.4 44403.0 44720.3 56021.9 59459.0 60137.4 61143.4 61304.0 7998.1 8465.2 8557.4 9230.6 9517.4 13023.7 13721.2 13868.1 14141.4 14295.6 12127.5 12130.9 12137.7 12311.0 12487.5 12058.0 12284.9 12387.3 12421.1 12542.3 12328.9 12411.5 12561.7 12652.1 12662.9 8493.7 8514.6 8539.4 8680.7 8770.1 11567.2 12278.0 12526.6 12839.6 12845.6 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#3] mootools.html Cycles:180 Average:6447.89 Median:4463.00 stddev:3708.38 (83.1%) stddev-sans-first:3700.60 05:24:37 INFO - PROCESS | 29223 | Values: 1560.8 1574.2 1743.2 1854.9 1897.7 8680.9 9298.4 9426.9 10023.0 10029.8 9538.0 9952.3 9954.3 9972.2 9977.2 2587.5 2637.7 2640.1 2642.6 2643.1 2553.5 2593.4 2594.6 2600.1 2616.8 2568.9 2571.2 2573.8 2585.6 2592.8 2519.9 2525.4 2535.4 2538.1 2549.4 2483.6 2487.6 2498.6 2532.1 2537.0 9898.7 9949.2 10019.0 10049.2 10056.0 5880.9 5986.2 6011.8 6015.2 6017.9 3479.5 3607.2 3620.9 3650.9 3663.7 1084.1 1121.5 1122.2 1136.4 1154.1 13963.8 14006.7 14054.4 14073.9 14086.5 5211.0 5260.7 5356.4 5424.2 5470.4 11762.5 11867.6 11871.7 11887.8 11902.5 6077.3 6079.1 6089.2 6097.3 6138.4 4885.4 5319.0 5529.0 5533.0 5541.9 4476.8 4509.5 4555.6 4565.9 4568.4 1416.3 1452.5 1455.4 1458.4 1467.0 1046.2 1050.1 1056.4 1065.7 1066.9 6441.9 6535.3 6693.4 6729.8 6766.7 480.2 487.4 1053.2 1066.7 1073.7 4307.2 4338.9 4449.2 4479.4 4545.2 12276.1 12644.2 12659.7 12665.0 12702.2 12151.6 12377.9 12448.3 12474.0 12589.4 8712.3 8788.9 8906.2 8908.1 8923.7 6341.1 6355.5 6446.1 6546.2 6571.5 10622.3 10715.4 10738.5 10777.0 10855.9 10791.8 10962.2 11042.8 11057.7 11091.9 8342.8 8380.0 8420.5 8484.7 8546.8 9479.4 9480.0 9498.7 9547.1 9630.9 8337.1 8557.7 8564.3 8603.7 8726.2 8145.4 8161.3 8185.3 8260.5 8399.3 7251.7 7437.5 7489.0 7618.2 7645.2 5555.8 5616.7 5636.4 5690.9 5833.3 5785.8 5897.9 5906.0 5985.0 6010.4 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#4] prototype.html Cycles:180 Average:4913.78 Median:5410.36 stddev:1420.74 (26.3%) stddev-sans-first:1382.98 05:24:37 INFO - PROCESS | 29223 | Values: 359.2 359.3 366.1 367.9 370.0 5780.2 5801.8 5807.3 5830.8 5850.8 5516.2 5672.7 5738.9 5749.3 5766.6 4503.4 4503.9 4507.8 4541.1 4561.3 4514.1 4530.5 4536.0 4558.2 4560.1 4419.6 4496.3 4502.5 4504.8 4532.7 4453.0 4466.6 4470.2 4473.3 4495.9 3980.9 3989.8 3992.0 4011.5 4019.1 5470.2 5505.2 5597.4 5597.9 5612.2 5109.7 5113.2 5121.4 5158.1 5197.9 5919.0 5944.0 5973.4 5984.8 5989.7 4311.9 4364.0 4375.0 4423.8 4457.8 5941.3 6137.9 6152.9 6156.2 6162.6 4353.4 4387.2 4405.4 4426.4 4426.6 4467.9 4474.8 4478.7 4486.2 4493.1 4953.9 5063.3 5098.7 5117.9 5131.7 5987.5 5991.0 6009.2 6009.2 6103.6 1537.9 1553.5 1554.7 1557.0 1557.3 933.6 990.1 990.4 994.2 999.8 5149.9 5159.9 5195.7 5195.8 5218.3 5410.9 5416.1 5462.0 5466.7 5489.8 4954.6 5126.8 5157.2 5162.6 5213.3 2856.0 2900.8 2908.0 2908.5 2919.0 5495.9 5561.4 5587.5 5589.7 5596.5 5075.5 5409.9 5427.3 5452.9 5491.9 5543.4 5562.5 5586.9 5612.4 5623.1 5176.5 5378.5 5386.6 5405.6 5414.8 5296.4 5318.2 5330.4 5334.7 5344.5 6188.0 6446.8 6462.7 6474.8 6484.0 4430.4 4493.4 4499.8 4512.7 4529.6 6113.5 6264.6 6296.5 6329.5 6337.9 6087.4 6100.1 6107.3 6131.9 6144.7 5901.8 6084.2 6112.8 6122.0 6178.7 5998.7 6052.2 6053.5 6064.9 6068.8 6113.3 6135.2 6143.4 6150.3 6213.7 5772.5 5906.7 5959.6 5979.0 5986.0 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - PROCESS | 29223 | [#5] yui.html Cycles:180 Average:20618.62 Median:4123.52 stddev:28597.98 (693.5%) stddev-sans-first:28639.43 05:24:37 INFO - PROCESS | 29223 | Values: 786.0 819.5 831.4 858.6 885.4 14419.5 14682.0 14834.1 14836.8 14891.0 14561.1 14839.1 14855.0 14856.5 14893.3 739.7 858.2 872.1 877.3 882.5 894.2 897.9 900.9 903.8 904.0 933.0 941.7 942.3 944.1 945.0 933.5 934.0 935.2 939.3 940.1 687.0 688.8 690.8 691.2 692.2 13728.9 13804.1 13826.1 13839.2 13851.2 14297.2 15915.9 16528.0 16706.7 16997.9 13652.2 13881.9 13979.2 14021.7 14137.3 4161.0 4193.9 4280.1 4904.5 4994.6 81249.6 82509.0 82808.6 83963.6 83969.0 12647.6 12685.9 12783.7 12796.7 12844.7 22628.7 22669.2 22714.8 22747.5 22842.5 8202.8 8505.8 8605.1 9086.4 9176.4 4833.9 5039.5 5131.8 5137.8 5203.2 3934.2 4001.0 4047.8 4081.9 4086.1 672.6 676.4 680.5 688.5 688.5 791.7 836.0 840.6 858.1 867.3 10507.9 10602.6 10811.6 10901.5 11727.4 688.5 749.5 770.9 825.8 854.9 5074.4 5180.6 5212.6 5270.8 5284.4 75225.2 75503.0 76472.6 95425.5 123281.8 112671.0 117449.5 119448.0 119510.4 120878.4 56960.4 58759.7 62033.7 80874.0 95905.5 10164.0 10566.3 10647.7 10986.3 11198.6 49327.5 56552.7 56990.7 57578.7 57926.4 49265.0 51866.5 52138.7 61355.4 74652.0 13757.7 13824.2 14631.4 14837.9 15880.8 15361.6 15527.8 15575.3 15771.1 16576.9 15356.8 15406.9 15471.3 15841.7 16139.0 15304.2 15493.4 15534.1 15853.6 15999.0 15119.6 15194.5 15418.9 15685.8 16134.8 11537.0 11782.0 11960.9 12049.7 12271.6 12779.0 13116.0 13213.7 13480.0 13730.5 05:24:37 INFO - PROCESS | 29223 | -------- Summary: end -------- 05:24:37 INFO - PROCESS | 29223 | 05:24:37 INFO - TEST-INFO | 29223: exit 0 05:24:37 INFO - TEST-OK | dromaeo_css | took 1110321ms 05:24:37 INFO - TEST-START | kraken 05:24:37 INFO - operating with platform_type : linux_ 05:24:37 INFO - Initialising browser for kraken test... 05:24:37 INFO - TEST-INFO | started process 29465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyu5_RH/profile http://localhost:38158/getInfo.html) 05:24:42 INFO - PROCESS | 29465 | __metrics Screen width/height:1600/1200 05:24:42 INFO - PROCESS | 29465 | colorDepth:24 05:24:42 INFO - PROCESS | 29465 | Browser inner width/height: 1024/697 05:24:42 INFO - PROCESS | 29465 | __metrics 05:24:43 ERROR - PROCESS | 29465 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:24:43 INFO - TEST-INFO | 29465: exit 0 05:24:43 INFO - Browser initialized. 05:24:43 INFO - Running cycle 1/1 for kraken test... 05:24:43 INFO - TEST-INFO | started process 29595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyu5_RH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:55 INFO - PROCESS | 29595 | RSS: Main: 150286336 05:24:55 INFO - PROCESS | 29595 | 05:24:58 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38158/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:58 INFO - PROCESS | 29595 | RSS: Main: 156590080 05:24:58 INFO - PROCESS | 29595 | 05:25:01 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38158/tests/kraken/driver.html?testName=audio-dft) 05:25:02 INFO - PROCESS | 29595 | RSS: Main: 155127808 05:25:02 INFO - PROCESS | 29595 | 05:25:05 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38158/tests/kraken/driver.html?testName=audio-fft) 05:25:05 INFO - PROCESS | 29595 | RSS: Main: 155762688 05:25:05 INFO - PROCESS | 29595 | 05:25:07 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38158/tests/kraken/driver.html?testName=audio-oscillator) 05:25:08 INFO - PROCESS | 29595 | RSS: Main: 156426240 05:25:08 INFO - PROCESS | 29595 | 05:25:10 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:11 INFO - PROCESS | 29595 | RSS: Main: 155996160 05:25:11 INFO - PROCESS | 29595 | 05:25:14 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38158/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:14 INFO - PROCESS | 29595 | RSS: Main: 155869184 05:25:14 INFO - PROCESS | 29595 | 05:25:18 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38158/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:18 INFO - PROCESS | 29595 | RSS: Main: 156766208 05:25:18 INFO - PROCESS | 29595 | 05:25:21 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38158/tests/kraken/driver.html?testName=json-parse-financial) 05:25:22 INFO - PROCESS | 29595 | RSS: Main: 156721152 05:25:22 INFO - PROCESS | 29595 | 05:25:23 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:24 INFO - PROCESS | 29595 | RSS: Main: 155766784 05:25:24 INFO - PROCESS | 29595 | 05:25:26 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:26 INFO - PROCESS | 29595 | RSS: Main: 155701248 05:25:26 INFO - PROCESS | 29595 | 05:25:28 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:29 INFO - PROCESS | 29595 | RSS: Main: 156463104 05:25:29 INFO - PROCESS | 29595 | 05:25:31 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:32 INFO - PROCESS | 29595 | RSS: Main: 156303360 05:25:32 INFO - PROCESS | 29595 | 05:25:35 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:35 INFO - PROCESS | 29595 | RSS: Main: 156889088 05:25:35 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | Cycle 1(1): loaded http://localhost:38158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38158/tests/kraken/driver.html?testName=ai-astar) 05:25:37 INFO - PROCESS | 29595 | RSS: Main: 158654464 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | __start_tp_report 05:25:37 INFO - PROCESS | 29595 | _x_x_mozilla_page_load 05:25:37 INFO - PROCESS | 29595 | _x_x_mozilla_page_load_details 05:25:37 INFO - PROCESS | 29595 | |i|pagename|runs| 05:25:37 INFO - PROCESS | 29595 | |0;ai-astar;100;111;105;109;111;111;110;109;113;110 05:25:37 INFO - PROCESS | 29595 | |1;audio-beat-detection;146;118;147;172;122;142;148;116;173;120 05:25:37 INFO - PROCESS | 29595 | |2;audio-dft;162;162;162;161;161;168;166;162;162;161 05:25:37 INFO - PROCESS | 29595 | |3;audio-fft;75;76;77;180;75;75;75;77;175;75 05:25:37 INFO - PROCESS | 29595 | |4;audio-oscillator;82;84;152;84;83;82;137;83;83;140 05:25:37 INFO - PROCESS | 29595 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:25:37 INFO - PROCESS | 29595 | |6;imaging-darkroom;148;148;146;148;147;147;146;147;147;147 05:25:37 INFO - PROCESS | 29595 | |7;imaging-desaturate;96;95;95;95;96;95;96;96;95;95 05:25:37 INFO - PROCESS | 29595 | |8;json-parse-financial;52;51;50;51;51;51;52;51;52;51 05:25:37 INFO - PROCESS | 29595 | |9;json-stringify-tinderbox;61;59;58;59;59;58;58;58;62;59 05:25:37 INFO - PROCESS | 29595 | |10;stanford-crypto-aes;73;73;78;72;72;74;72;73;72;73 05:25:37 INFO - PROCESS | 29595 | |11;stanford-crypto-ccm;130;120;122;120;132;127;124;139;159;130 05:25:37 INFO - PROCESS | 29595 | |12;stanford-crypto-pbkdf2;163;152;152;154;152;151;154;155;152;153 05:25:37 INFO - PROCESS | 29595 | |13;stanford-crypto-sha256-iterative;65;63;63;61;62;62;60;61;62;62 05:25:37 INFO - PROCESS | 29595 | __end_tp_report 05:25:37 INFO - PROCESS | 29595 | __start_cc_report 05:25:37 INFO - PROCESS | 29595 | _x_x_mozilla_cycle_collect,892 05:25:37 INFO - PROCESS | 29595 | __end_cc_report 05:25:37 INFO - PROCESS | 29595 | __startTimestamp1475756737784__endTimestamp 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | ------- Summary: start ------- 05:25:37 INFO - PROCESS | 29595 | Number of tests: 14 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.75 (3.4%) stddev-sans-first:2.20 05:25:37 INFO - PROCESS | 29595 | Values: 100.0 111.0 105.0 109.0 111.0 111.0 110.0 109.0 113.0 110.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:146.50 stddev:21.21 (14.5%) stddev-sans-first:22.40 05:25:37 INFO - PROCESS | 29595 | Values: 146.0 118.0 147.0 172.0 122.0 142.0 148.0 116.0 173.0 120.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.36 (1.5%) stddev-sans-first:2.49 05:25:37 INFO - PROCESS | 29595 | Values: 162.0 162.0 162.0 161.0 161.0 168.0 166.0 162.0 162.0 161.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.00 stddev:42.98 (57.3%) stddev-sans-first:44.91 05:25:37 INFO - PROCESS | 29595 | Values: 75.0 76.0 77.0 180.0 75.0 75.0 75.0 77.0 175.0 75.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:83.00 stddev:29.23 (35.2%) stddev-sans-first:30.18 05:25:37 INFO - PROCESS | 29595 | Values: 82.0 84.0 152.0 84.0 83.0 82.0 137.0 83.0 83.0 140.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:25:37 INFO - PROCESS | 29595 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 05:25:37 INFO - PROCESS | 29595 | Values: 148.0 148.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:25:37 INFO - PROCESS | 29595 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 05:25:37 INFO - PROCESS | 29595 | Values: 52.0 51.0 50.0 51.0 51.0 51.0 52.0 51.0 52.0 51.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:1.37 (2.3%) stddev-sans-first:1.27 05:25:37 INFO - PROCESS | 29595 | Values: 61.0 59.0 58.0 59.0 59.0 58.0 58.0 58.0 62.0 59.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.81 (2.5%) stddev-sans-first:1.92 05:25:37 INFO - PROCESS | 29595 | Values: 73.0 73.0 78.0 72.0 72.0 74.0 72.0 73.0 72.0 73.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:130.00 stddev:11.71 (9.0%) stddev-sans-first:12.42 05:25:37 INFO - PROCESS | 29595 | Values: 130.0 120.0 122.0 120.0 132.0 127.0 124.0 139.0 159.0 130.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:153.50 stddev:3.46 (2.3%) stddev-sans-first:1.30 05:25:37 INFO - PROCESS | 29595 | Values: 163.0 152.0 152.0 154.0 152.0 151.0 154.0 155.0 152.0 153.0 05:25:37 INFO - PROCESS | 29595 | 05:25:37 INFO - PROCESS | 29595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:0.97 05:25:37 INFO - PROCESS | 29595 | Values: 65.0 63.0 63.0 61.0 62.0 62.0 60.0 61.0 62.0 62.0 05:25:37 INFO - PROCESS | 29595 | -------- Summary: end -------- 05:25:37 INFO - PROCESS | 29595 | 05:25:38 INFO - TEST-INFO | 29595: exit 0 05:25:38 INFO - TEST-OK | kraken | took 60959ms 05:25:38 INFO - SUITE-END | took 1171s 05:25:38 INFO - Completed test suite (00:19:31) 05:25:38 INFO - javascript benchmark 05:25:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7874.470618462957, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.5280934264533, 3266.4447044002522, 3279.966810454707, 3294.6046474423074, 3299.977007127791, 5739.167820666001, 5811.941880581204, 5812.825615231539, 5839.299284085911, 5854.736536855847, 5872.677002764846, 5894.49896758775, 5905.291365036191, 5913.852153696149, 5928.5553583481305, 5285.920711189336, 5342.946570534284, 5351.170568561879, 5402.540784033362, 5437.02133615951, 5386.1920711893135, 5390.326209223847, 5395.460453954613, 5403.351597808269, 5405.081136206854, 5268.5521730652945, 5279.260903473517, 5400.78396864125, 5411.512963833255, 5440.483154100354, 5228.633995620289, 5283.128283833163, 5331.333583302087, 5408.2698835657275, 5411.350637923474, 5248.763805628756, 5335.573154147698, 5337.653052551611, 5357.464253574651, 5359.115745901921, 5819.912701309484, 5821.825345239649, 5877.324107727581, 5923.763049478016, 5932.3474417814, 6043.0, 6144.740328232746, 6154.107654390134, 6189.659568723719, 6339.619622822645, 6346.174997250328, 6352.809415717536, 6354.523410744213, 6355.8411039723915, 6359.745610175587, 5916.556258280646, 5921.585489015728, 5922.703864806743, 5925.525957923356, 5939.316978547479, 6146.5390095743, 6216.564840461215, 6293.874122517615, 6308.463780578702, 6409.647469389229, 6128.78549250783, 6161.907571386433, 6179.752809887644, 6180.81457556274, 6191.040388739752, 6241.812745617639, 6288.811335659938, 6301.6219026858535, 6315.96842015787, 6316.210473690789, 6030.065339872327, 6083.695815209222, 6115.510759139258, 6134.202553668084, 6185.84535386619, 6127.632342059402, 6138.263408390932, 6157.353477884847, 6172.660503672251, 6178.783742568989, 4699.083678682624, 4700.036492519025, 4706.670533062653, 4712.858614241578, 4734.644901632391, 4125.401816736557, 4178.770167640809, 4203.117345357448, 4221.261279276176, 4284.721493102938, 6000.789972350947, 6060.727267272983, 6086.056661217518, 6090.269167699905, 6096.969515152396, 6312.0, 6334.493240540745, 6347.333529979378, 6352.777652782131, 6366.6180029198395, 5754.769809207585, 5964.7315870785915, 6005.159277701126, 6013.067974463965, 6094.268687757498, 5202.03762303975, 5216.0, 5222.947770522323, 5233.188855727369, 5264.921026184534, 6282.18331616896, 6529.673516324165, 6540.640264785482, 6542.182227221598, 6581.539292249592, 6114.205153330038, 6123.44595874501, 6128.411459112376, 6239.344868788893, 6247.187865577446, 6386.584871983307, 6430.935690643221, 6434.935650643433, 6443.6133831968355, 6450.451711604378, 5919.881602367843, 6139.754409823736, 6145.784897528565, 6146.416090471398, 6152.077188421773, 6113.3546859767275, 6131.877362452815, 6153.969230153821, 6237.282712488122, 6243.282022567281, 6088.878222435438, 6089.056196289582, 6091.0558863376245, 6097.0317869630835, 6138.815835524942, 5986.341502434641, 6068.362821903636, 6086.482648974887, 6091.086337049478, 6095.695215239309, 6000.399960003964, 6025.337212906665, 6075.1191077294425, 6145.740123274807, 6154.261488621215, 6185.6907154641185, 6204.689765511796, 6226.25284965807, 6251.937480625317, 6252.562320637694, 5833.737481813413, 6014.097885317237, 6036.6679832609625, 6075.3317135115985, 6090.025595904634], "value": 5754.711440504747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.892199404107, 643.9130717353157, 672.6771149848073, 681.3765404654739, 721.3543878228982, 41750.58249417505, 46330.53669463305, 46381.30428043582, 46745.29882051767, 46825.8293542662, 47529.0, 48253.7587312063, 48502.757486212606, 48595.27107093388, 48599.51400486003, 9047.230985366252, 9190.724278271662, 9203.0, 9204.263658907272, 9217.0, 9141.040190779971, 9198.0, 9228.723138305862, 9241.260699144086, 9259.444433333987, 9199.310051746146, 9262.0, 9276.933152687427, 9280.443173409583, 9290.1174388433, 9247.6300947962, 9255.028222036657, 9258.120478554527, 9292.53537323131, 9294.163525282724, 9119.544022798833, 9192.172704456563, 9207.631694732203, 9211.907880921239, 9219.078092190794, 43520.0, 43621.781891090344, 43705.56294437047, 44017.0, 44091.0, 3667.174885650734, 3741.28915506053, 3845.730798844082, 3877.1082650990147, 3929.292727309083, 35324.11689707778, 35646.46530302048, 35742.642573574194, 35823.10442238939, 35901.64098359009, 4162.188373267214, 4291.849785257532, 4295.506016808075, 4332.0, 4508.504064552896, 380476.0, 381174.9999999972, 382176.0, 382973.0, 384241.0, 67038.32961670321, 67659.0, 67896.32103678999, 68044.0, 68103.0, 41737.373939390935, 42261.57738422638, 42634.57365426368, 42662.57337426648, 72564.27435725575, 18175.818241817677, 18309.45071647853, 18359.0, 18381.08094595265, 18401.90799045996, 13576.660583485493, 13630.795538066937, 13647.0, 13715.588532344045, 13717.0, 21259.149634014466, 21487.570248595253, 21574.78425215759, 21664.458388540414, 21678.783212167993, 7459.179490256068, 7715.92284077152, 7819.139894611588, 7860.371170306362, 7936.444448888637, 1049.8897615750236, 1088.2926098036182, 1109.434188563822, 1121.1367247219596, 1142.605800998654, 34457.655423445445, 34483.13792155216, 34860.30279394398, 34898.302033959684, 35083.824580876935, 1193.0813273779315, 1206.324458303353, 1240.0513607090584, 1242.8322176506056, 1255.8681338459512, 18133.546661333574, 18281.0, 18295.817041829676, 18416.0, 18465.0, 617293.0, 628431.0, 629002.0, 630379.0, 630572.0, 64477.677611611645, 64903.675481623235, 65054.34945650578, 65242.0, 65543.34456655373, 1447.3703938786662, 1449.8042764226905, 1463.1806188534667, 1465.2087872548705, 1478.4529724001973, 32025.67974320227, 33510.0, 33523.48525575861, 33827.0, 33956.0, 56105.0, 56239.0, 56390.154147687, 56604.88673123018, 56803.0, 492311.0, 494590.0, 496518.0, 497000.0, 498978.0, 31365.21586960253, 31569.0, 31741.0, 31918.202044949063, 32015.199620009687, 53345.0, 53517.0, 53773.462265376846, 54033.0, 54157.72921135369, 44501.0, 46335.536644633125, 46875.29687054765, 47344.28983565318, 47384.05231895274, 46332.53667463417, 47568.286475703586, 47834.0, 48178.27732584084, 48380.51619483901, 38886.222275554894, 44282.0, 44766.0, 44773.776131119135, 46733.532664672915, 38858.4171237426, 38889.0, 39627.405588916765, 39720.602793972845, 39865.60134398735, 30260.0, 30589.23526911845, 30620.114539329414, 31304.843475782476, 31349.68650313559], "value": 21689.111313226073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.2121023081722, 427.76045414567835, 430.9845000193268, 436.53727049327716, 437.5318409302048, 19139.234430622775, 20290.18839246432, 20771.584568308645, 20964.8951755241, 21073.57852842942, 19359.612807743837, 20065.89967050163, 20600.484987875312, 20873.165073397045, 20936.057877395517, 5959.106134079891, 6176.876462470748, 6178.783742569011, 6193.7832175873855, 6196.87606247877, 6060.757569697207, 6105.419985101408, 6137.9079313810325, 6140.631562106288, 6152.753889844401, 6075.817725468243, 6102.633841969496, 6114.541409394291, 6124.112003759475, 6125.0, 6001.87996240075, 6017.608855424405, 6028.517718582503, 6062.514998800129, 6091.786787462417, 5180.0, 5464.0, 5470.152126420371, 5488.807891723811, 5489.066858634002, 14923.925380373028, 15107.848921510755, 15157.545273641808, 15450.227488625524, 15472.845271547252, 2366.432056306491, 2397.7961873240797, 2490.6139548370033, 2593.4424098818654, 2847.729465700755, 10114.848277275847, 10246.18030557561, 10421.218408619308, 10664.626738064131, 10906.345619262791, 2005.7091721700272, 2056.5372791122027, 2106.9051892664716, 2231.1967691631, 2250.1336985260627, 81896.0, 93522.0, 95005.0, 95806.52096739471, 99663.50168249184, 18950.0, 19130.426087217405, 19485.318013869448, 19710.211591536463, 20043.799562004486, 34949.0, 35172.29655406877, 35428.29143417117, 35508.82245588807, 35994.0, 10372.948135259276, 10446.791064178673, 10576.94711526453, 10584.417857017937, 10865.45672716361, 8734.781630459162, 8852.336074794417, 8867.68963086289, 9080.772980675536, 9093.590788414538, 9555.27674612732, 9735.805283894282, 9746.658866939764, 9918.25613079022, 9935.155511781435, 3675.9816200918826, 3711.4247291669835, 3714.0714821294678, 3821.4840996465678, 3858.305505009125, 899.9415038022507, 1023.8157131716214, 1032.1691038713907, 1086.2342048855537, 1098.9725256868483, 20490.0, 20741.0, 20827.8958605206, 20929.790702093087, 20943.581128377347, 997.9401235925868, 1047.9580816767395, 1048.6749107776461, 1050.1388861133796, 1102.0, 11312.321260724382, 11382.089432845352, 11768.0, 11776.646700598996, 11792.587259445878, 514962.0, 516739.0, 524094.0, 529017.0, 532311.0, 94285.0, 96895.0, 97507.51246243865, 97755.51122244485, 99182.0, 990.4453506036642, 993.895640957689, 1001.7645853224486, 1007.4056306779036, 1053.594366169015, 18024.909875451063, 18171.727424088385, 18541.516678665943, 18546.81453185505, 18773.0, 28730.281742956595, 34514.82742586271, 41043.38434923419, 44403.0, 44720.32919506275, 56021.87956240771, 59459.0, 60137.39862601318, 61143.38856611377, 61304.0, 7998.120206777134, 8465.238128568459, 8557.400981931205, 9230.584623692084, 9517.381370210915, 13023.739525209632, 13721.176729396268, 13868.098573592684, 14141.363638636492, 14295.642608934444, 12127.454264558293, 12130.93934530357, 12137.69655758613, 12311.0, 12487.500499979898, 12058.0, 12284.877151228373, 12387.256764594153, 12421.130520863453, 12542.310172940211, 12328.876711233132, 12411.503539858304, 12561.656040176566, 12652.051096167641, 12662.873371266169, 8493.702720405003, 8514.574271286287, 8539.359548034046, 8680.739577812676, 8770.07914169003, 11567.190296679151, 12278.0, 12526.624201273977, 12839.614811555668, 12845.614631561068], "value": 10361.906082501968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1560.758082497213, 1574.197159448681, 1743.1545700335334, 1854.9258029678813, 1897.6963685810274, 8680.8697869532, 9298.395604285724, 9426.905730942688, 10023.0, 10029.799404011916, 9537.95231023844, 9952.303338766289, 9954.253430992669, 9972.202223822076, 9977.151942084913, 2587.534243836104, 2637.749413805695, 2640.0627777139125, 2642.6432431621774, 2643.1145566235236, 2553.5148321818797, 2593.442409881875, 2594.6367508548724, 2600.0769726747017, 2616.751408616178, 2568.858712770806, 2571.1643715792347, 2573.794096472278, 2585.6380106785064, 2592.844429334246, 2519.86140762258, 2525.4065294655743, 2535.4168541235617, 2538.073603134861, 2549.4008907906627, 2483.6398722185363, 2487.5522405966917, 2498.5877330240487, 2532.050481069599, 2537.0232460502657, 9898.703038908845, 9949.20406367496, 10019.0, 10049.196064314838, 10056.044675755791, 5880.882382352372, 5986.2217911671205, 6011.75952961881, 6015.157877897098, 6017.939820601781, 3479.460683594047, 3607.1703508193, 3620.8956268338147, 3650.8539658413633, 3663.7069034477177, 1084.078533246742, 1121.472907733364, 1122.1752012270974, 1136.3920302638132, 1154.1459320103147, 13963.79054314186, 14006.71986560263, 14054.437822487089, 14073.929630351988, 14086.506972255922, 5211.0, 5260.736963151827, 5356.3572371315695, 5424.186372044225, 5470.398256191816, 11762.470688819023, 11867.643970680894, 11871.703207419883, 11887.821682674767, 11902.464389102512, 6077.301110372276, 6079.05774604937, 6089.1779609753, 6097.298810636834, 6138.355472675394, 4885.41375034991, 5319.0, 5528.9723551381985, 5533.0, 5541.9168712469345, 4476.768888555674, 4509.458864936229, 4555.612772914273, 4565.863024109282, 4568.428946381702, 1416.3414012484038, 1452.5424491285212, 1455.3669153918079, 1458.4385011770332, 1467.0317590390505, 1046.220565678559, 1050.0654417568371, 1056.3767377247461, 1065.658989123473, 1066.8933106689424, 6441.935580644227, 6535.281119076898, 6693.397594216543, 6729.798106056826, 6766.72933082681, 480.2028632470083, 487.43214155509145, 1053.1732589916878, 1066.7013236293851, 1073.7154654016692, 4307.164392256459, 4338.891527711769, 4449.221386257392, 4479.417675702138, 4545.159145558082, 12276.140670153181, 12644.241345519298, 12659.746805064031, 12665.0, 12702.237865728086, 12151.635450936486, 12377.876221237853, 12448.31534265606, 12474.0, 12589.370531473389, 8712.259457946146, 8788.8681669775, 8906.198442140108, 8908.10918908117, 8923.687670931617, 6341.112244285711, 6355.52333574993, 6446.065320528403, 6546.24718157418, 6571.539992200691, 10622.309549879234, 10715.35707857531, 10738.463076846283, 10777.0, 10855.891441085803, 10791.838122428013, 10962.232643714864, 11042.834357484804, 11057.723556911142, 11091.889081109086, 8342.83314333722, 8379.95810020946, 8420.452670576393, 8484.745457636282, 8546.829063418572, 9479.431234125974, 9480.0, 9498.667546635834, 9547.093026162504, 9630.903690963001, 8337.08292087882, 8557.700480483154, 8564.272036876686, 8603.65585376603, 8726.171013753683, 8145.389095817719, 8161.265486106042, 8185.30424913889, 8260.463069900437, 8399.286060684666, 7251.746188883575, 7437.51656142349, 7489.0, 7618.238176182559, 7645.159032506309, 5555.805546805843, 5616.747246374005, 5636.351819540805, 5690.9430905690415, 5833.270841144857, 5785.797497087582, 5897.852553686193, 5906.0, 5985.042393217064, 6010.398960103955], "value": 5112.492208512064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.175691787348, 359.32626325639427, 366.12678761154655, 367.89882782234866, 369.95375578052744, 5780.219670344502, 5801.8106288210865, 5807.303123625165, 5830.766769329232, 5850.795222167225, 5516.24187906047, 5672.68800215988, 5738.942610573893, 5749.281339832521, 5766.606858153871, 4503.369528266046, 4503.864884053467, 4507.842225522108, 4541.114482675879, 4561.270196768518, 4514.097180563884, 4530.524294949032, 4535.977320113395, 4558.2251017327135, 4560.1335746208115, 4419.558044195571, 4496.2581174106235, 4502.549745025504, 4504.7747612619405, 4532.705374150686, 4453.0, 4466.620337271336, 4470.240059189946, 4473.329000649896, 4495.932561011571, 3980.86066987654, 3989.7606143631474, 3991.98004009981, 4011.4785077939973, 4019.075612609087, 5470.152126420411, 5505.229267902497, 5597.44025597441, 5597.944020559783, 5612.186232996192, 5109.667871588372, 5113.2330150477355, 5121.385433747974, 5158.123119069767, 5197.922031169535, 5919.0404797601195, 5943.970280148615, 5973.402659734035, 5984.790532331391, 5989.730462129215, 4311.935320970188, 4363.956360436387, 4374.993751437156, 4423.778811059434, 4457.754823484707, 5941.346451890288, 6137.938620613826, 6152.87694246117, 6156.230471191101, 6162.582606000645, 4353.4122893408985, 4387.210302145644, 4405.449318835145, 4426.3581780641625, 4426.605619229932, 4467.865964021084, 4474.821007159742, 4478.708883922534, 4486.237339652267, 4493.146302202571, 4953.910139769245, 5063.341765570526, 5098.719570423662, 5117.948820511821, 5131.717755523482, 5987.520998320124, 5990.9700451497465, 6009.1587177795145, 6009.188759517497, 6103.633781973096, 1537.8769698424098, 1553.5339398180502, 1554.6657468644296, 1556.9610759730872, 1557.2603013568464, 933.6229062133299, 990.0544979544518, 990.3513198854762, 994.1649014827435, 999.7900440907491, 5149.910053967665, 5159.871003224949, 5195.740212989335, 5195.766190521435, 5218.321618189611, 5410.864728381822, 5416.0792665247, 5461.972690136603, 5466.72666366688, 5489.752961116759, 4954.6374746944875, 5126.79492820283, 5157.226416037624, 5162.586993040548, 5213.2701421800975, 2856.043225519433, 2900.8259504429802, 2908.022544669645, 2908.476474234658, 2918.9854050730037, 5495.862603434946, 5561.360443548962, 5587.451968000349, 5589.692566908859, 5596.496315331558, 5075.462268865567, 5409.864753381197, 5427.29445172133, 5452.890942181213, 5491.901619676001, 5543.417941116206, 5562.527185189223, 5586.944130558642, 5612.382637909826, 5623.104101387788, 5176.498815343508, 5378.515933565841, 5386.596005299697, 5405.567554595702, 5414.810481633124, 5296.443873393392, 5318.228856815817, 5330.360356757214, 5334.732738586163, 5344.545713614386, 6188.0, 6446.806595802133, 6462.676866156579, 6474.838129046811, 6483.967580162069, 4430.3575981483145, 4493.404841281298, 4499.775011249359, 4512.706674066307, 4529.637628989607, 6113.480354169767, 6264.590467144856, 6296.496280297473, 6329.461995730415, 6337.904931426125, 6087.386842486656, 6100.145979562776, 6107.297660769068, 6131.9269127903335, 6144.678894037804, 5901.822945311647, 6084.170860549865, 6112.755489780359, 6121.969390153021, 6178.691065446799, 5998.7300571473515, 6052.243469566304, 6053.549476798183, 6064.909026364697, 6068.757249710139, 6113.29697084841, 6135.202423684892, 6143.447089761943, 6150.292716337678, 6213.65824879636, 5772.480476757112, 5906.675132867734, 5959.642421454727, 5978.953683105527, 5985.970070149621], "value": 4464.417428211878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.0, 819.4509678515398, 831.3640065350006, 858.6479543387211, 885.3625389719408, 14419.495317663885, 14682.0, 14834.109953402804, 14836.777448338271, 14891.0, 14561.126332420035, 14839.109653420803, 14855.0, 14856.48002319919, 14893.329800158992, 739.6560599321315, 858.2275951643539, 872.1235158665532, 877.3156937588675, 882.4925667741043, 894.2309613732185, 897.878786363839, 900.9369344145913, 903.8192361527688, 903.9954800225989, 932.9877083364557, 941.7080704981444, 942.3215284994827, 944.1361154543584, 944.9574769135405, 933.5378987401245, 933.9626414943394, 935.1536859142487, 939.3143005605912, 940.1209868772719, 686.9862602747917, 688.7761477519776, 690.7513295213719, 691.1982100763091, 692.1728534401392, 13728.862711372958, 13804.102733322303, 13826.101303415346, 13839.169649821042, 13851.238181899991, 14297.213653249068, 15915.920420397939, 16528.0, 16706.665866682597, 16997.915010424993, 13652.24912629805, 13881.930590347085, 13979.23114228717, 14021.719565608733, 14137.293135343192, 4160.958390416087, 4193.895152621179, 4280.079782846703, 4904.509549045067, 4994.625403094782, 81249.59375203087, 82509.0, 82808.58595706982, 83963.5801820987, 83969.0, 12647.620571382873, 12685.873141268654, 12783.744325113446, 12796.680082997813, 12844.743105138032, 22628.660570091462, 22669.2065777697, 22714.772852271264, 22747.545049098924, 22842.54314913726, 8202.794930126794, 8505.82988340242, 8605.13948605147, 9086.36395452312, 9176.44941303524, 4833.9033219335415, 5039.496050394931, 5131.794728210904, 5137.794488220429, 5203.245529398292, 3934.1934903344745, 4001.0197501612292, 4047.7571345719352, 4081.89795255121, 4086.0806318578084, 672.5729161982176, 676.4047638078459, 680.5089888870164, 688.5386790850142, 688.5421194905332, 791.7070683847013, 835.9874601880977, 840.6385254340693, 858.1375717404094, 867.2714919467552, 10507.947460262803, 10602.562765920575, 10811.56753729842, 10901.454927253606, 11727.35499547516, 688.5042769206163, 749.5240522268399, 770.9190534993857, 825.8018075661918, 854.9358798090168, 5074.3657042869645, 5180.585553155738, 5212.609054320941, 5270.815521456807, 5284.445133260952, 75225.24774752292, 75503.0, 76472.61763691145, 95425.52287238519, 123281.76718232883, 112671.0, 117449.47651570466, 119448.0, 119510.4024479872, 120878.3956080214, 56960.43039569551, 58759.70620146872, 62033.689831551455, 80874.0, 95905.5204723972, 10164.0, 10566.26036177491, 10647.733806654896, 10986.294433882134, 11198.552057917592, 49327.50672493373, 56552.717236413555, 56990.71504642616, 57578.7121064392, 57926.420735792104, 49265.0, 51866.48133518767, 52138.73930630474, 61355.386446134966, 74652.0, 13757.656058598215, 13824.170549767046, 14631.414743410145, 14837.92581037088, 15880.761788572949, 15361.6159596011, 15527.767083493982, 15575.299111539782, 15771.132587707327, 16576.917115414344, 15356.846431535989, 15406.897441111507, 15471.303791329192, 15841.68316633684, 16139.0, 15304.158271295186, 15493.380264789283, 15534.067955922681, 15853.603659908595, 15999.040057596581, 15119.622009449851, 15194.544163675107, 15418.922905385401, 15685.843141568896, 16134.838651613334, 11537.043495590788, 11782.0, 11960.880391196324, 12049.698757531132, 12271.631851044483, 12779.0, 13116.0, 13213.655970751468, 13480.0, 13730.519431820238], "value": 8075.758105782065, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 109.0, 111.0, 111.0, 110.0, 109.0, 113.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 147.0, 172.0, 122.0, 142.0, 148.0, 116.0, 173.0, 120.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 168.0, 166.0, 162.0, 162.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 180.0, 75.0, 75.0, 75.0, 77.0, 175.0, 75.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 152.0, 84.0, 83.0, 82.0, 137.0, 83.0, 83.0, 140.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 51.0, 51.0, 52.0, 51.0, 52.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 62.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 78.0, 72.0, 72.0, 74.0, 72.0, 73.0, 72.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 122.0, 120.0, 132.0, 127.0, 124.0, 139.0, 159.0, 130.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 152.0, 152.0, 154.0, 152.0, 151.0, 154.0, 155.0, 152.0, 153.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 61.0, 62.0, 62.0, 60.0, 61.0, 62.0, 62.0], "value": 62.1, "unit": "score"}]}]} 05:25:39 INFO - Return code: 0 05:25:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:39 ERROR - # TBPL SUCCESS # 05:25:39 INFO - Running post-action listener: _resource_record_post_action 05:25:39 INFO - [mozharness: 2016-10-06 12:25:39.099986Z] Finished run-tests step (success) 05:25:39 INFO - Running post-run listener: _resource_record_post_run 05:25:39 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288763904; Read time: 8; Write time: 180740 05:25:39 INFO - TinderboxPrint: CPU usage
13.2% 05:25:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:25:39 INFO - TinderboxPrint: I/O write bytes / time
288,763,904 / 180,740 05:25:39 INFO - TinderboxPrint: CPU idle
8,211.7 (86.8%) 05:25:39 INFO - TinderboxPrint: CPU user
1,198.1 (12.7%) 05:25:39 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71294976; Read time: 0; Write time: 36680 05:25:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 217468928; Read time: 0; Write time: 144060 05:25:39 INFO - Running post-run listener: _upload_blobber_files 05:25:39 INFO - Blob upload gear active. 05:25:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:39 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:25:39 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:25:39 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:25:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:43 INFO - (blobuploader) - INFO - Done attempting. 05:25:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:25:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:25:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:44 INFO - (blobuploader) - INFO - Done attempting. 05:25:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:25:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:45 INFO - (blobuploader) - INFO - Done attempting. 05:25:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:45 INFO - Return code: 0 05:25:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/417512c920e42254a1880211f3825a36f4123d7cbf2997455f0563c2d5c3a0a59063c3e1af431937c43d2dd78f1fd92a29a2282e8f02c0d64b608aa23a371bbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07543d31ed31000dcfa028d4b2ee2a8898ab2f1e178b0f71877d561c34c31c19a1f4050762705a8e30c5fef83f32e3daf3b443342c450c4bb2f792fd5e3a97fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0438ffde87a8e64af1254625146b6bb77089044313eea244402b6ce431f0035db33ff6dcb4dc62b25d09444965fae33571701f39291cf9a2418065ca0f86e081"} 05:25:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:45 INFO - Contents: 05:25:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/417512c920e42254a1880211f3825a36f4123d7cbf2997455f0563c2d5c3a0a59063c3e1af431937c43d2dd78f1fd92a29a2282e8f02c0d64b608aa23a371bbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07543d31ed31000dcfa028d4b2ee2a8898ab2f1e178b0f71877d561c34c31c19a1f4050762705a8e30c5fef83f32e3daf3b443342c450c4bb2f792fd5e3a97fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0438ffde87a8e64af1254625146b6bb77089044313eea244402b6ce431f0035db33ff6dcb4dc62b25d09444965fae33571701f39291cf9a2418065ca0f86e081"} 05:25:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:45 INFO - Copying logs to upload dir... 05:25:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.514573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-06 05:25:45.073358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:25:45.077079) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 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/417512c920e42254a1880211f3825a36f4123d7cbf2997455f0563c2d5c3a0a59063c3e1af431937c43d2dd78f1fd92a29a2282e8f02c0d64b608aa23a371bbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07543d31ed31000dcfa028d4b2ee2a8898ab2f1e178b0f71877d561c34c31c19a1f4050762705a8e30c5fef83f32e3daf3b443342c450c4bb2f792fd5e3a97fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0438ffde87a8e64af1254625146b6bb77089044313eea244402b6ce431f0035db33ff6dcb4dc62b25d09444965fae33571701f39291cf9a2418065ca0f86e081"} build_url:https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/CHrRNJ3ITniZbPjIKG5QMg/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/417512c920e42254a1880211f3825a36f4123d7cbf2997455f0563c2d5c3a0a59063c3e1af431937c43d2dd78f1fd92a29a2282e8f02c0d64b608aa23a371bbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07543d31ed31000dcfa028d4b2ee2a8898ab2f1e178b0f71877d561c34c31c19a1f4050762705a8e30c5fef83f32e3daf3b443342c450c4bb2f792fd5e3a97fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0438ffde87a8e64af1254625146b6bb77089044313eea244402b6ce431f0035db33ff6dcb4dc62b25d09444965fae33571701f39291cf9a2418065ca0f86e081"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:25:45.106796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:25:45.107235) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475755070.953758-405734806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:25:45.187868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:25:45.188204) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:25:45.188538) ========= ========= Total master_lag: 0.18 =========