builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1477023118.89 results: success (0) buildid: 20161020182350 builduid: 447fe19c863c4f45967c2828b5f1c32f revision: e4e6022059e5c35d3b1bbc731b1f68f266302be3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:58.886118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:58.886525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:58.886799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:58.905638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:58.905901) ========= 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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 21:11:59-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.9M=0s 2016-10-20 21:11:59 (68.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.029886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.030188) ========= 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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.082979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.083374) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e4e6022059e5c35d3b1bbc731b1f68f266302be3 --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 e4e6022059e5c35d3b1bbc731b1f68f266302be3 --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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 21:11:59,403 truncating revision to first 12 chars 2016-10-20 21:11:59,403 Setting DEBUG logging. 2016-10-20 21:11:59,403 attempt 1/10 2016-10-20 21:11:59,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e4e6022059e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 21:11:59,707 unpacking tar archive at: mozilla-beta-e4e6022059e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.823542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.823853) ========= script_repo_revision: e4e6022059e5c35d3b1bbc731b1f68f266302be3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.824268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.824550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:11:59.833794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-20 21:11:59.834224) ========= /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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:12:00 INFO - MultiFileLogger online at 20161020 21:12:00 in /builds/slave/test 21:12:00 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 21:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:00 INFO - {'append_to_log': False, 21:12:00 INFO - 'base_work_dir': '/builds/slave/test', 21:12:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:00 INFO - 'branch': 'Mozilla-Beta', 21:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:00 INFO - 'config_files': ('talos/linux_config.py',), 21:12:00 INFO - 'default_actions': ('clobber', 21:12:00 INFO - 'read-buildbot-config', 21:12:00 INFO - 'download-and-extract', 21:12:00 INFO - 'populate-webroot', 21:12:00 INFO - 'create-virtualenv', 21:12:00 INFO - 'install', 21:12:00 INFO - 'run-tests'), 21:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:00 INFO - 'download_minidump_stackwalk': True, 21:12:00 INFO - 'download_symbols': 'ondemand', 21:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:00 INFO - 'installer_path': 'installer.exe', 21:12:00 INFO - 'log_level': 'info', 21:12:00 INFO - 'log_name': 'talos', 21:12:00 INFO - 'log_to_console': True, 21:12:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:12:00 INFO - 'opt_config_files': (), 21:12:00 INFO - 'pip_index': False, 21:12:00 INFO - 'sps_profile': False, 21:12:00 INFO - 'sps_profile_interval': 0, 21:12:00 INFO - 'suite': 'dromaeojs-e10s', 21:12:00 INFO - 'system_bits': '32', 21:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:00 INFO - 'title': 'talos-linux64-ix-008', 21:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:00 INFO - 'use_talos_json': True, 21:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:00 INFO - 'work_dir': 'build'} 21:12:00 INFO - [mozharness: 2016-10-21 04:12:00.245788Z] Running clobber step. 21:12:00 INFO - Running pre-action listener: _resource_record_pre_action 21:12:00 INFO - Running main action method: clobber 21:12:00 INFO - rmtree: /builds/slave/test/build 21:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:00 INFO - Running post-action listener: _resource_record_post_action 21:12:00 INFO - [mozharness: 2016-10-21 04:12:00.704663Z] Finished clobber step (success) 21:12:00 INFO - [mozharness: 2016-10-21 04:12:00.704763Z] Running read-buildbot-config step. 21:12:00 INFO - Running pre-action listener: _resource_record_pre_action 21:12:00 INFO - Running main action method: read_buildbot_config 21:12:00 INFO - Using buildbot properties: 21:12:00 INFO - { 21:12:00 INFO - "project": "", 21:12:00 INFO - "product": "firefox", 21:12:00 INFO - "script_repo_revision": "production", 21:12:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 21:12:00 INFO - "repository": "", 21:12:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 21:12:00 INFO - "buildid": "20161020182350", 21:12:00 INFO - "pgo_build": "True", 21:12:00 INFO - "basedir": "/builds/slave/test", 21:12:00 INFO - "buildnumber": 202, 21:12:00 INFO - "slavename": "talos-linux64-ix-008", 21:12:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:12:00 INFO - "platform": "ubuntu64_hw", 21:12:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:12:00 INFO - "branch": "mozilla-beta", 21:12:00 INFO - "repo_path": "releases/mozilla-beta", 21:12:00 INFO - "revision": "e4e6022059e5c35d3b1bbc731b1f68f266302be3", 21:12:00 INFO - "stage_platform": "linux64-pgo", 21:12:00 INFO - "builduid": "447fe19c863c4f45967c2828b5f1c32f", 21:12:00 INFO - "slavebuilddir": "test" 21:12:00 INFO - } 21:12:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 21:12:00 INFO - Running post-action listener: _resource_record_post_action 21:12:00 INFO - [mozharness: 2016-10-21 04:12:00.707208Z] Finished read-buildbot-config step (success) 21:12:00 INFO - [mozharness: 2016-10-21 04:12:00.707298Z] Running download-and-extract step. 21:12:00 INFO - Running pre-action listener: _resource_record_pre_action 21:12:00 INFO - Running main action method: download_and_extract 21:12:00 INFO - mkdir: /builds/slave/test/build/tests 21:12:00 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')]} 21:12:00 INFO - https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:12:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:12:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:12:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:12:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:12:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:12:00 INFO - retry: Failed, sleeping 30 seconds before retrying 21:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:12:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:12:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:12:30 INFO - retry: Failed, sleeping 60 seconds before retrying 21:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:13:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:13:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:13:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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! 21:13:30 INFO - Caught exception: HTTP Error 404: Not Found 21:13:30 INFO - Caught exception: HTTP Error 404: Not Found 21:13:30 INFO - Caught exception: HTTP Error 404: Not Found 21:13:30 INFO - trying https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:13:30 INFO - Downloading https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:13:31 INFO - Downloaded 1327 bytes. 21:13:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:13:31 INFO - Using the following test package requirements: 21:13:31 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 21:13:31 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:13:31 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 21:13:31 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'jsshell-linux-x86_64.zip'], 21:13:31 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:13:31 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 21:13:31 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 21:13:31 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 21:13:31 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:13:31 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:13:31 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:13:31 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:13:31 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')]} 21:13:31 INFO - https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:13:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:13:31 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:13:31 INFO - retry: Failed, sleeping 30 seconds before retrying 21:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:14:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:14:01 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:14:01 INFO - retry: Failed, sleeping 60 seconds before retrying 21:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:01 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:15:01 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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! 21:15:01 INFO - Caught exception: HTTP Error 404: Not Found 21:15:01 INFO - Caught exception: HTTP Error 404: Not Found 21:15:01 INFO - Caught exception: HTTP Error 404: Not Found 21:15:01 INFO - trying https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:02 INFO - Downloaded 21774087 bytes. 21:15:02 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'] 21:15:02 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 21:15:03 INFO - Return code: 0 21:15:03 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 21:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:03 INFO - https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:15:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:15:03 INFO - retry: Failed, sleeping 30 seconds before retrying 21:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:15:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:15:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:15:33 INFO - retry: Failed, sleeping 60 seconds before retrying 21:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:16:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:16:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:16:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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! 21:16:33 INFO - Caught exception: HTTP Error 404: Not Found 21:16:33 INFO - Caught exception: HTTP Error 404: Not Found 21:16:33 INFO - Caught exception: HTTP Error 404: Not Found 21:16:33 INFO - trying https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:16:33 INFO - Downloading https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:16:34 INFO - Downloaded 21774087 bytes. 21:16:34 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'] 21:16:34 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 21:16:36 INFO - Return code: 0 21:16: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')]} 21:16:36 INFO - https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:16:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:16:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:16:36 INFO - retry: Failed, sleeping 30 seconds before retrying 21:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:17:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:17:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:17:06 INFO - retry: Failed, sleeping 60 seconds before retrying 21:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:18:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:18:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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! 21:18:06 INFO - Caught exception: HTTP Error 404: Not Found 21:18:06 INFO - Caught exception: HTTP Error 404: Not Found 21:18:06 INFO - Caught exception: HTTP Error 404: Not Found 21:18:06 INFO - trying https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:18:06 INFO - Downloading https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:06 INFO - Downloaded 14413762 bytes. 21:18:06 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'] 21:18:06 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 21:18:07 INFO - Return code: 0 21:18: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')]} 21:18:07 INFO - https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:18:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:18:07 INFO - retry: Failed, sleeping 30 seconds before retrying 21:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:18:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:18:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:18:37 INFO - retry: Failed, sleeping 60 seconds before retrying 21:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:19:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:19:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:19:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9JBOHyGSaafHDR7oKZdew/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! 21:19:37 INFO - Caught exception: HTTP Error 404: Not Found 21:19:37 INFO - Caught exception: HTTP Error 404: Not Found 21:19:37 INFO - Caught exception: HTTP Error 404: Not Found 21:19:37 INFO - trying https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:19:37 INFO - Downloading https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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 21:19:38 INFO - Downloaded 56790427 bytes. 21:19:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:19:38 INFO - mkdir: /builds/slave/test/properties 21:19:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:19:38 INFO - Writing to file /builds/slave/test/properties/build_url 21:19:38 INFO - Contents: 21:19:38 INFO - build_url:https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:19:39 INFO - Running post-action listener: _resource_record_post_action 21:19:39 INFO - Running post-action listener: set_extra_try_arguments 21:19:39 INFO - [mozharness: 2016-10-21 04:19:39.014622Z] Finished download-and-extract step (success) 21:19:39 INFO - [mozharness: 2016-10-21 04:19:39.014855Z] Running populate-webroot step. 21:19:39 INFO - Running pre-action listener: _resource_record_pre_action 21:19:39 INFO - Running main action method: populate_webroot 21:19:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:19:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:19:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:19:39 INFO - '--tppagecycles', 21:19:39 INFO - '7'], 21:19:39 INFO - 'tests': ['tsvgm']}}, 21:19:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:19:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:19:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:19:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:19:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['damp', 'tps']}, 21:19:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'tests': ['damp', 'tps']}, 21:19:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['dromaeo_dom']}, 21:19:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:19:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['basic_compositor_video']}, 21:19:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:19:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'other-e10s': {'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['a11yr', 21:19:39 INFO - 'ts_paint', 21:19:39 INFO - 'tpaint', 21:19:39 INFO - 'sessionrestore', 21:19:39 INFO - 'sessionrestore_no_auto_restore', 21:19:39 INFO - 'tabpaint']}, 21:19:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['tsvgx', 21:19:39 INFO - 'tsvgr_opacity', 21:19:39 INFO - 'tart', 21:19:39 INFO - 'tscrollx', 21:19:39 INFO - 'cart']}, 21:19:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:19:39 INFO - 'tsvgr_opacity', 21:19:39 INFO - 'tart', 21:19:39 INFO - 'tscrollx', 21:19:39 INFO - 'cart']}, 21:19:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'talos_options': ['--disable-e10s'], 21:19:39 INFO - 'tests': ['tp5o']}, 21:19:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'tests': ['tp5o']}, 21:19:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'talos_options': ['--disable-e10s', 21:19:39 INFO - '--xperf_path', 21:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:39 INFO - 'tests': ['tp5n']}, 21:19:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:39 INFO - 'talos_options': ['--xperf_path', 21:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:39 INFO - 'tests': ['tp5n']}}, 21:19:39 INFO - 'talos.zip': {'path': '', 21:19:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:19:39 INFO - Running post-action listener: _resource_record_post_action 21:19:39 INFO - [mozharness: 2016-10-21 04:19:39.035002Z] Finished populate-webroot step (success) 21:19:39 INFO - [mozharness: 2016-10-21 04:19:39.035091Z] Running create-virtualenv step. 21:19:39 INFO - Running pre-action listener: _resource_record_pre_action 21:19:39 INFO - Running main action method: create_virtualenv 21:19:39 INFO - Creating virtualenv /builds/slave/test/build/venv 21:19:39 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 21:19:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:19:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:19:39 INFO - Using real prefix '/usr' 21:19:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:19:39 INFO - Installing distribute.............................................................................................................................................................................................done. 21:19:41 INFO - Installing pip.................done. 21:19:41 INFO - Return code: 0 21:19:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:19: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')]} 21:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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')]} 21:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19: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', 'pip>=1.5'] in /builds/slave/test/build 21:19: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 pip>=1.5 21:19:41 INFO - Using env: {'DISPLAY': ':0', 21:19:41 INFO - 'HOME': '/home/cltbld', 21:19:41 INFO - 'LANG': 'en_US.UTF-8', 21:19:41 INFO - 'LANGUAGE': 'en_US:en', 21:19:41 INFO - 'LOGNAME': 'cltbld', 21:19:41 INFO - 'MAIL': '/var/mail/cltbld', 21:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:41 INFO - 'MOZ_NO_REMOTE': '1', 21:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:41 INFO - 'NO_EM_RESTART': '1', 21:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:41 INFO - 'PWD': '/builds/slave/test', 21:19:41 INFO - 'SHELL': '/bin/bash', 21:19:41 INFO - 'SHLVL': '1', 21:19:41 INFO - 'TERM': 'linux', 21:19:41 INFO - 'TMOUT': '86400', 21:19:41 INFO - 'USER': 'cltbld', 21:19:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:41 INFO - '_': '/tools/buildbot/bin/python'} 21:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:41 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 21:19:41 INFO - Cleaning up... 21:19:41 INFO - Return code: 0 21:19:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:19: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')]} 21:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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')]} 21:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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', '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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:19: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 psutil>=3.1.1 21:19:41 INFO - Using env: {'DISPLAY': ':0', 21:19:41 INFO - 'HOME': '/home/cltbld', 21:19:41 INFO - 'LANG': 'en_US.UTF-8', 21:19:41 INFO - 'LANGUAGE': 'en_US:en', 21:19:41 INFO - 'LOGNAME': 'cltbld', 21:19:41 INFO - 'MAIL': '/var/mail/cltbld', 21:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:41 INFO - 'MOZ_NO_REMOTE': '1', 21:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:41 INFO - 'NO_EM_RESTART': '1', 21:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:41 INFO - 'PWD': '/builds/slave/test', 21:19:41 INFO - 'SHELL': '/bin/bash', 21:19:41 INFO - 'SHLVL': '1', 21:19:41 INFO - 'TERM': 'linux', 21:19:41 INFO - 'TMOUT': '86400', 21:19:41 INFO - 'USER': 'cltbld', 21:19:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:41 INFO - '_': '/tools/buildbot/bin/python'} 21:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:42 INFO - Downloading/unpacking psutil>=3.1.1 21:19: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 21:19: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 21:19: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 21:19: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 21:19: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 21:19: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 21:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:19:44 INFO - Installing collected packages: psutil 21:19:44 INFO - Running setup.py install for psutil 21:19:44 INFO - building 'psutil._psutil_linux' extension 21:19:44 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 21:19:44 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 21:19:44 INFO - building 'psutil._psutil_posix' extension 21:19:44 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 21:19:44 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 21:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:19:44 INFO - Successfully installed psutil 21:19:44 INFO - Cleaning up... 21:19:44 INFO - Return code: 0 21:19:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:44 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:44 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 21:19:44 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 21:19:44 INFO - Using env: {'DISPLAY': ':0', 21:19:44 INFO - 'HOME': '/home/cltbld', 21:19:44 INFO - 'LANG': 'en_US.UTF-8', 21:19:44 INFO - 'LANGUAGE': 'en_US:en', 21:19:44 INFO - 'LOGNAME': 'cltbld', 21:19:44 INFO - 'MAIL': '/var/mail/cltbld', 21:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:44 INFO - 'MOZ_NO_REMOTE': '1', 21:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:44 INFO - 'NO_EM_RESTART': '1', 21:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:44 INFO - 'PWD': '/builds/slave/test', 21:19:44 INFO - 'SHELL': '/bin/bash', 21:19:44 INFO - 'SHLVL': '1', 21:19:44 INFO - 'TERM': 'linux', 21:19:44 INFO - 'TMOUT': '86400', 21:19:44 INFO - 'USER': 'cltbld', 21:19:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:44 INFO - '_': '/tools/buildbot/bin/python'} 21:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:19: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 21:19: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 21:19: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 21:19: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 21:19: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 21:19: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 21:19:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:19:46 INFO - Installing collected packages: mozsystemmonitor 21:19:46 INFO - Running setup.py install for mozsystemmonitor 21:19:46 INFO - Successfully installed mozsystemmonitor 21:19:46 INFO - Cleaning up... 21:19:46 INFO - Return code: 0 21:19:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:46 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 21:19:46 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 21:19:46 INFO - Using env: {'DISPLAY': ':0', 21:19:46 INFO - 'HOME': '/home/cltbld', 21:19:46 INFO - 'LANG': 'en_US.UTF-8', 21:19:46 INFO - 'LANGUAGE': 'en_US:en', 21:19:46 INFO - 'LOGNAME': 'cltbld', 21:19:46 INFO - 'MAIL': '/var/mail/cltbld', 21:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:46 INFO - 'MOZ_NO_REMOTE': '1', 21:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:46 INFO - 'NO_EM_RESTART': '1', 21:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:46 INFO - 'PWD': '/builds/slave/test', 21:19:46 INFO - 'SHELL': '/bin/bash', 21:19:46 INFO - 'SHLVL': '1', 21:19:46 INFO - 'TERM': 'linux', 21:19:46 INFO - 'TMOUT': '86400', 21:19:46 INFO - 'USER': 'cltbld', 21:19:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:46 INFO - '_': '/tools/buildbot/bin/python'} 21:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:47 INFO - Downloading/unpacking jsonschema==2.5.1 21:19:47 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 21:19:47 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 21:19:47 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 21:19:47 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 21:19:47 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 21:19:47 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 21:19:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:19:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 INFO - Downloading functools32-3.2.3-2.tar.gz 21:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:19:49 INFO - warning: no files found matching '*.txt' 21:19:49 INFO - no previously-included directories found matching 'build' 21:19:49 INFO - no previously-included directories found matching 'dist' 21:19:49 INFO - no previously-included directories found matching '.git*' 21:19:49 INFO - Installing collected packages: jsonschema, functools32 21:19:49 INFO - Running setup.py install for functools32 21:19:49 INFO - warning: no files found matching '*.txt' 21:19:49 INFO - no previously-included directories found matching 'build' 21:19:49 INFO - no previously-included directories found matching 'dist' 21:19:49 INFO - no previously-included directories found matching '.git*' 21:19:49 INFO - Successfully installed jsonschema functools32 21:19:49 INFO - Cleaning up... 21:19:49 INFO - Return code: 0 21:19:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:19:49 INFO - Using env: {'DISPLAY': ':0', 21:19:49 INFO - 'HOME': '/home/cltbld', 21:19:49 INFO - 'LANG': 'en_US.UTF-8', 21:19:49 INFO - 'LANGUAGE': 'en_US:en', 21:19:49 INFO - 'LOGNAME': 'cltbld', 21:19:49 INFO - 'MAIL': '/var/mail/cltbld', 21:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:49 INFO - 'MOZ_NO_REMOTE': '1', 21:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:49 INFO - 'NO_EM_RESTART': '1', 21:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:49 INFO - 'PWD': '/builds/slave/test', 21:19:49 INFO - 'SHELL': '/bin/bash', 21:19:49 INFO - 'SHLVL': '1', 21:19:49 INFO - 'TERM': 'linux', 21:19:49 INFO - 'TMOUT': '86400', 21:19:49 INFO - 'USER': 'cltbld', 21:19:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:49 INFO - '_': '/tools/buildbot/bin/python'} 21:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:19:49 INFO - Cleaning up... 21:19:49 INFO - Return code: 0 21:19:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:19:49 INFO - Using env: {'DISPLAY': ':0', 21:19:49 INFO - 'HOME': '/home/cltbld', 21:19:49 INFO - 'LANG': 'en_US.UTF-8', 21:19:49 INFO - 'LANGUAGE': 'en_US:en', 21:19:49 INFO - 'LOGNAME': 'cltbld', 21:19:49 INFO - 'MAIL': '/var/mail/cltbld', 21:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:49 INFO - 'MOZ_NO_REMOTE': '1', 21:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:49 INFO - 'NO_EM_RESTART': '1', 21:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:49 INFO - 'PWD': '/builds/slave/test', 21:19:49 INFO - 'SHELL': '/bin/bash', 21:19:49 INFO - 'SHLVL': '1', 21:19:49 INFO - 'TERM': 'linux', 21:19:49 INFO - 'TMOUT': '86400', 21:19:49 INFO - 'USER': 'cltbld', 21:19:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:49 INFO - '_': '/tools/buildbot/bin/python'} 21:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:49 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 21:19:51 INFO - Downloading blobuploader-1.2.4.tar.gz 21:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:19:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:19:51 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 21:19:51 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 21:19:51 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 21:19:51 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 21:19:51 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 21:19:51 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 21:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:19:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:19:52 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 21:19:52 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 21:19:52 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 21:19:52 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 21:19:52 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 21:19:52 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 21:19:52 INFO - Downloading docopt-0.6.1.tar.gz 21:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:19:52 INFO - Installing collected packages: blobuploader, requests, docopt 21:19:52 INFO - Running setup.py install for blobuploader 21:19:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:19:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:19:52 INFO - Running setup.py install for requests 21:19:53 INFO - Running setup.py install for docopt 21:19:53 INFO - Successfully installed blobuploader requests docopt 21:19:53 INFO - Cleaning up... 21:19:53 INFO - Return code: 0 21:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:19: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')]} 21:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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')]} 21:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:53 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:53 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 21:19:53 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 21:19:53 INFO - Using env: {'DISPLAY': ':0', 21:19:53 INFO - 'HOME': '/home/cltbld', 21:19:53 INFO - 'LANG': 'en_US.UTF-8', 21:19:53 INFO - 'LANGUAGE': 'en_US:en', 21:19:53 INFO - 'LOGNAME': 'cltbld', 21:19:53 INFO - 'MAIL': '/var/mail/cltbld', 21:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:53 INFO - 'MOZ_NO_REMOTE': '1', 21:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:53 INFO - 'NO_EM_RESTART': '1', 21:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:53 INFO - 'PWD': '/builds/slave/test', 21:19:53 INFO - 'SHELL': '/bin/bash', 21:19:53 INFO - 'SHLVL': '1', 21:19:53 INFO - 'TERM': 'linux', 21:19:53 INFO - 'TMOUT': '86400', 21:19:53 INFO - 'USER': 'cltbld', 21:19:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:53 INFO - '_': '/tools/buildbot/bin/python'} 21:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:19:53 INFO - Running setup.py (path:/tmp/pip-NSvIRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:19:53 INFO - Running setup.py (path:/tmp/pip-HeRR7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:19:53 INFO - Running setup.py (path:/tmp/pip-Zx38fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:19:53 INFO - Running setup.py (path:/tmp/pip-uhlkyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:19:53 INFO - Running setup.py (path:/tmp/pip-BiN6VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:19:53 INFO - Running setup.py (path:/tmp/pip-h89eqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:19:53 INFO - Running setup.py (path:/tmp/pip-YNUOKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:19:53 INFO - Running setup.py (path:/tmp/pip-n3bpWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:19:54 INFO - Running setup.py (path:/tmp/pip-R5scOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:19:54 INFO - Running setup.py (path:/tmp/pip-BttLci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:19:54 INFO - Running setup.py (path:/tmp/pip-HzYahY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:19:54 INFO - Running setup.py (path:/tmp/pip-yIVm7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:19:54 INFO - Running setup.py (path:/tmp/pip-QerfPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:19:54 INFO - Running setup.py (path:/tmp/pip-2p7bJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:54 INFO - Running setup.py (path:/tmp/pip-t10fC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:19:54 INFO - Running setup.py (path:/tmp/pip-bc51Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:19:54 INFO - Running setup.py (path:/tmp/pip-SlhTMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:19:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:19:54 INFO - Running setup.py install for manifestparser 21:19:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:19:54 INFO - Running setup.py install for mozcrash 21:19:54 INFO - Running setup.py install for mozdebug 21:19:55 INFO - Running setup.py install for mozdevice 21:19:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for mozfile 21:19:55 INFO - Running setup.py install for mozhttpd 21:19:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for mozinfo 21:19:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for mozInstall 21:19:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for mozleak 21:19:55 INFO - Running setup.py install for mozlog 21:19:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for moznetwork 21:19:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:19:55 INFO - Running setup.py install for mozprocess 21:19:55 INFO - Running setup.py install for mozprofile 21:19:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:19:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:19:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:19:56 INFO - Running setup.py install for mozrunner 21:19:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:19:56 INFO - Running setup.py install for mozscreenshot 21:19:56 INFO - Running setup.py install for moztest 21:19:56 INFO - Running setup.py install for mozversion 21:19:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:19:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:19:56 INFO - Cleaning up... 21:19:56 INFO - Return code: 0 21:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:19: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')]} 21:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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')]} 21:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:56 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:19:56 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 21:19:56 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 21:19:56 INFO - Using env: {'DISPLAY': ':0', 21:19:56 INFO - 'HOME': '/home/cltbld', 21:19:56 INFO - 'LANG': 'en_US.UTF-8', 21:19:56 INFO - 'LANGUAGE': 'en_US:en', 21:19:56 INFO - 'LOGNAME': 'cltbld', 21:19:56 INFO - 'MAIL': '/var/mail/cltbld', 21:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:56 INFO - 'MOZ_NO_REMOTE': '1', 21:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:56 INFO - 'NO_EM_RESTART': '1', 21:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:56 INFO - 'PWD': '/builds/slave/test', 21:19:56 INFO - 'SHELL': '/bin/bash', 21:19:56 INFO - 'SHLVL': '1', 21:19:56 INFO - 'TERM': 'linux', 21:19:56 INFO - 'TMOUT': '86400', 21:19:56 INFO - 'USER': 'cltbld', 21:19:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:56 INFO - '_': '/tools/buildbot/bin/python'} 21:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:19:56 INFO - Running setup.py (path:/tmp/pip-VnJejq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:19:56 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)) 21:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:19:56 INFO - Running setup.py (path:/tmp/pip-6JuBfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:19:56 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)) 21:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:19:56 INFO - Running setup.py (path:/tmp/pip-GR8cIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:19:56 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)) 21:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:19:56 INFO - Running setup.py (path:/tmp/pip-pralIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:19:57 INFO - Running setup.py (path:/tmp/pip-KkuEKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:19:57 INFO - Running setup.py (path:/tmp/pip-AvrApq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:19:57 INFO - Running setup.py (path:/tmp/pip-wHVZCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:19:57 INFO - Running setup.py (path:/tmp/pip-0cFZq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:19:57 INFO - Running setup.py (path:/tmp/pip-6_k7Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:19:57 INFO - Running setup.py (path:/tmp/pip-KPvyqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:19:57 INFO - Running setup.py (path:/tmp/pip-Bm8CuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:19:57 INFO - Running setup.py (path:/tmp/pip-cx7Dcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:19:57 INFO - Running setup.py (path:/tmp/pip-F6RpZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:19:57 INFO - Running setup.py (path:/tmp/pip-gka4eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:57 INFO - Running setup.py (path:/tmp/pip-GBbprz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:19:57 INFO - Running setup.py (path:/tmp/pip-fVYs3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:19:57 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)) 21:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:19:57 INFO - Running setup.py (path:/tmp/pip-hO5FB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:19:57 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)) 21:19:57 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)) 21:19:57 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)) 21:19:57 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)) 21:19:57 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)) 21:19:57 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)) 21:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:19:57 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 21:19:57 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 21:19:57 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 21:19:57 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 21:19:57 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 21:19:57 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 21:19:59 INFO - Downloading blessings-1.6.tar.gz 21:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:19:59 INFO - Installing collected packages: blessings 21:19:59 INFO - Running setup.py install for blessings 21:20:00 INFO - Successfully installed blessings 21:20:00 INFO - Cleaning up... 21:20:00 INFO - Return code: 0 21:20:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:00 INFO - Reading from file tmpfile_stdout 21:20:00 INFO - Current package versions: 21:20:00 INFO - argparse == 1.2.1 21:20:00 INFO - blessings == 1.6 21:20:00 INFO - blobuploader == 1.2.4 21:20:00 INFO - docopt == 0.6.1 21:20:00 INFO - functools32 == 3.2.3-2 21:20:00 INFO - jsonschema == 2.5.1 21:20:00 INFO - manifestparser == 1.1 21:20:00 INFO - mozInstall == 1.12 21:20:00 INFO - mozcrash == 0.17 21:20:00 INFO - mozdebug == 0.1 21:20:00 INFO - mozdevice == 0.48 21:20:00 INFO - mozfile == 1.2 21:20:00 INFO - mozhttpd == 0.7 21:20:00 INFO - mozinfo == 0.9 21:20:00 INFO - mozleak == 0.1 21:20:00 INFO - mozlog == 3.3 21:20:00 INFO - moznetwork == 0.27 21:20:00 INFO - mozprocess == 0.23 21:20:00 INFO - mozprofile == 0.28 21:20:00 INFO - mozrunner == 6.12 21:20:00 INFO - mozscreenshot == 0.1 21:20:00 INFO - mozsystemmonitor == 0.3 21:20:00 INFO - moztest == 0.7 21:20:00 INFO - mozversion == 1.4 21:20:00 INFO - psutil == 3.1.1 21:20:00 INFO - requests == 1.2.3 21:20:00 INFO - wsgiref == 0.1.2 21:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20:00 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')]} 21:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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')]} 21:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:20:00 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 21:20:00 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 21:20:00 INFO - Using env: {'DISPLAY': ':0', 21:20:00 INFO - 'HOME': '/home/cltbld', 21:20:00 INFO - 'LANG': 'en_US.UTF-8', 21:20:00 INFO - 'LANGUAGE': 'en_US:en', 21:20:00 INFO - 'LOGNAME': 'cltbld', 21:20:00 INFO - 'MAIL': '/var/mail/cltbld', 21:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:00 INFO - 'MOZ_NO_REMOTE': '1', 21:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:00 INFO - 'NO_EM_RESTART': '1', 21:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:00 INFO - 'PWD': '/builds/slave/test', 21:20:00 INFO - 'SHELL': '/bin/bash', 21:20:00 INFO - 'SHLVL': '1', 21:20:00 INFO - 'TERM': 'linux', 21:20:00 INFO - 'TMOUT': '86400', 21:20:00 INFO - 'USER': 'cltbld', 21:20:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:00 INFO - '_': '/tools/buildbot/bin/python'} 21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 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)) 21:20:00 INFO - Cleaning up... 21:20:00 INFO - Return code: 0 21:20:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:20:00 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')]} 21:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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')]} 21:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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 0xc48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, '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': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', '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 21:20:00 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 21:20:00 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 21:20:00 INFO - Using env: {'DISPLAY': ':0', 21:20:00 INFO - 'HOME': '/home/cltbld', 21:20:00 INFO - 'LANG': 'en_US.UTF-8', 21:20:00 INFO - 'LANGUAGE': 'en_US:en', 21:20:00 INFO - 'LOGNAME': 'cltbld', 21:20:00 INFO - 'MAIL': '/var/mail/cltbld', 21:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:00 INFO - 'MOZ_NO_REMOTE': '1', 21:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:00 INFO - 'NO_EM_RESTART': '1', 21:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:00 INFO - 'PWD': '/builds/slave/test', 21:20:00 INFO - 'SHELL': '/bin/bash', 21:20:00 INFO - 'SHLVL': '1', 21:20:00 INFO - 'TERM': 'linux', 21:20:00 INFO - 'TMOUT': '86400', 21:20:00 INFO - 'USER': 'cltbld', 21:20:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:00 INFO - '_': '/tools/buildbot/bin/python'} 21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:20:00 INFO - Cleaning up... 21:20:00 INFO - Return code: 0 21:20:00 INFO - Running post-action listener: _resource_record_post_action 21:20:00 INFO - Running post-action listener: _start_resource_monitoring 21:20:00 INFO - Starting resource monitoring. 21:20:00 INFO - [mozharness: 2016-10-21 04:20:00.821091Z] Finished create-virtualenv step (success) 21:20:00 INFO - [mozharness: 2016-10-21 04:20:00.821708Z] Running install step. 21:20:00 INFO - Running pre-action listener: _resource_record_pre_action 21:20:00 INFO - Running main action method: install 21:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:01 INFO - Reading from file tmpfile_stdout 21:20:01 INFO - Detecting whether we're running mozinstall >=1.0... 21:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:20:01 INFO - Reading from file tmpfile_stdout 21:20:01 INFO - Output received: 21:20:01 INFO - Usage: mozinstall [options] installer 21:20:01 INFO - Options: 21:20:01 INFO - -h, --help show this help message and exit 21:20:01 INFO - -d DEST, --destination=DEST 21:20:01 INFO - Directory to install application into. [default: 21:20:01 INFO - "/builds/slave/test"] 21:20:01 INFO - --app=APP Application being installed. [default: firefox] 21:20:01 INFO - mkdir: /builds/slave/test/build/application 21:20:01 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'] 21:20:01 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 21:20:15 INFO - Reading from file tmpfile_stdout 21:20:15 INFO - Output received: 21:20:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:20:15 INFO - Running post-action listener: _resource_record_post_action 21:20:15 INFO - [mozharness: 2016-10-21 04:20:15.227040Z] Finished install step (success) 21:20:15 INFO - [mozharness: 2016-10-21 04:20:15.227380Z] Running run-tests step. 21:20:15 INFO - Running pre-action listener: _resource_record_pre_action 21:20:15 INFO - Running main action method: run_tests 21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:20:15 INFO - Python 2.7.3 21:20:15 INFO - Return code: 0 21:20:15 INFO - grabbing minidump binary from tooltool 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:15 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 0xf06570>, '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 0xf07470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf07900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:20:15 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 21:20:15 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 21:20:15 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 21:20:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:15 INFO - Return code: 0 21:20:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:20:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:20:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:20:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:20:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:20:15 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/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 21:20:15 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/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:20:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 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/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 21:20:15 INFO - mozversion application_buildid: 20161020182350 21:20:15 INFO - mozversion application_changeset: e4e6022059e5c35d3b1bbc731b1f68f266302be3 21:20:15 INFO - mozversion application_display_name: Firefox 21:20:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:15 INFO - mozversion application_name: Firefox 21:20:15 INFO - mozversion application_remotingname: firefox 21:20:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:20:15 INFO - mozversion application_vendor: Mozilla 21:20:15 INFO - mozversion application_version: 50.0 21:20:15 INFO - mozversion platform_buildid: 20161020182350 21:20:15 INFO - mozversion platform_changeset: e4e6022059e5c35d3b1bbc731b1f68f266302be3 21:20:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:20:15 INFO - mozversion platform_version: 50.0 21:20:15 INFO - using testdate: 1477023615 21:20:15 INFO - actual date: 1477023615 21:20:15 INFO - starting webserver on 'localhost:39043' 21:20:15 INFO - SUITE-START | Running 2 tests 21:20:15 INFO - TEST-START | dromaeo_css 21:20:15 INFO - operating with platform_type : linux_ 21:20:15 INFO - Initialising browser for dromaeo_css test... 21:20:15 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgggHc/profile http://localhost:39043/getInfo.html) 21:20:20 INFO - PROCESS | 4159 | __metrics Screen width/height:1600/1200 21:20:20 INFO - PROCESS | 4159 | colorDepth:24 21:20:20 INFO - PROCESS | 4159 | Browser inner width/height: 1024/697 21:20:20 INFO - PROCESS | 4159 | __metrics 21:20:20 ERROR - PROCESS | 4159 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:20:21 INFO - TEST-INFO | 4159: exit 0 21:20:21 INFO - Browser initialized. 21:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:20:21 INFO - TEST-INFO | started process 4287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgggHc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:20:33 INFO - PROCESS | 4287 | RSS: Main: 150511616 21:20:33 INFO - PROCESS | 4287 | 21:21:23 INFO - PROCESS | 4287 | 1477023682996 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] 21:23:31 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39043/tests/dromaeo/cssquery-ext.html) 21:23:32 INFO - PROCESS | 4287 | RSS: Main: 158556160 21:23:32 INFO - PROCESS | 4287 | 21:26:34 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-ext.html (next: http://localhost:39043/tests/dromaeo/cssquery-jquery.html) 21:26:34 INFO - PROCESS | 4287 | RSS: Main: 156008448 21:26:34 INFO - PROCESS | 4287 | 21:29:36 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39043/tests/dromaeo/cssquery-mootools.html) 21:29:37 INFO - PROCESS | 4287 | RSS: Main: 155471872 21:29:37 INFO - PROCESS | 4287 | 21:32:39 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39043/tests/dromaeo/cssquery-prototype.html) 21:32:39 INFO - PROCESS | 4287 | RSS: Main: 157106176 21:32:39 INFO - PROCESS | 4287 | 21:35:42 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39043/tests/dromaeo/cssquery-yui.html) 21:35:42 INFO - PROCESS | 4287 | RSS: Main: 158044160 21:35:42 INFO - PROCESS | 4287 | 21:38:44 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:39043/tests/dromaeo/cssquery-yui.html (next: http://localhost:39043/tests/dromaeo/cssquery-dojo.html) 21:38:45 INFO - PROCESS | 4287 | RSS: Main: 157388800 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | __start_tp_report 21:38:45 INFO - PROCESS | 4287 | _x_x_mozilla_page_load 21:38:45 INFO - PROCESS | 4287 | _x_x_mozilla_page_load_details 21:38:45 INFO - PROCESS | 4287 | |i|pagename|runs| 21:38:45 INFO - PROCESS | 4287 | |0;dojo.html;3256.8208748518828;3273.7053665170138;3274.2796584751345;3290.4735242361226;3300.867965281389;5761.913571296429;5804.622699524533;5821.912671309934;5836.066229403291;5842.737076831542;5768.567357448187;5780.248567686195;5796.62321949073;5804.477597016267;5817.040188368925;5195.922061169076;5246.501582349671;5259.289995850569;5293.073712100387;5309.230161626562;5304.787808487656;5305;5310.8406747797435;5315.468453154692;5346.732663366835;5129.769160387791;5176.301199338098;5267.736613169345;5282.841514754545;5301.787928482856;5263.368395792491;5327.813526526553;5336.893262134736;5339.199120131992;5389.973050134763;5223.660462069954;5277.683338999634;5283;5288.629795914288;5295.867603309909;5643.68959707216;5725.255716756837;5773.913391299134;5811.564132690023;5889.1755154278435;6078.088286756978;6195.380461953769;6199.287081985584;6207.255129384503;6214.782482613132;6230.7819226326865;6238.906416403757;6238.968805155945;6244.531660125509;6265.373462653698;5691.630044047124;5705.429457054344;5797.4782269595935;5806.651600903917;5841.9415805842245;6279.591826531261;6373.52198585108;6386;6392.968035159887;6395.744170233232;6119.082137679384;6135.693215339215;6137.693115344215;6137.693115344215;6147.139400483936;5993.340732519419;6113.658745237643;6201.6899155042065;6245.937540624535;6255.530835187379;6152.8769424611255;6259.843503912439;6261.467775239064;6264.404881536247;6267.780627678009;6227.221597300338;6246.125542424064;6258.311585725566;6260.530460215502;6272.529560282906;4586.633069354443;4669.042846216517;4736.95263047372;4743.335932969387;4752.1683705351425;4167.4790651168605;4217.5782421758195;4223.66210703143;4243.554426785143;4259.87220383389;5978.209332155414;6006.699665016819;6013.579049466495;6013.849653758603;6051.4553690168095;6046.848828779316;6069.2110025696375;6288.937110628835;6299.6850157491945;6300.054991751183;5842.8539286517325;5899.439553242435;5909.586328957018;5909.704514774244;5934.317553481319;5093.617978651616;5143.151380022329;5145.897082058338;5148.176291793295;5155.6391052626705;6157.661328626879;6304.18045654062;6358.395952384516;6421.775237866652;6430;6281.089242059876;6292;6299.905501417574;6305.90541141874;6312.495000400048;6449.645269510222;6484;6488.513361497812;6501.479881609365;6502.057201705632;5985.610935289193;6016.187814644967;6045;6159.23009623797;6163.137160797402;6245.469135123565;6252.1559589456665;6260.186175797117;6267.185265915402;6271.372862713874;6031.879362412815;6070.332263451105;6079.270487541523;6080.452759251689;6089.117078023573;5944.048952167633;5981.371955944737;6023.488003519575;6078.541948427334;6104.145419641342;6000.489958353589;6055;6061.1514387984835;6061.969690151521;6062.211912451353;6062.060380641008;6128.264608247039;6142.907856382247;6152.846178845564;6164.075388691732;5739.827805165852;5802.854928626649;5876.08920617305;5919.437653422918;5969.850753731192 21:38:45 INFO - PROCESS | 4287 | |1;ext.html;594.748055343502;622.9937700622994;661.9900701489479;663.8141320430279;703.4161645833958;40734.18531629365;47082.29376559346;47137.528624713785;47193.29210061852;47224.52775472244;46078.769606152004;46641.30038049432;46658.53341466584;46662.30006549905;46816;8932.955335223314;9015.143561361692;9020.684276050339;9029.683961061364;9056.818863622724;9116.316276279273;9130.452172869616;9204.079592040776;9208.907910920905;9209.769755756126;9231.676891308805;9245.630174793001;9271.25829933607;9274.536273186348;9274.907250927505;9212.309076819232;9235.630574777;9261.120193581599;9261.722148335528;9263.027382124847;8488.151184881524;8583.484990900566;8596.355273354524;8597.441166324232;8604.52675102869;44012;44422.33366499505;44599.33101003455;44747.328790068175;44836.3274550882;3880.864169754045;3967.8214480348165;4128.277551428518;4219.346001369762;4672.15901137795;35974.28051438983;36247.45628815544;36287;36694.633053669655;36846.26307473835;4732.645051621108;4763.14263432582;4837.226043833005;4874.585660218886;4946.777395017233;360678;362650;363951;364519;366891;64545.35454645487;64597.354026460074;65066.674666626364;65086.349136508026;65142;39896;40534.79732601377;40642.59357406388;42777.572224277355;69915;18813.717794233096;18983.90508047451;19005.904970475058;19041.14314855835;19119.80880191208;14852.70294594102;15125.39498420073;15249.771253431207;15256.084634921941;15359;20969.89515052415;21093.472663183235;21165.576688466146;21309.36071917845;21368.358949231548;7467.290607392289;7520.172780994087;7521.172671006185;7662.540247585162;7699.191584883507;1033.2199189611795;1042.4579218806177;1107.645553422913;1108.6396921000546;1171.7480741640588;33529.66470335314;34507.05627102454;34670;34755.30489390198;35246.47130293048;1143.4568579924469;1177.9057675385948;1179.8525184351956;1215.3133479584008;1287.4914408808468;17935.910320448314;18304.63390732178;18321.083945802657;18373.7243941341;18410.447686569423;603871;855535;873024;873270;875243;66534.66732666403;67074.66462667656;67078.32921670818;67201.66399167973;67276.6636166816;1447.4499690117898;1460.0947412604253;1464.05568408376;1481.052126638952;1493.4698182145182;34591.13522161966;35336;35533.82233088818;35597.64402356047;35918.640813592574;58465;58888.411115890005;58935;59241.11138333015;59417.70291148689;500710;503635;505312;505336;506516;31887.36225275528;31993.6800632;32659.34681306408;32788.67211327856;32804.67195328016;51918;52816.471835281154;53568;54165.45834541762;58262;45645.771771140935;47060.52939470561;47120.29319560278;47752.7612361936;48859.75570122269;46511.53488465207;46649.3002604968;47653.523464766295;48184.27723584219;48245.5175448241;45263.321050183615;45339.31991020203;46672.766636166605;46680.53319466898;46760;39056;40027;40886;41022.58977410188;41346.58653413427;30690.386192276477;30726.385472290876;30807.921722739597;30959.69040309568;31115.68884311128 21:38:45 INFO - PROCESS | 4287 | |2;jquery.html;405.8153540139237;418.6274215947809;422.48245898773996;428.3916838089912;441.60696979688083;19350;20945.952702364877;21017.894910525443;21232.150713971423;21860.781392186112;20816.895915520403;20968.895155524202;21084.57830843382;21347.57304853902;21525.67711484329;6019.789307374253;6221.346758590328;6224;6228.875422491547;6240.4071613196675;6015.9398406016035;6089.908651370233;6100.633961962274;6101.938980610182;6130.386961303856;5891.234139561851;6016.458518733313;6024.1566180734735;6025.15647809307;6045.365236650155;5896.115582662614;5964.433378829026;5987.880242395149;5993.61041532299;6015.879682406371;5349.545288650469;5419.918701219485;5489.533389661883;5511.751971161308;5512.145617429305;18037.27850885963;24310.149144779847;24472.143474978468;24964.126255580966;25117.748822511723;2575.72954839741;2705.9052933147245;3023.9848800756076;3334.816585087819;3382.0868365541164;15581;15667.764983525256;15877.36490540377;16034.438794642132;16105.838941610667;2020.2121172742643;2046.4883779055235;2067.2066310011173;2128.9787102128935;2172.997557483362;79468.60265698635;79587.60206198989;79877.60061199658;80681;81058;11379.374134422686;11403.144764142722;11445.484953177127;11570.88429115698;11686.24039437434;16401.917990409973;16402.917985409997;16406.917965410335;16413;16462.259198336105;8873.511956842436;9089.77275568116;9113.726588202364;9114.498702571422;9217.769555761026;8848.601812918434;8893.155150260714;8944;9096.499692516843;9128.863067053999;7065.763491388986;7071.8939215911805;7158.391536719437;7285.271472852673;7292.708291668274;2066.142550841414;2071.78246284138;2086.238522939116;2087.4259578616;2087.4885653014803;948.7580666929889;1054.467493915583;1060.3743791163097;1077.7844431113808;1138.5275110828914;20618;21087.894560527406;21216.575668486545;21232.469188270417;21268.574628507344;1078.946052697362;1087.9184061195442;1097.2922465010024;1105.4969988655143;1147.3804145761196;11299.378534180534;11957.88042119585;11964.102692297938;12052.457639406248;12127.818082728767;508201;519750;582018;583281;595129;62336.37663623397;87187;97042;103815.4809225949;105216;1049.7690508088208;1062.0759938853248;1103.8454616353717;1107.147496427746;1109.2512554025839;18409;18808.52978675544;19145.13846876866;19193.32823351176;19208.847469151337;45105.54894451145;45169.09661806811;45456.77271613753;46802;47393.52606473891;57255;62834.685826570574;63604.68197658982;64538.677306613165;64923.67538162279;9080.137386948229;9139.58871850755;9221.815563688822;9337.299702522474;9517.095875891779;12266.938665306616;14187.432502700189;14324.57026289213;14352.21062841512;14388.424463021362;12052.75894482123;12295.200811947196;12536.874631253935;12577.87422125767;12754.42605082792;10544.736381590521;12551.3096779678;12658.050646201387;12694.174878632859;12894.742105158031;12500.124991250525;12565;12938.417771200131;12998.285094319903;13042.804357934448;9252.907470925475;9353.017933117197;9359.532023398939;9394.154526092685;9412.764680883032;11570.479328430072;11979.460924258603;12236.327002014974;12399.442025108712;12767.595564487714 21:38:45 INFO - PROCESS | 4287 | |3;mootools.html;1507.0882116319626;1553.068159104537;1734.6964281250787;1895.744074549937;1897.6868816645247;8600.56997150143;9251.676191333305;9435.339526233167;9947.452890091043;9962.651307204249;9471.905280947205;9885;9890.703278901645;9896.208303335734;9918.256130790201;2397.7602239776056;2420.43119866832;2446.7430919753438;2458.2010846474877;2460.6063029915217;2469.3579669286023;2489.4772097859473;2509.422832748469;2511.6232565115197;2520.042383894118;2429.914952976646;2436.1351720139273;2532.328932832801;2532.5441420544294;2538.060917460542;2424.6847909771705;2432.756724327562;2440.365504968703;2474.39377352548;2477.1330034487964;2400.2079313826393;2415.541047201044;2416.613341865293;2416.903323867043;2471.1845091119885;9788.853167202426;10028.59885604575;10029.648962286357;10045.598176073021;10046.296759226858;5556.472135147154;5667.4615911488345;5669.801556945487;5677.290338707661;5693.17448969897;3531.1172206948263;3620.330238905811;3663.7069034477177;3706.3143318485895;3775.924481510382;1186.727052777866;1193.9044876409866;1235.734317121823;1250.4310538704958;1288.8646692097382;13985.230812305217;13997.160170389707;13998.230097344642;14083.859161408358;14095.78856317156;4900.558949694473;4926.3842019747535;5015.949840501548;5065.290859279704;5083.186690129635;11888.881111188777;11930.22453540517;11947.103967202494;11954.043676505858;11955.701107472209;5801.100829371454;5823.679697616672;5836.270466191726;5839.854003649858;5842.883142337215;4679.298105284234;5055.292259083732;5205.011047900886;5213.191955246943;5328.040952628487;4287.185434767384;4332.1119170569955;4380.69335146543;4439.778011099432;4442.267025940683;1295.3264302562802;1315.9736805263842;1316.1116246533552;1322.2397121655088;1325.9138156019828;1054.4991129213563;1057.4501259345097;1058.4813441413653;1062.3148069495287;1070.5075665194097;6493.610383376918;6518.120053792677;6699.732010719614;6723.697433615499;6739.865202695919;472.6951116529819;481.4872161148366;1022.3303736052898;1090.1278976818514;1114.9498272577753;4135.875923722293;4179.12238429927;4253.595908388698;4312.245357062501;4338.891527711769;12045.518179272905;12278.877211227951;12359.32023738703;12363.876361236273;12418.316992565495;12314.261144331369;12342.81485777714;12356.505739770488;12454.750904981849;12506.062045346636;8646.913530864736;8920.420172688755;9001.819963600692;9154.130357616015;9180.403273787182;6611.438027767694;6617.239017513048;6713.395794378334;6815.795526134224;6892.793216203522;10731.463426828783;11463;11615.6515304541;11622.82565761531;11688.649340519458;11252.549898003988;11269.436528173723;11270.436478175894;11435.085193184359;11447.427628618703;8761;8772.473651580925;8847.336449766422;8918.10818918103;8948.328875334506;9338.719838404859;9413.29400294967;9443.102905224268;9448.622055117994;9467.479288639192;8660.653573856975;8737.03892571804;8749.08134645853;8826.161514656098;8832.735017949472;8203.261706446448;8270.214329638675;8314.833703326021;8374.455660382057;8417.747467575982;7676.654550545127;7812.765617031499;7830.33442157423;7831.84336313282;7841.098273698598;5678.290213723285;5716.171155182558;5779.8555036124435;5797.681127538026;5839.919614871263;5710.5146062585145;5722.084466485342;5731.083026715705;5811.535077193899;5826.504747096375 21:38:45 INFO - PROCESS | 4287 | |4;prototype.html;328.9440795064839;333.13052931847875;336.93429781192646;347.23608062263025;350.81582169361087;5780.4219578042175;5837.970810145948;5856.56075794315;5866.76532938682;5880.852978675524;5728.255326807509;5744.885102297952;5752.971235143829;5762.452567006138;5791.160281759142;4292.1630282095;4402.405675233835;4469.307257375096;4509.616682581985;4533.387992621004;4470.2400591899295;4481.5070342262325;4496.572825581581;4507.188706032913;4520.3219517072375;4461.107778444324;4476.03765190484;4491.887702807439;4513.887152821189;4523.253663145577;4187.1625674865;4413.44831896013;4423.380726698281;4423.690341676084;4428.490723566799;3909.257241124177;3931.7444366116397;3950.6839452843706;3954.5056867891512;3956.66368358687;5663.915041274384;5678.488935995781;5701.657900525982;5711.7144142792695;5728.398518155575;4985.601151907875;5078.7460626968505;5091.694498330112;5093.516115968977;5125.538701516882;5990.891685038282;6012.5791194616395;6031.698415079229;6048.727807248684;6086.1783659205885;4191.580841915784;4308.6983911126235;4322.876052226444;4326.740395576244;4328.891777705582;6222.346653601352;6270.529710271748;6270.905936410957;6272.435480806749;6272.874542509125;4457.531959144243;4466.486354069324;4478.715854914018;4484.775761211927;4503.234450143484;4305.203537345601;4529.84145554904;4530.864074077783;4561.840335588238;4565;5115.948840511622;5118.948810511922;5133.614978876599;5146.948530514722;5176.249443830623;6061.787837425669;6094.6647934363145;6098.237720284965;6112.074696470598;6138.1713468681155;1485.970280594382;1499.265359973605;1504.0674781635455;1523.9466618668516;1535.4702627593463;977.9364341317792;994.9602015919282;1037.3931250218707;1057.9471026448646;1079.169039839335;5774;5784.4504772046585;5813.7500437405315;5816.738246778905;5847.193347193286;6085.817425477243;6129.353034944201;6155.569110162246;6193.4425901669065;6204.751809927642;5595.433278681976;5746.540276777848;5778.711064446761;5784.652920824764;5817.331006934172;3265.3632541654624;3292.209869631319;3320.900372988814;3322.621112238394;3334.4164771165433;6140.5701600887505;6333.429991300713;6354.3010268870385;6377.298497165308;6415.775447859302;6228;6237.656928868956;6251.687415629201;6263;6277;6222.564420490613;6406.686629240994;6412.198475190601;6415.518836087312;6432.678366081771;6235.812925612239;6288.213973253343;6306;6307.684615769102;6317.368263173646;6182.598131121463;6184;6197.411245931629;6218;6225.875482490234;6287.182666253358;6463.095166676763;6494.447971922439;6505.674716264073;6511.641859697762;4485.798139083684;4510.436195475566;4531.410916580823;4531.977340113278;4547.977260113678;6070.696465176812;6165.5375846810775;6309.274433440213;6336.714847831767;6360.427561519486;6032.969835150796;6057.122866638311;6067.544934130046;6081.016933908297;6115.816525504064;6052.788152414821;6079.635221886701;6100.938990610037;6110.480609148272;6127.3566275540425;5847.970760146172;5848.298204215522;6036.185115009417;6064.514838812973;6067.393260673897;6132.202813634199;6139.324674285915;6147.08013693492;6166.568340216142;6169.383061693795;5873.295204575478;5974.044152935509;5988;6000.669963152069;6012.398760123952 21:38:45 INFO - PROCESS | 4287 | |5;yui.html;797.4617133434933;814.360726829439;840.4537050916904;884.3676771108657;919.8758167647366;17593.472195834114;17819.91090044548;18320.992345420997;18527.5368115797;18538.165782539785;16553.66892662146;16577.83422165781;16738.246778894947;16740.330386784513;16749.246283917222;866.5667166416791;892.5715656484891;893.7631527645179;893.9106089391041;894.3158483759896;743.2567432567432;869.652139144341;885.340421386065;888.0276097673037;891.6611687558718;923.3490389275545;935.1256575102267;938.0478814003792;938.3337830140574;938.3712912348709;927.5686805635378;929.809389075238;930.6137952749601;931.9767005824875;932.4498545857977;677.7255211639244;680.6120511308557;684.4045680258157;685.3283781893722;685.396850771323;17241.741373879275;17321.307147714077;17375.565610859703;17402.825971740247;17419.30322787087;14765;14902.925485372503;14948.40206391743;15401.537953861402;15559.533214003599;13710.177389356571;13723.382447789874;14091.577252682437;14230.153969206096;14679.55961321162;4105.548389677133;4153.356229784388;4207.453031105967;4252.87241382759;4256.361545768129;92838.53580732121;93786.53106734491;93941.53029234879;94035.52982235113;94327;13265.867341326657;13354.93322533381;13482.19106853592;13749;14369.56891293263;25912.74087259141;26017.349566260615;26318;26338.341541461617;26408.207753767034;9464.1009104135;9518.286128540387;9587.089226523469;9673.467959262167;10160.644377446753;5447.945520544823;5455.345358556999;5460;5544.390117087117;5627.549796016309;3883.6310550497656;3995.9200815983518;4007.2987227235117;4009.0578714002186;4009.6190861868076;629.8677277771627;631.4348657951108;638.9265234498092;664.2427632498955;664.6377724140258;778.5951305321202;795.4431897671653;817.9141190175066;831.7089018843357;832.196929962589;9655.855162172573;10005.949970250102;11051.447427628747;11388.601398950997;11441.48513316886;713.0373995106668;751.8646643604094;758.9089309282922;821.8191997760483;835.5446281776447;5131.7690703918415;5402.297701298885;5419.83740487786;5439.102548079602;5497.505224529811;104849.47575262075;105483.47258263659;106190.597483805;141709;145751;104661.47669261758;105406;105544;110789;111045.44477277562;79638.6018069906;87301.56349218213;95704.52147739216;97071;100674;10511.632092876713;10917.727056823644;11305.378204198849;11512.251703639236;11554;55993.44006559882;56433.43566564282;56498;56652.15021774594;56726;83139;85709.57145214484;86439;87966.56016719875;88407.55796220977;13162.210267383987;13442.852149597964;13907;14031.789523156956;14078.788818167941;15564.533064008097;15834.524964251092;15953.601159971093;16049.679006419572;16503.257353418885;14152.971395795324;14468.348924298221;15130.924345378202;15501.069935803887;15613.297401617181;14721.852781472477;14762.040467369587;14865.628359291104;15025.474108406153;15247.466338678092;13728;13767.173969561458;13953.302334883012;14135;14181.929090354895;11719.41402929833;12071.517139314328;12202.572909948109;12493.500259989498;12842;12894.355282235663;13188.538401155913;13203.471861125447;13225;13355.666108347368 21:38:45 INFO - PROCESS | 4287 | __end_tp_report 21:38:45 INFO - PROCESS | 4287 | __start_cc_report 21:38:45 INFO - PROCESS | 4287 | _x_x_mozilla_cycle_collect,331 21:38:45 INFO - PROCESS | 4287 | __end_cc_report 21:38:45 INFO - PROCESS | 4287 | __startTimestamp1477024725168__endTimestamp 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | ------- Summary: start ------- 21:38:45 INFO - PROCESS | 4287 | Number of tests: 6 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#0] dojo.html Cycles:165 Average:5762.88 Median:6013.58 stddev:676.05 (11.2%) stddev-sans-first:648.91 21:38:45 INFO - PROCESS | 4287 | Values: 3256.8 3273.7 3274.3 3290.5 3300.9 5761.9 5804.6 5821.9 5836.1 5842.7 5768.6 5780.2 5796.6 5804.5 5817.0 5195.9 5246.5 5259.3 5293.1 5309.2 5304.8 5305.0 5310.8 5315.5 5346.7 5129.8 5176.3 5267.7 5282.8 5301.8 5263.4 5327.8 5336.9 5339.2 5390.0 5223.7 5277.7 5283.0 5288.6 5295.9 5643.7 5725.3 5773.9 5811.6 5889.2 6078.1 6195.4 6199.3 6207.3 6214.8 6230.8 6238.9 6239.0 6244.5 6265.4 5691.6 5705.4 5797.5 5806.7 5841.9 6279.6 6373.5 6386.0 6393.0 6395.7 6119.1 6135.7 6137.7 6137.7 6147.1 5993.3 6113.7 6201.7 6245.9 6255.5 6152.9 6259.8 6261.5 6264.4 6267.8 6227.2 6246.1 6258.3 6260.5 6272.5 4586.6 4669.0 4737.0 4743.3 4752.2 4167.5 4217.6 4223.7 4243.6 4259.9 5978.2 6006.7 6013.6 6013.8 6051.5 6046.8 6069.2 6288.9 6299.7 6300.1 5842.9 5899.4 5909.6 5909.7 5934.3 5093.6 5143.2 5145.9 5148.2 5155.6 6157.7 6304.2 6358.4 6421.8 6430.0 6281.1 6292.0 6299.9 6305.9 6312.5 6449.6 6484.0 6488.5 6501.5 6502.1 5985.6 6016.2 6045.0 6159.2 6163.1 6245.5 6252.2 6260.2 6267.2 6271.4 6031.9 6070.3 6079.3 6080.5 6089.1 5944.0 5981.4 6023.5 6078.5 6104.1 6000.5 6055.0 6061.2 6062.0 6062.2 6062.1 6128.3 6142.9 6152.8 6164.1 5739.8 5802.9 5876.1 5919.4 5969.9 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#1] ext.html Cycles:180 Average:72329.34 Median:46653.92 stddev:159906.32 (342.8%) stddev-sans-first:160264.19 21:38:45 INFO - PROCESS | 4287 | Values: 594.7 623.0 662.0 663.8 703.4 40734.2 47082.3 47137.5 47193.3 47224.5 46078.8 46641.3 46658.5 46662.3 46816.0 8933.0 9015.1 9020.7 9029.7 9056.8 9116.3 9130.5 9204.1 9208.9 9209.8 9231.7 9245.6 9271.3 9274.5 9274.9 9212.3 9235.6 9261.1 9261.7 9263.0 8488.2 8583.5 8596.4 8597.4 8604.5 44012.0 44422.3 44599.3 44747.3 44836.3 3880.9 3967.8 4128.3 4219.3 4672.2 35974.3 36247.5 36287.0 36694.6 36846.3 4732.6 4763.1 4837.2 4874.6 4946.8 360678.0 362650.0 363951.0 364519.0 366891.0 64545.4 64597.4 65066.7 65086.3 65142.0 39896.0 40534.8 40642.6 42777.6 69915.0 18813.7 18983.9 19005.9 19041.1 19119.8 14852.7 15125.4 15249.8 15256.1 15359.0 20969.9 21093.5 21165.6 21309.4 21368.4 7467.3 7520.2 7521.2 7662.5 7699.2 1033.2 1042.5 1107.6 1108.6 1171.7 33529.7 34507.1 34670.0 34755.3 35246.5 1143.5 1177.9 1179.9 1215.3 1287.5 17935.9 18304.6 18321.1 18373.7 18410.4 603871.0 855535.0 873024.0 873270.0 875243.0 66534.7 67074.7 67078.3 67201.7 67276.7 1447.4 1460.1 1464.1 1481.1 1493.5 34591.1 35336.0 35533.8 35597.6 35918.6 58465.0 58888.4 58935.0 59241.1 59417.7 500710.0 503635.0 505312.0 505336.0 506516.0 31887.4 31993.7 32659.3 32788.7 32804.7 51918.0 52816.5 53568.0 54165.5 58262.0 45645.8 47060.5 47120.3 47752.8 48859.8 46511.5 46649.3 47653.5 48184.3 48245.5 45263.3 45339.3 46672.8 46680.5 46760.0 39056.0 40027.0 40886.0 41022.6 41346.6 30690.4 30726.4 30807.9 30959.7 31115.7 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#2] jquery.html Cycles:180 Average:31851.52 Median:12016.89 stddev:91730.86 (763.3%) stddev-sans-first:91957.80 21:38:45 INFO - PROCESS | 4287 | Values: 405.8 418.6 422.5 428.4 441.6 19350.0 20946.0 21017.9 21232.2 21860.8 20816.9 20968.9 21084.6 21347.6 21525.7 6019.8 6221.3 6224.0 6228.9 6240.4 6015.9 6089.9 6100.6 6101.9 6130.4 5891.2 6016.5 6024.2 6025.2 6045.4 5896.1 5964.4 5987.9 5993.6 6015.9 5349.5 5419.9 5489.5 5511.8 5512.1 18037.3 24310.1 24472.1 24964.1 25117.7 2575.7 2705.9 3024.0 3334.8 3382.1 15581.0 15667.8 15877.4 16034.4 16105.8 2020.2 2046.5 2067.2 2129.0 2173.0 79468.6 79587.6 79877.6 80681.0 81058.0 11379.4 11403.1 11445.5 11570.9 11686.2 16401.9 16402.9 16406.9 16413.0 16462.3 8873.5 9089.8 9113.7 9114.5 9217.8 8848.6 8893.2 8944.0 9096.5 9128.9 7065.8 7071.9 7158.4 7285.3 7292.7 2066.1 2071.8 2086.2 2087.4 2087.5 948.8 1054.5 1060.4 1077.8 1138.5 20618.0 21087.9 21216.6 21232.5 21268.6 1078.9 1087.9 1097.3 1105.5 1147.4 11299.4 11957.9 11964.1 12052.5 12127.8 508201.0 519750.0 582018.0 583281.0 595129.0 62336.4 87187.0 97042.0 103815.5 105216.0 1049.8 1062.1 1103.8 1107.1 1109.3 18409.0 18808.5 19145.1 19193.3 19208.8 45105.5 45169.1 45456.8 46802.0 47393.5 57255.0 62834.7 63604.7 64538.7 64923.7 9080.1 9139.6 9221.8 9337.3 9517.1 12266.9 14187.4 14324.6 14352.2 14388.4 12052.8 12295.2 12536.9 12577.9 12754.4 10544.7 12551.3 12658.1 12694.2 12894.7 12500.1 12565.0 12938.4 12998.3 13042.8 9252.9 9353.0 9359.5 9394.2 9412.8 11570.5 11979.5 12236.3 12399.4 12767.6 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#3] mootools.html Cycles:180 Average:6444.21 Median:4299.72 stddev:3773.99 (87.8%) stddev-sans-first:3766.34 21:38:45 INFO - PROCESS | 4287 | Values: 1507.1 1553.1 1734.7 1895.7 1897.7 8600.6 9251.7 9435.3 9947.5 9962.7 9471.9 9885.0 9890.7 9896.2 9918.3 2397.8 2420.4 2446.7 2458.2 2460.6 2469.4 2489.5 2509.4 2511.6 2520.0 2429.9 2436.1 2532.3 2532.5 2538.1 2424.7 2432.8 2440.4 2474.4 2477.1 2400.2 2415.5 2416.6 2416.9 2471.2 9788.9 10028.6 10029.6 10045.6 10046.3 5556.5 5667.5 5669.8 5677.3 5693.2 3531.1 3620.3 3663.7 3706.3 3775.9 1186.7 1193.9 1235.7 1250.4 1288.9 13985.2 13997.2 13998.2 14083.9 14095.8 4900.6 4926.4 5015.9 5065.3 5083.2 11888.9 11930.2 11947.1 11954.0 11955.7 5801.1 5823.7 5836.3 5839.9 5842.9 4679.3 5055.3 5205.0 5213.2 5328.0 4287.2 4332.1 4380.7 4439.8 4442.3 1295.3 1316.0 1316.1 1322.2 1325.9 1054.5 1057.5 1058.5 1062.3 1070.5 6493.6 6518.1 6699.7 6723.7 6739.9 472.7 481.5 1022.3 1090.1 1114.9 4135.9 4179.1 4253.6 4312.2 4338.9 12045.5 12278.9 12359.3 12363.9 12418.3 12314.3 12342.8 12356.5 12454.8 12506.1 8646.9 8920.4 9001.8 9154.1 9180.4 6611.4 6617.2 6713.4 6815.8 6892.8 10731.5 11463.0 11615.7 11622.8 11688.6 11252.5 11269.4 11270.4 11435.1 11447.4 8761.0 8772.5 8847.3 8918.1 8948.3 9338.7 9413.3 9443.1 9448.6 9467.5 8660.7 8737.0 8749.1 8826.2 8832.7 8203.3 8270.2 8314.8 8374.5 8417.7 7676.7 7812.8 7830.3 7831.8 7841.1 5678.3 5716.2 5779.9 5797.7 5839.9 5710.5 5722.1 5731.1 5811.5 5826.5 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#4] prototype.html Cycles:180 Average:5104.00 Median:5815.24 stddev:1509.63 (26.0%) stddev-sans-first:1470.71 21:38:45 INFO - PROCESS | 4287 | Values: 328.9 333.1 336.9 347.2 350.8 5780.4 5838.0 5856.6 5866.8 5880.9 5728.3 5744.9 5753.0 5762.5 5791.2 4292.2 4402.4 4469.3 4509.6 4533.4 4470.2 4481.5 4496.6 4507.2 4520.3 4461.1 4476.0 4491.9 4513.9 4523.3 4187.2 4413.4 4423.4 4423.7 4428.5 3909.3 3931.7 3950.7 3954.5 3956.7 5663.9 5678.5 5701.7 5711.7 5728.4 4985.6 5078.7 5091.7 5093.5 5125.5 5990.9 6012.6 6031.7 6048.7 6086.2 4191.6 4308.7 4322.9 4326.7 4328.9 6222.3 6270.5 6270.9 6272.4 6272.9 4457.5 4466.5 4478.7 4484.8 4503.2 4305.2 4529.8 4530.9 4561.8 4565.0 5115.9 5118.9 5133.6 5146.9 5176.2 6061.8 6094.7 6098.2 6112.1 6138.2 1486.0 1499.3 1504.1 1523.9 1535.5 977.9 995.0 1037.4 1057.9 1079.2 5774.0 5784.5 5813.8 5816.7 5847.2 6085.8 6129.4 6155.6 6193.4 6204.8 5595.4 5746.5 5778.7 5784.7 5817.3 3265.4 3292.2 3320.9 3322.6 3334.4 6140.6 6333.4 6354.3 6377.3 6415.8 6228.0 6237.7 6251.7 6263.0 6277.0 6222.6 6406.7 6412.2 6415.5 6432.7 6235.8 6288.2 6306.0 6307.7 6317.4 6182.6 6184.0 6197.4 6218.0 6225.9 6287.2 6463.1 6494.4 6505.7 6511.6 4485.8 4510.4 4531.4 4532.0 4548.0 6070.7 6165.5 6309.3 6336.7 6360.4 6033.0 6057.1 6067.5 6081.0 6115.8 6052.8 6079.6 6100.9 6110.5 6127.4 5848.0 5848.3 6036.2 6064.5 6067.4 6132.2 6139.3 6147.1 6166.6 6169.4 5873.3 5974.0 5988.0 6000.7 6012.4 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - PROCESS | 4287 | [#5] yui.html Cycles:180 Average:23198.76 Median:15145.92 stddev:33073.53 (218.4%) stddev-sans-first:33123.54 21:38:45 INFO - PROCESS | 4287 | Values: 797.5 814.4 840.5 884.4 919.9 17593.5 17819.9 18321.0 18527.5 18538.2 16553.7 16577.8 16738.2 16740.3 16749.2 866.6 892.6 893.8 893.9 894.3 743.3 869.7 885.3 888.0 891.7 923.3 935.1 938.0 938.3 938.4 927.6 929.8 930.6 932.0 932.4 677.7 680.6 684.4 685.3 685.4 17241.7 17321.3 17375.6 17402.8 17419.3 14765.0 14902.9 14948.4 15401.5 15559.5 13710.2 13723.4 14091.6 14230.2 14679.6 4105.5 4153.4 4207.5 4252.9 4256.4 92838.5 93786.5 93941.5 94035.5 94327.0 13265.9 13354.9 13482.2 13749.0 14369.6 25912.7 26017.3 26318.0 26338.3 26408.2 9464.1 9518.3 9587.1 9673.5 10160.6 5447.9 5455.3 5460.0 5544.4 5627.5 3883.6 3995.9 4007.3 4009.1 4009.6 629.9 631.4 638.9 664.2 664.6 778.6 795.4 817.9 831.7 832.2 9655.9 10005.9 11051.4 11388.6 11441.5 713.0 751.9 758.9 821.8 835.5 5131.8 5402.3 5419.8 5439.1 5497.5 104849.5 105483.5 106190.6 141709.0 145751.0 104661.5 105406.0 105544.0 110789.0 111045.4 79638.6 87301.6 95704.5 97071.0 100674.0 10511.6 10917.7 11305.4 11512.3 11554.0 55993.4 56433.4 56498.0 56652.2 56726.0 83139.0 85709.6 86439.0 87966.6 88407.6 13162.2 13442.9 13907.0 14031.8 14078.8 15564.5 15834.5 15953.6 16049.7 16503.3 14153.0 14468.3 15130.9 15501.1 15613.3 14721.9 14762.0 14865.6 15025.5 15247.5 13728.0 13767.2 13953.3 14135.0 14181.9 11719.4 12071.5 12202.6 12493.5 12842.0 12894.4 13188.5 13203.5 13225.0 13355.7 21:38:45 INFO - PROCESS | 4287 | -------- Summary: end -------- 21:38:45 INFO - PROCESS | 4287 | 21:38:45 INFO - TEST-INFO | 4287: exit 0 21:38:45 INFO - TEST-OK | dromaeo_css | took 1110356ms 21:38:45 INFO - TEST-START | kraken 21:38:45 INFO - operating with platform_type : linux_ 21:38:45 INFO - Initialising browser for kraken test... 21:38:45 INFO - TEST-INFO | started process 4526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnERB4D/profile http://localhost:39043/getInfo.html) 21:38:49 INFO - PROCESS | 4526 | __metrics Screen width/height:1600/1200 21:38:49 INFO - PROCESS | 4526 | colorDepth:24 21:38:49 INFO - PROCESS | 4526 | Browser inner width/height: 1024/697 21:38:49 INFO - PROCESS | 4526 | __metrics 21:38:50 ERROR - PROCESS | 4526 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:38:51 INFO - TEST-INFO | 4526: exit 0 21:38:51 INFO - Browser initialized. 21:38:51 INFO - Running cycle 1/1 for kraken test... 21:38:51 INFO - TEST-INFO | started process 4655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnERB4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:03 INFO - PROCESS | 4655 | RSS: Main: 150011904 21:39:03 INFO - PROCESS | 4655 | 21:39:05 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39043/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:06 INFO - PROCESS | 4655 | RSS: Main: 156577792 21:39:06 INFO - PROCESS | 4655 | 21:39:09 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39043/tests/kraken/driver.html?testName=audio-dft) 21:39:09 INFO - PROCESS | 4655 | RSS: Main: 155238400 21:39:09 INFO - PROCESS | 4655 | 21:39:12 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39043/tests/kraken/driver.html?testName=audio-fft) 21:39:13 INFO - PROCESS | 4655 | RSS: Main: 156315648 21:39:13 INFO - PROCESS | 4655 | 21:39:15 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39043/tests/kraken/driver.html?testName=audio-oscillator) 21:39:15 INFO - PROCESS | 4655 | RSS: Main: 155303936 21:39:15 INFO - PROCESS | 4655 | 21:39:18 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:18 INFO - PROCESS | 4655 | RSS: Main: 155238400 21:39:18 INFO - PROCESS | 4655 | 21:39:21 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39043/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:22 INFO - PROCESS | 4655 | RSS: Main: 155602944 21:39:22 INFO - PROCESS | 4655 | 21:39:25 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39043/tests/kraken/driver.html?testName=imaging-desaturate) 21:39:26 INFO - PROCESS | 4655 | RSS: Main: 155774976 21:39:26 INFO - PROCESS | 4655 | 21:39:29 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39043/tests/kraken/driver.html?testName=json-parse-financial) 21:39:29 INFO - PROCESS | 4655 | RSS: Main: 156315648 21:39:29 INFO - PROCESS | 4655 | 21:39:31 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:39:31 INFO - PROCESS | 4655 | RSS: Main: 155676672 21:39:31 INFO - PROCESS | 4655 | 21:39:33 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:39:34 INFO - PROCESS | 4655 | RSS: Main: 155693056 21:39:34 INFO - PROCESS | 4655 | 21:39:36 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:39:36 INFO - PROCESS | 4655 | RSS: Main: 156147712 21:39:36 INFO - PROCESS | 4655 | 21:39:39 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:39:40 INFO - PROCESS | 4655 | RSS: Main: 156037120 21:39:40 INFO - PROCESS | 4655 | 21:39:42 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:39:43 INFO - PROCESS | 4655 | RSS: Main: 156463104 21:39:43 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:39043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39043/tests/kraken/driver.html?testName=ai-astar) 21:39:45 INFO - PROCESS | 4655 | RSS: Main: 158392320 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | __start_tp_report 21:39:45 INFO - PROCESS | 4655 | _x_x_mozilla_page_load 21:39:45 INFO - PROCESS | 4655 | _x_x_mozilla_page_load_details 21:39:45 INFO - PROCESS | 4655 | |i|pagename|runs| 21:39:45 INFO - PROCESS | 4655 | |0;ai-astar;101;111;104;110;111;111;113;111;110;110 21:39:45 INFO - PROCESS | 4655 | |1;audio-beat-detection;142;125;145;171;118;146;147;117;180;118 21:39:45 INFO - PROCESS | 4655 | |2;audio-dft;162;163;163;163;163;162;163;162;161;161 21:39:45 INFO - PROCESS | 4655 | |3;audio-fft;74;76;75;174;77;77;74;75;181;75 21:39:45 INFO - PROCESS | 4655 | |4;audio-oscillator;84;84;152;84;84;84;133;85;84;152 21:39:45 INFO - PROCESS | 4655 | |5;imaging-gaussian-blur;117;118;117;118;118;117;121;120;117;117 21:39:45 INFO - PROCESS | 4655 | |6;imaging-darkroom;147;148;146;146;146;146;151;147;146;146 21:39:45 INFO - PROCESS | 4655 | |7;imaging-desaturate;95;95;96;95;94;95;95;95;95;95 21:39:45 INFO - PROCESS | 4655 | |8;json-parse-financial;50;53;51;49;50;51;51;51;52;51 21:39:45 INFO - PROCESS | 4655 | |9;json-stringify-tinderbox;59;61;61;60;60;59;60;60;63;61 21:39:45 INFO - PROCESS | 4655 | |10;stanford-crypto-aes;73;74;73;72;73;73;80;73;77;73 21:39:45 INFO - PROCESS | 4655 | |11;stanford-crypto-ccm;119;135;128;122;121;127;128;134;161;130 21:39:45 INFO - PROCESS | 4655 | |12;stanford-crypto-pbkdf2;162;169;153;159;160;156;157;156;154;154 21:39:45 INFO - PROCESS | 4655 | |13;stanford-crypto-sha256-iterative;62;63;62;64;67;61;61;61;62;61 21:39:45 INFO - PROCESS | 4655 | __end_tp_report 21:39:45 INFO - PROCESS | 4655 | __start_cc_report 21:39:45 INFO - PROCESS | 4655 | _x_x_mozilla_cycle_collect,850 21:39:45 INFO - PROCESS | 4655 | __end_cc_report 21:39:45 INFO - PROCESS | 4655 | __startTimestamp1477024785418__endTimestamp 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | ------- Summary: start ------- 21:39:45 INFO - PROCESS | 4655 | Number of tests: 14 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.71 (3.3%) stddev-sans-first:2.47 21:39:45 INFO - PROCESS | 4655 | Values: 101.0 111.0 104.0 110.0 111.0 111.0 113.0 111.0 110.0 110.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.50 stddev:22.08 (15.2%) stddev-sans-first:23.42 21:39:45 INFO - PROCESS | 4655 | Values: 142.0 125.0 145.0 171.0 118.0 146.0 147.0 117.0 180.0 118.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 21:39:45 INFO - PROCESS | 4655 | Values: 162.0 163.0 163.0 163.0 163.0 162.0 163.0 162.0 161.0 161.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#3] audio-fft Cycles:10 Average:95.80 Median:75.00 stddev:43.10 (57.5%) stddev-sans-first:44.99 21:39:45 INFO - PROCESS | 4655 | Values: 74.0 76.0 75.0 174.0 77.0 77.0 74.0 75.0 181.0 75.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:30.17 (35.9%) stddev-sans-first:31.24 21:39:45 INFO - PROCESS | 4655 | Values: 84.0 84.0 152.0 84.0 84.0 84.0 133.0 85.0 84.0 152.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.41 (1.2%) stddev-sans-first:1.45 21:39:45 INFO - PROCESS | 4655 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 121.0 120.0 117.0 117.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.50 stddev:1.60 (1.1%) stddev-sans-first:1.69 21:39:45 INFO - PROCESS | 4655 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 151.0 147.0 146.0 146.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:39:45 INFO - PROCESS | 4655 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.10 (2.2%) stddev-sans-first:1.12 21:39:45 INFO - PROCESS | 4655 | Values: 50.0 53.0 51.0 49.0 50.0 51.0 51.0 51.0 52.0 51.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:1.17 (1.9%) stddev-sans-first:1.13 21:39:45 INFO - PROCESS | 4655 | Values: 59.0 61.0 61.0 60.0 60.0 59.0 60.0 60.0 63.0 61.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.00 stddev:2.47 (3.4%) stddev-sans-first:2.59 21:39:45 INFO - PROCESS | 4655 | Values: 73.0 74.0 73.0 72.0 73.0 73.0 80.0 73.0 77.0 73.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:129.00 stddev:11.94 (9.3%) stddev-sans-first:11.91 21:39:45 INFO - PROCESS | 4655 | Values: 119.0 135.0 128.0 122.0 121.0 127.0 128.0 134.0 161.0 130.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:4.81 (3.0%) stddev-sans-first:4.88 21:39:45 INFO - PROCESS | 4655 | Values: 162.0 169.0 153.0 159.0 160.0 156.0 157.0 156.0 154.0 154.0 21:39:45 INFO - PROCESS | 4655 | 21:39:45 INFO - PROCESS | 4655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.90 (3.1%) stddev-sans-first:2.01 21:39:45 INFO - PROCESS | 4655 | Values: 62.0 63.0 62.0 64.0 67.0 61.0 61.0 61.0 62.0 61.0 21:39:45 INFO - PROCESS | 4655 | -------- Summary: end -------- 21:39:45 INFO - PROCESS | 4655 | 21:39:46 INFO - TEST-INFO | 4655: exit 0 21:39:46 INFO - TEST-OK | kraken | took 60482ms 21:39:46 INFO - SUITE-END | took 1170s 21:39:46 INFO - Completed test suite (00:19:31) 21:39:46 INFO - javascript benchmark 21:39:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7944.560451979545, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.8208748518828, 3273.7053665170138, 3274.2796584751345, 3290.4735242361226, 3300.867965281389, 5761.913571296429, 5804.622699524533, 5821.912671309934, 5836.066229403291, 5842.737076831542, 5768.567357448187, 5780.248567686195, 5796.62321949073, 5804.477597016267, 5817.040188368925, 5195.922061169076, 5246.501582349671, 5259.289995850569, 5293.073712100387, 5309.230161626562, 5304.787808487656, 5305.0, 5310.8406747797435, 5315.468453154692, 5346.732663366835, 5129.769160387791, 5176.301199338098, 5267.736613169345, 5282.841514754545, 5301.787928482856, 5263.368395792491, 5327.813526526553, 5336.893262134736, 5339.199120131992, 5389.973050134763, 5223.660462069954, 5277.683338999634, 5283.0, 5288.629795914288, 5295.867603309909, 5643.68959707216, 5725.255716756837, 5773.913391299134, 5811.564132690023, 5889.1755154278435, 6078.088286756978, 6195.380461953769, 6199.287081985584, 6207.255129384503, 6214.782482613132, 6230.7819226326865, 6238.906416403757, 6238.968805155945, 6244.531660125509, 6265.373462653698, 5691.630044047124, 5705.429457054344, 5797.4782269595935, 5806.651600903917, 5841.9415805842245, 6279.591826531261, 6373.52198585108, 6386.0, 6392.968035159887, 6395.744170233232, 6119.082137679384, 6135.693215339215, 6137.693115344215, 6137.693115344215, 6147.139400483936, 5993.340732519419, 6113.658745237643, 6201.6899155042065, 6245.937540624535, 6255.530835187379, 6152.8769424611255, 6259.843503912439, 6261.467775239064, 6264.404881536247, 6267.780627678009, 6227.221597300338, 6246.125542424064, 6258.311585725566, 6260.530460215502, 6272.529560282906, 4586.633069354443, 4669.042846216517, 4736.95263047372, 4743.335932969387, 4752.1683705351425, 4167.4790651168605, 4217.5782421758195, 4223.66210703143, 4243.554426785143, 4259.87220383389, 5978.209332155414, 6006.699665016819, 6013.579049466495, 6013.849653758603, 6051.4553690168095, 6046.848828779316, 6069.2110025696375, 6288.937110628835, 6299.6850157491945, 6300.054991751183, 5842.8539286517325, 5899.439553242435, 5909.586328957018, 5909.704514774244, 5934.317553481319, 5093.617978651616, 5143.151380022329, 5145.897082058338, 5148.176291793295, 5155.6391052626705, 6157.661328626879, 6304.18045654062, 6358.395952384516, 6421.775237866652, 6430.0, 6281.089242059876, 6292.0, 6299.905501417574, 6305.90541141874, 6312.495000400048, 6449.645269510222, 6484.0, 6488.513361497812, 6501.479881609365, 6502.057201705632, 5985.610935289193, 6016.187814644967, 6045.0, 6159.23009623797, 6163.137160797402, 6245.469135123565, 6252.1559589456665, 6260.186175797117, 6267.185265915402, 6271.372862713874, 6031.879362412815, 6070.332263451105, 6079.270487541523, 6080.452759251689, 6089.117078023573, 5944.048952167633, 5981.371955944737, 6023.488003519575, 6078.541948427334, 6104.145419641342, 6000.489958353589, 6055.0, 6061.1514387984835, 6061.969690151521, 6062.211912451353, 6062.060380641008, 6128.264608247039, 6142.907856382247, 6152.846178845564, 6164.075388691732, 5739.827805165852, 5802.854928626649, 5876.08920617305, 5919.437653422918, 5969.850753731192], "value": 5715.354121989374, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.748055343502, 622.9937700622994, 661.9900701489479, 663.8141320430279, 703.4161645833958, 40734.18531629365, 47082.29376559346, 47137.528624713785, 47193.29210061852, 47224.52775472244, 46078.769606152004, 46641.30038049432, 46658.53341466584, 46662.30006549905, 46816.0, 8932.955335223314, 9015.143561361692, 9020.684276050339, 9029.683961061364, 9056.818863622724, 9116.316276279273, 9130.452172869616, 9204.079592040776, 9208.907910920905, 9209.769755756126, 9231.676891308805, 9245.630174793001, 9271.25829933607, 9274.536273186348, 9274.907250927505, 9212.309076819232, 9235.630574777, 9261.120193581599, 9261.722148335528, 9263.027382124847, 8488.151184881524, 8583.484990900566, 8596.355273354524, 8597.441166324232, 8604.52675102869, 44012.0, 44422.33366499505, 44599.33101003455, 44747.328790068175, 44836.3274550882, 3880.864169754045, 3967.8214480348165, 4128.277551428518, 4219.346001369762, 4672.15901137795, 35974.28051438983, 36247.45628815544, 36287.0, 36694.633053669655, 36846.26307473835, 4732.645051621108, 4763.14263432582, 4837.226043833005, 4874.585660218886, 4946.777395017233, 360678.0, 362650.0, 363951.0, 364519.0, 366891.0, 64545.35454645487, 64597.354026460074, 65066.674666626364, 65086.349136508026, 65142.0, 39896.0, 40534.79732601377, 40642.59357406388, 42777.572224277355, 69915.0, 18813.717794233096, 18983.90508047451, 19005.904970475058, 19041.14314855835, 19119.80880191208, 14852.70294594102, 15125.39498420073, 15249.771253431207, 15256.084634921941, 15359.0, 20969.89515052415, 21093.472663183235, 21165.576688466146, 21309.36071917845, 21368.358949231548, 7467.290607392289, 7520.172780994087, 7521.172671006185, 7662.540247585162, 7699.191584883507, 1033.2199189611795, 1042.4579218806177, 1107.645553422913, 1108.6396921000546, 1171.7480741640588, 33529.66470335314, 34507.05627102454, 34670.0, 34755.30489390198, 35246.47130293048, 1143.4568579924469, 1177.9057675385948, 1179.8525184351956, 1215.3133479584008, 1287.4914408808468, 17935.910320448314, 18304.63390732178, 18321.083945802657, 18373.7243941341, 18410.447686569423, 603871.0, 855535.0, 873024.0, 873270.0, 875243.0, 66534.66732666403, 67074.66462667656, 67078.32921670818, 67201.66399167973, 67276.6636166816, 1447.4499690117898, 1460.0947412604253, 1464.05568408376, 1481.052126638952, 1493.4698182145182, 34591.13522161966, 35336.0, 35533.82233088818, 35597.64402356047, 35918.640813592574, 58465.0, 58888.411115890005, 58935.0, 59241.11138333015, 59417.70291148689, 500710.0, 503635.0, 505312.0, 505336.0, 506516.0, 31887.36225275528, 31993.6800632, 32659.34681306408, 32788.67211327856, 32804.67195328016, 51918.0, 52816.471835281154, 53568.0, 54165.45834541762, 58262.0, 45645.771771140935, 47060.52939470561, 47120.29319560278, 47752.7612361936, 48859.75570122269, 46511.53488465207, 46649.3002604968, 47653.523464766295, 48184.27723584219, 48245.5175448241, 45263.321050183615, 45339.31991020203, 46672.766636166605, 46680.53319466898, 46760.0, 39056.0, 40027.0, 40886.0, 41022.58977410188, 41346.58653413427, 30690.386192276477, 30726.385472290876, 30807.921722739597, 30959.69040309568, 31115.68884311128], "value": 22033.05184594587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.8153540139237, 418.6274215947809, 422.48245898773996, 428.3916838089912, 441.60696979688083, 19350.0, 20945.952702364877, 21017.894910525443, 21232.150713971423, 21860.781392186112, 20816.895915520403, 20968.895155524202, 21084.57830843382, 21347.57304853902, 21525.67711484329, 6019.789307374253, 6221.346758590328, 6224.0, 6228.875422491547, 6240.4071613196675, 6015.9398406016035, 6089.908651370233, 6100.633961962274, 6101.938980610182, 6130.386961303856, 5891.234139561851, 6016.458518733313, 6024.1566180734735, 6025.15647809307, 6045.365236650155, 5896.115582662614, 5964.433378829026, 5987.880242395149, 5993.61041532299, 6015.879682406371, 5349.545288650469, 5419.918701219485, 5489.533389661883, 5511.751971161308, 5512.145617429305, 18037.27850885963, 24310.149144779847, 24472.143474978468, 24964.126255580966, 25117.748822511723, 2575.72954839741, 2705.9052933147245, 3023.9848800756076, 3334.816585087819, 3382.0868365541164, 15581.0, 15667.764983525256, 15877.36490540377, 16034.438794642132, 16105.838941610667, 2020.2121172742643, 2046.4883779055235, 2067.2066310011173, 2128.9787102128935, 2172.997557483362, 79468.60265698635, 79587.60206198989, 79877.60061199658, 80681.0, 81058.0, 11379.374134422686, 11403.144764142722, 11445.484953177127, 11570.88429115698, 11686.24039437434, 16401.917990409973, 16402.917985409997, 16406.917965410335, 16413.0, 16462.259198336105, 8873.511956842436, 9089.77275568116, 9113.726588202364, 9114.498702571422, 9217.769555761026, 8848.601812918434, 8893.155150260714, 8944.0, 9096.499692516843, 9128.863067053999, 7065.763491388986, 7071.8939215911805, 7158.391536719437, 7285.271472852673, 7292.708291668274, 2066.142550841414, 2071.78246284138, 2086.238522939116, 2087.4259578616, 2087.4885653014803, 948.7580666929889, 1054.467493915583, 1060.3743791163097, 1077.7844431113808, 1138.5275110828914, 20618.0, 21087.894560527406, 21216.575668486545, 21232.469188270417, 21268.574628507344, 1078.946052697362, 1087.9184061195442, 1097.2922465010024, 1105.4969988655143, 1147.3804145761196, 11299.378534180534, 11957.88042119585, 11964.102692297938, 12052.457639406248, 12127.818082728767, 508201.0, 519750.0, 582018.0, 583281.0, 595129.0, 62336.37663623397, 87187.0, 97042.0, 103815.4809225949, 105216.0, 1049.7690508088208, 1062.0759938853248, 1103.8454616353717, 1107.147496427746, 1109.2512554025839, 18409.0, 18808.52978675544, 19145.13846876866, 19193.32823351176, 19208.847469151337, 45105.54894451145, 45169.09661806811, 45456.77271613753, 46802.0, 47393.52606473891, 57255.0, 62834.685826570574, 63604.68197658982, 64538.677306613165, 64923.67538162279, 9080.137386948229, 9139.58871850755, 9221.815563688822, 9337.299702522474, 9517.095875891779, 12266.938665306616, 14187.432502700189, 14324.57026289213, 14352.21062841512, 14388.424463021362, 12052.75894482123, 12295.200811947196, 12536.874631253935, 12577.87422125767, 12754.42605082792, 10544.736381590521, 12551.3096779678, 12658.050646201387, 12694.174878632859, 12894.742105158031, 12500.124991250525, 12565.0, 12938.417771200131, 12998.285094319903, 13042.804357934448, 9252.907470925475, 9353.017933117197, 9359.532023398939, 9394.154526092685, 9412.764680883032, 11570.479328430072, 11979.460924258603, 12236.327002014974, 12399.442025108712, 12767.595564487714], "value": 10112.47514730597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.0882116319626, 1553.068159104537, 1734.6964281250787, 1895.744074549937, 1897.6868816645247, 8600.56997150143, 9251.676191333305, 9435.339526233167, 9947.452890091043, 9962.651307204249, 9471.905280947205, 9885.0, 9890.703278901645, 9896.208303335734, 9918.256130790201, 2397.7602239776056, 2420.43119866832, 2446.7430919753438, 2458.2010846474877, 2460.6063029915217, 2469.3579669286023, 2489.4772097859473, 2509.422832748469, 2511.6232565115197, 2520.042383894118, 2429.914952976646, 2436.1351720139273, 2532.328932832801, 2532.5441420544294, 2538.060917460542, 2424.6847909771705, 2432.756724327562, 2440.365504968703, 2474.39377352548, 2477.1330034487964, 2400.2079313826393, 2415.541047201044, 2416.613341865293, 2416.903323867043, 2471.1845091119885, 9788.853167202426, 10028.59885604575, 10029.648962286357, 10045.598176073021, 10046.296759226858, 5556.472135147154, 5667.4615911488345, 5669.801556945487, 5677.290338707661, 5693.17448969897, 3531.1172206948263, 3620.330238905811, 3663.7069034477177, 3706.3143318485895, 3775.924481510382, 1186.727052777866, 1193.9044876409866, 1235.734317121823, 1250.4310538704958, 1288.8646692097382, 13985.230812305217, 13997.160170389707, 13998.230097344642, 14083.859161408358, 14095.78856317156, 4900.558949694473, 4926.3842019747535, 5015.949840501548, 5065.290859279704, 5083.186690129635, 11888.881111188777, 11930.22453540517, 11947.103967202494, 11954.043676505858, 11955.701107472209, 5801.100829371454, 5823.679697616672, 5836.270466191726, 5839.854003649858, 5842.883142337215, 4679.298105284234, 5055.292259083732, 5205.011047900886, 5213.191955246943, 5328.040952628487, 4287.185434767384, 4332.1119170569955, 4380.69335146543, 4439.778011099432, 4442.267025940683, 1295.3264302562802, 1315.9736805263842, 1316.1116246533552, 1322.2397121655088, 1325.9138156019828, 1054.4991129213563, 1057.4501259345097, 1058.4813441413653, 1062.3148069495287, 1070.5075665194097, 6493.610383376918, 6518.120053792677, 6699.732010719614, 6723.697433615499, 6739.865202695919, 472.6951116529819, 481.4872161148366, 1022.3303736052898, 1090.1278976818514, 1114.9498272577753, 4135.875923722293, 4179.12238429927, 4253.595908388698, 4312.245357062501, 4338.891527711769, 12045.518179272905, 12278.877211227951, 12359.32023738703, 12363.876361236273, 12418.316992565495, 12314.261144331369, 12342.81485777714, 12356.505739770488, 12454.750904981849, 12506.062045346636, 8646.913530864736, 8920.420172688755, 9001.819963600692, 9154.130357616015, 9180.403273787182, 6611.438027767694, 6617.239017513048, 6713.395794378334, 6815.795526134224, 6892.793216203522, 10731.463426828783, 11463.0, 11615.6515304541, 11622.82565761531, 11688.649340519458, 11252.549898003988, 11269.436528173723, 11270.436478175894, 11435.085193184359, 11447.427628618703, 8761.0, 8772.473651580925, 8847.336449766422, 8918.10818918103, 8948.328875334506, 9338.719838404859, 9413.29400294967, 9443.102905224268, 9448.622055117994, 9467.479288639192, 8660.653573856975, 8737.03892571804, 8749.08134645853, 8826.161514656098, 8832.735017949472, 8203.261706446448, 8270.214329638675, 8314.833703326021, 8374.455660382057, 8417.747467575982, 7676.654550545127, 7812.765617031499, 7830.33442157423, 7831.84336313282, 7841.098273698598, 5678.290213723285, 5716.171155182558, 5779.8555036124435, 5797.681127538026, 5839.919614871263, 5710.5146062585145, 5722.084466485342, 5731.083026715705, 5811.535077193899, 5826.504747096375], "value": 5073.149453442212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9440795064839, 333.13052931847875, 336.93429781192646, 347.23608062263025, 350.81582169361087, 5780.4219578042175, 5837.970810145948, 5856.56075794315, 5866.76532938682, 5880.852978675524, 5728.255326807509, 5744.885102297952, 5752.971235143829, 5762.452567006138, 5791.160281759142, 4292.1630282095, 4402.405675233835, 4469.307257375096, 4509.616682581985, 4533.387992621004, 4470.2400591899295, 4481.5070342262325, 4496.572825581581, 4507.188706032913, 4520.3219517072375, 4461.107778444324, 4476.03765190484, 4491.887702807439, 4513.887152821189, 4523.253663145577, 4187.1625674865, 4413.44831896013, 4423.380726698281, 4423.690341676084, 4428.490723566799, 3909.257241124177, 3931.7444366116397, 3950.6839452843706, 3954.5056867891512, 3956.66368358687, 5663.915041274384, 5678.488935995781, 5701.657900525982, 5711.7144142792695, 5728.398518155575, 4985.601151907875, 5078.7460626968505, 5091.694498330112, 5093.516115968977, 5125.538701516882, 5990.891685038282, 6012.5791194616395, 6031.698415079229, 6048.727807248684, 6086.1783659205885, 4191.580841915784, 4308.6983911126235, 4322.876052226444, 4326.740395576244, 4328.891777705582, 6222.346653601352, 6270.529710271748, 6270.905936410957, 6272.435480806749, 6272.874542509125, 4457.531959144243, 4466.486354069324, 4478.715854914018, 4484.775761211927, 4503.234450143484, 4305.203537345601, 4529.84145554904, 4530.864074077783, 4561.840335588238, 4565.0, 5115.948840511622, 5118.948810511922, 5133.614978876599, 5146.948530514722, 5176.249443830623, 6061.787837425669, 6094.6647934363145, 6098.237720284965, 6112.074696470598, 6138.1713468681155, 1485.970280594382, 1499.265359973605, 1504.0674781635455, 1523.9466618668516, 1535.4702627593463, 977.9364341317792, 994.9602015919282, 1037.3931250218707, 1057.9471026448646, 1079.169039839335, 5774.0, 5784.4504772046585, 5813.7500437405315, 5816.738246778905, 5847.193347193286, 6085.817425477243, 6129.353034944201, 6155.569110162246, 6193.4425901669065, 6204.751809927642, 5595.433278681976, 5746.540276777848, 5778.711064446761, 5784.652920824764, 5817.331006934172, 3265.3632541654624, 3292.209869631319, 3320.900372988814, 3322.621112238394, 3334.4164771165433, 6140.5701600887505, 6333.429991300713, 6354.3010268870385, 6377.298497165308, 6415.775447859302, 6228.0, 6237.656928868956, 6251.687415629201, 6263.0, 6277.0, 6222.564420490613, 6406.686629240994, 6412.198475190601, 6415.518836087312, 6432.678366081771, 6235.812925612239, 6288.213973253343, 6306.0, 6307.684615769102, 6317.368263173646, 6182.598131121463, 6184.0, 6197.411245931629, 6218.0, 6225.875482490234, 6287.182666253358, 6463.095166676763, 6494.447971922439, 6505.674716264073, 6511.641859697762, 4485.798139083684, 4510.436195475566, 4531.410916580823, 4531.977340113278, 4547.977260113678, 6070.696465176812, 6165.5375846810775, 6309.274433440213, 6336.714847831767, 6360.427561519486, 6032.969835150796, 6057.122866638311, 6067.544934130046, 6081.016933908297, 6115.816525504064, 6052.788152414821, 6079.635221886701, 6100.938990610037, 6110.480609148272, 6127.3566275540425, 5847.970760146172, 5848.298204215522, 6036.185115009417, 6064.514838812973, 6067.393260673897, 6132.202813634199, 6139.324674285915, 6147.08013693492, 6166.568340216142, 6169.383061693795, 5873.295204575478, 5974.044152935509, 5988.0, 6000.669963152069, 6012.398760123952], "value": 4613.866256716185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.4617133434933, 814.360726829439, 840.4537050916904, 884.3676771108657, 919.8758167647366, 17593.472195834114, 17819.91090044548, 18320.992345420997, 18527.5368115797, 18538.165782539785, 16553.66892662146, 16577.83422165781, 16738.246778894947, 16740.330386784513, 16749.246283917222, 866.5667166416791, 892.5715656484891, 893.7631527645179, 893.9106089391041, 894.3158483759896, 743.2567432567432, 869.652139144341, 885.340421386065, 888.0276097673037, 891.6611687558718, 923.3490389275545, 935.1256575102267, 938.0478814003792, 938.3337830140574, 938.3712912348709, 927.5686805635378, 929.809389075238, 930.6137952749601, 931.9767005824875, 932.4498545857977, 677.7255211639244, 680.6120511308557, 684.4045680258157, 685.3283781893722, 685.396850771323, 17241.741373879275, 17321.307147714077, 17375.565610859703, 17402.825971740247, 17419.30322787087, 14765.0, 14902.925485372503, 14948.40206391743, 15401.537953861402, 15559.533214003599, 13710.177389356571, 13723.382447789874, 14091.577252682437, 14230.153969206096, 14679.55961321162, 4105.548389677133, 4153.356229784388, 4207.453031105967, 4252.87241382759, 4256.361545768129, 92838.53580732121, 93786.53106734491, 93941.53029234879, 94035.52982235113, 94327.0, 13265.867341326657, 13354.93322533381, 13482.19106853592, 13749.0, 14369.56891293263, 25912.74087259141, 26017.349566260615, 26318.0, 26338.341541461617, 26408.207753767034, 9464.1009104135, 9518.286128540387, 9587.089226523469, 9673.467959262167, 10160.644377446753, 5447.945520544823, 5455.345358556999, 5460.0, 5544.390117087117, 5627.549796016309, 3883.6310550497656, 3995.9200815983518, 4007.2987227235117, 4009.0578714002186, 4009.6190861868076, 629.8677277771627, 631.4348657951108, 638.9265234498092, 664.2427632498955, 664.6377724140258, 778.5951305321202, 795.4431897671653, 817.9141190175066, 831.7089018843357, 832.196929962589, 9655.855162172573, 10005.949970250102, 11051.447427628747, 11388.601398950997, 11441.48513316886, 713.0373995106668, 751.8646643604094, 758.9089309282922, 821.8191997760483, 835.5446281776447, 5131.7690703918415, 5402.297701298885, 5419.83740487786, 5439.102548079602, 5497.505224529811, 104849.47575262075, 105483.47258263659, 106190.597483805, 141709.0, 145751.0, 104661.47669261758, 105406.0, 105544.0, 110789.0, 111045.44477277562, 79638.6018069906, 87301.56349218213, 95704.52147739216, 97071.0, 100674.0, 10511.632092876713, 10917.727056823644, 11305.378204198849, 11512.251703639236, 11554.0, 55993.44006559882, 56433.43566564282, 56498.0, 56652.15021774594, 56726.0, 83139.0, 85709.57145214484, 86439.0, 87966.56016719875, 88407.55796220977, 13162.210267383987, 13442.852149597964, 13907.0, 14031.789523156956, 14078.788818167941, 15564.533064008097, 15834.524964251092, 15953.601159971093, 16049.679006419572, 16503.257353418885, 14152.971395795324, 14468.348924298221, 15130.924345378202, 15501.069935803887, 15613.297401617181, 14721.852781472477, 14762.040467369587, 14865.628359291104, 15025.474108406153, 15247.466338678092, 13728.0, 13767.173969561458, 13953.302334883012, 14135.0, 14181.929090354895, 11719.41402929833, 12071.517139314328, 12202.572909948109, 12493.500259989498, 12842.0, 12894.355282235663, 13188.538401155913, 13203.471861125447, 13225.0, 13355.666108347368], "value": 8434.502137537835, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 110.0, 111.0, 111.0, 113.0, 111.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 125.0, 145.0, 171.0, 118.0, 146.0, 147.0, 117.0, 180.0, 118.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 174.0, 77.0, 77.0, 74.0, 75.0, 181.0, 75.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 152.0, 84.0, 84.0, 84.0, 133.0, 85.0, 84.0, 152.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 121.0, 120.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 151.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 51.0, 49.0, 50.0, 51.0, 51.0, 51.0, 52.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 63.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 72.0, 73.0, 73.0, 80.0, 73.0, 77.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 135.0, 128.0, 122.0, 121.0, 127.0, 128.0, 134.0, 161.0, 130.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 153.0, 159.0, 160.0, 156.0, 157.0, 156.0, 154.0, 154.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 67.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 62.4, "unit": "score"}]}]} 21:39:46 INFO - Return code: 0 21:39:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:39:46 ERROR - # TBPL SUCCESS # 21:39:46 INFO - Running post-action listener: _resource_record_post_action 21:39:46 INFO - [mozharness: 2016-10-21 04:39:46.752819Z] Finished run-tests step (success) 21:39:46 INFO - Running post-run listener: _resource_record_post_run 21:39:46 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291139584; Read time: 12; Write time: 194844 21:39:46 INFO - TinderboxPrint: CPU usage
13.1% 21:39:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:39:46 INFO - TinderboxPrint: I/O write bytes / time
291,139,584 / 194,844 21:39:46 INFO - TinderboxPrint: CPU idle
8,211.5 (86.8%) 21:39:46 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 21:39:46 INFO - TinderboxPrint: Swap in / out
0 / 0 21:39:46 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70094848; Read time: 0; Write time: 73388 21:39:46 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 221044736; Read time: 0; Write time: 121456 21:39:47 INFO - Running post-run listener: _upload_blobber_files 21:39:47 INFO - Blob upload gear active. 21:39:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:39:47 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 21:39:47 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'] 21:39:47 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 21:39:47 INFO - (blobuploader) - INFO - Open directory for files ... 21:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:39:51 INFO - (blobuploader) - INFO - Done attempting. 21:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:39:52 INFO - (blobuploader) - INFO - Done attempting. 21:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:39:53 INFO - (blobuploader) - INFO - Done attempting. 21:39:53 INFO - (blobuploader) - INFO - Iteration through files over. 21:39:53 INFO - Return code: 0 21:39:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:39:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:39:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e115f9059a52906adea1cbee754cc965a157b47ba43b37dbcb3d75317ab9a4ec313ce2aaabd010f231f037ce2524c95405246552f4cff58244a5c8c214ddf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8579b06ebcf7cc6bb1dd3860d13472024d4a6fe939df36743428ee3ca95ffbe21b78f9904113c90bf972e0227380dfe6b2e0b9d4bf752b99e8d250f3268c750", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7420935219bde2aa862d0a9a30faad458889b594cfd0f5d2de215f9dafcb77048062c3c97ff0aa987434ded088e3f4f8c056db5b58c719a682b80e355620c4d1"} 21:39:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:39:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:39:53 INFO - Contents: 21:39:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e115f9059a52906adea1cbee754cc965a157b47ba43b37dbcb3d75317ab9a4ec313ce2aaabd010f231f037ce2524c95405246552f4cff58244a5c8c214ddf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8579b06ebcf7cc6bb1dd3860d13472024d4a6fe939df36743428ee3ca95ffbe21b78f9904113c90bf972e0227380dfe6b2e0b9d4bf752b99e8d250f3268c750", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7420935219bde2aa862d0a9a30faad458889b594cfd0f5d2de215f9dafcb77048062c3c97ff0aa987434ded088e3f4f8c056db5b58c719a682b80e355620c4d1"} 21:39:53 INFO - Running post-run listener: copy_logs_to_upload_dir 21:39:53 INFO - Copying logs to upload dir... 21:39:53 INFO - mkdir: /builds/slave/test/build/upload/logs 21:39:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.757282 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-20 21:39:53.595608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:39:53.599703) ========= 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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 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/7e115f9059a52906adea1cbee754cc965a157b47ba43b37dbcb3d75317ab9a4ec313ce2aaabd010f231f037ce2524c95405246552f4cff58244a5c8c214ddf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8579b06ebcf7cc6bb1dd3860d13472024d4a6fe939df36743428ee3ca95ffbe21b78f9904113c90bf972e0227380dfe6b2e0b9d4bf752b99e8d250f3268c750", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7420935219bde2aa862d0a9a30faad458889b594cfd0f5d2de215f9dafcb77048062c3c97ff0aa987434ded088e3f4f8c056db5b58c719a682b80e355620c4d1"} build_url:https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/d9JBOHyGSaafHDR7oKZdew/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/7e115f9059a52906adea1cbee754cc965a157b47ba43b37dbcb3d75317ab9a4ec313ce2aaabd010f231f037ce2524c95405246552f4cff58244a5c8c214ddf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8579b06ebcf7cc6bb1dd3860d13472024d4a6fe939df36743428ee3ca95ffbe21b78f9904113c90bf972e0227380dfe6b2e0b9d4bf752b99e8d250f3268c750", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7420935219bde2aa862d0a9a30faad458889b594cfd0f5d2de215f9dafcb77048062c3c97ff0aa987434ded088e3f4f8c056db5b58c719a682b80e355620c4d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:39:53.624653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:39:53.624973) ========= 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=32c5991c409366f7fec8a718000001d2-1477022985.694922-2114325212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:39:53.713165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:39:53.713846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:39:53.714548) ========= ========= Total master_lag: 0.17 =========