builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1471236110.87 results: success (0) buildid: 20160814185116 builduid: d307c49b287a46cca81ae0d1d3b2d17b revision: 96c1a1c7fbaad98436cde8821e959bb0e32adacd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:50.873131) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:50.873696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:50.873992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:50.892186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:50.892500) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-14 21:41:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.2M=0s 2016-08-14 21:41:51 (64.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.356032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:51.262875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:51.263202) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:51.313251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-14 21:41:51.313663) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96c1a1c7fbaad98436cde8821e959bb0e32adacd --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-aurora --rev 96c1a1c7fbaad98436cde8821e959bb0e32adacd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-14 21:41:51,588 truncating revision to first 12 chars 2016-08-14 21:41:51,588 Setting DEBUG logging. 2016-08-14 21:41:51,588 attempt 1/10 2016-08-14 21:41:51,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96c1a1c7fbaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-14 21:41:52,926 unpacking tar archive at: mozilla-aurora-96c1a1c7fbaa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.726212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-14 21:41:53.054861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:53.055399) ========= script_repo_revision: 96c1a1c7fbaad98436cde8821e959bb0e32adacd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:53.056020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:53.056499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-14 21:41:53.070162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-14 21:41:53.070747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:53 INFO - MultiFileLogger online at 20160814 21:41:53 in /builds/slave/test 21:41:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:41:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:53 INFO - {'append_to_log': False, 21:41:53 INFO - 'base_work_dir': '/builds/slave/test', 21:41:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:41:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:53 INFO - 'branch': 'Mozilla-Aurora', 21:41:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:53 INFO - 'config_files': ('talos/linux_config.py',), 21:41:53 INFO - 'default_actions': ('clobber', 21:41:53 INFO - 'read-buildbot-config', 21:41:53 INFO - 'download-and-extract', 21:41:53 INFO - 'populate-webroot', 21:41:53 INFO - 'create-virtualenv', 21:41:53 INFO - 'install', 21:41:53 INFO - 'run-tests'), 21:41:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:53 INFO - 'download_minidump_stackwalk': True, 21:41:53 INFO - 'download_symbols': 'ondemand', 21:41:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:53 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:53 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:53 INFO - 'installer_path': 'installer.exe', 21:41:53 INFO - 'log_level': 'info', 21:41:53 INFO - 'log_name': 'talos', 21:41:53 INFO - 'log_to_console': True, 21:41:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:53 INFO - 'opt_config_files': (), 21:41:53 INFO - 'pip_index': False, 21:41:53 INFO - 'sps_profile': False, 21:41:53 INFO - 'sps_profile_interval': 0, 21:41:53 INFO - 'suite': 'dromaeojs-e10s', 21:41:53 INFO - 'system_bits': '32', 21:41:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:53 INFO - 'title': 'talos-linux64-ix-001', 21:41:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:53 INFO - 'use_talos_json': True, 21:41:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:53 INFO - 'work_dir': 'build'} 21:41:53 INFO - [mozharness: 2016-08-15 04:41:53.446321Z] Running clobber step. 21:41:53 INFO - Running pre-action listener: _resource_record_pre_action 21:41:53 INFO - Running main action method: clobber 21:41:53 INFO - rmtree: /builds/slave/test/build 21:41:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:53 INFO - Running post-action listener: _resource_record_post_action 21:41:53 INFO - [mozharness: 2016-08-15 04:41:53.912033Z] Finished clobber step (success) 21:41:53 INFO - [mozharness: 2016-08-15 04:41:53.912134Z] Running read-buildbot-config step. 21:41:53 INFO - Running pre-action listener: _resource_record_pre_action 21:41:53 INFO - Running main action method: read_buildbot_config 21:41:53 INFO - Using buildbot properties: 21:41:53 INFO - { 21:41:53 INFO - "project": "", 21:41:53 INFO - "product": "firefox", 21:41:53 INFO - "script_repo_revision": "production", 21:41:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:41:53 INFO - "repository": "", 21:41:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 21:41:53 INFO - "buildid": "20160814185116", 21:41:53 INFO - "pgo_build": "True", 21:41:53 INFO - "basedir": "/builds/slave/test", 21:41:53 INFO - "buildnumber": 461, 21:41:53 INFO - "slavename": "talos-linux64-ix-001", 21:41:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:41:53 INFO - "platform": "ubuntu64_hw", 21:41:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:41:53 INFO - "branch": "mozilla-aurora", 21:41:53 INFO - "repo_path": "releases/mozilla-aurora", 21:41:53 INFO - "revision": "96c1a1c7fbaad98436cde8821e959bb0e32adacd", 21:41:53 INFO - "stage_platform": "linux64-pgo", 21:41:53 INFO - "builduid": "d307c49b287a46cca81ae0d1d3b2d17b", 21:41:53 INFO - "slavebuilddir": "test" 21:41:53 INFO - } 21:41:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 21:41:53 INFO - Running post-action listener: _resource_record_post_action 21:41:53 INFO - [mozharness: 2016-08-15 04:41:53.914567Z] Finished read-buildbot-config step (success) 21:41:53 INFO - [mozharness: 2016-08-15 04:41:53.914655Z] Running download-and-extract step. 21:41:53 INFO - Running pre-action listener: _resource_record_pre_action 21:41:53 INFO - Running main action method: download_and_extract 21:41:53 INFO - mkdir: /builds/slave/test/build/tests 21:41: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:41:53 INFO - https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:41:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:41:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:41:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:41:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:41:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:41:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:41:53 INFO - retry: Failed, sleeping 30 seconds before retrying 21:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 21:42:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:42:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:42:23 INFO - retry: Failed, sleeping 60 seconds before retrying 21:43:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 21:43:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:43:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:43:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 21:43:24 INFO - Caught exception: HTTP Error 404: Not Found 21:43:24 INFO - Caught exception: HTTP Error 404: Not Found 21:43:24 INFO - Caught exception: HTTP Error 404: Not Found 21:43:24 INFO - trying https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:43:24 INFO - Downloading https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:43:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:43:24 INFO - Downloaded 1361 bytes. 21:43:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:43:24 INFO - Using the following test package requirements: 21:43:24 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 21:43:24 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:43:24 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:43:24 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'jsshell-linux-x86_64.zip'], 21:43:24 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:43:24 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 21:43:24 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:43:24 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:43:24 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:43:24 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:43:24 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:43:24 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:43:24 INFO - https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:43:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:43:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:43:24 INFO - retry: Failed, sleeping 30 seconds before retrying 21:43:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:43:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:43:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:43:54 INFO - retry: Failed, sleeping 60 seconds before retrying 21:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:44:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:44:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 21:44:54 INFO - Caught exception: HTTP Error 404: Not Found 21:44:54 INFO - Caught exception: HTTP Error 404: Not Found 21:44:54 INFO - Caught exception: HTTP Error 404: Not Found 21:44:54 INFO - trying https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:54 INFO - Downloading https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:44:55 INFO - Downloaded 21767821 bytes. 21:44:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:44:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:44:56 INFO - Return code: 0 21:44:56 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:44: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:44:56 INFO - https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:44:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:44:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:44:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:44:56 INFO - retry: Failed, sleeping 30 seconds before retrying 21:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:45:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:45:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:45:26 INFO - retry: Failed, sleeping 60 seconds before retrying 21:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:46:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:46:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:46:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 21:46:26 INFO - Caught exception: HTTP Error 404: Not Found 21:46:26 INFO - Caught exception: HTTP Error 404: Not Found 21:46:26 INFO - Caught exception: HTTP Error 404: Not Found 21:46:26 INFO - trying https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:46:28 INFO - Downloaded 21767821 bytes. 21:46:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:46:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:46:29 INFO - Return code: 0 21:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:29 INFO - https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:46:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:46:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:46:29 INFO - retry: Failed, sleeping 30 seconds before retrying 21:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 21:46:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:46:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:46:59 INFO - retry: Failed, sleeping 60 seconds before retrying 21:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 21:47:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:47:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:47:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 21:47:59 INFO - Caught exception: HTTP Error 404: Not Found 21:47:59 INFO - Caught exception: HTTP Error 404: Not Found 21:47:59 INFO - Caught exception: HTTP Error 404: Not Found 21:47:59 INFO - trying https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:47:59 INFO - Downloading https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:48:00 INFO - Downloaded 14413723 bytes. 21:48:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:48:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:48:00 INFO - Return code: 0 21:48: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:48:00 INFO - https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:48:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:48:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:48:00 INFO - retry: Failed, sleeping 30 seconds before retrying 21:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 21:48:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:48:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:48:30 INFO - retry: Failed, sleeping 60 seconds before retrying 21:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 21:49:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:49:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:49:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 21:49:30 INFO - Caught exception: HTTP Error 404: Not Found 21:49:30 INFO - Caught exception: HTTP Error 404: Not Found 21:49:30 INFO - Caught exception: HTTP Error 404: Not Found 21:49:30 INFO - trying https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:49:30 INFO - Downloading https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:49:32 INFO - Downloaded 63758099 bytes. 21:49:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:49:32 INFO - mkdir: /builds/slave/test/properties 21:49:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:49:32 INFO - Writing to file /builds/slave/test/properties/build_url 21:49:32 INFO - Contents: 21:49:32 INFO - build_url:https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:49:32 INFO - Running post-action listener: _resource_record_post_action 21:49:32 INFO - Running post-action listener: set_extra_try_arguments 21:49:32 INFO - [mozharness: 2016-08-15 04:49:32.777221Z] Finished download-and-extract step (success) 21:49:32 INFO - [mozharness: 2016-08-15 04:49:32.777456Z] Running populate-webroot step. 21:49:32 INFO - Running pre-action listener: _resource_record_pre_action 21:49:32 INFO - Running main action method: populate_webroot 21:49:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:49:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:49:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:49:32 INFO - '--tppagecycles', 21:49:32 INFO - '7'], 21:49:32 INFO - 'tests': ['tsvgm']}}, 21:49:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:49:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:49:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:49:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:49:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:49:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:49:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['damp', 'tps']}, 21:49:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'tests': ['damp', 'tps']}, 21:49:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['dromaeo_dom']}, 21:49:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:49:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['basic_compositor_video']}, 21:49:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:49:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['a11yr', 21:49:32 INFO - 'ts_paint', 21:49:32 INFO - 'tpaint', 21:49:32 INFO - 'sessionrestore', 21:49:32 INFO - 'sessionrestore_no_auto_restore', 21:49:32 INFO - 'tabpaint']}, 21:49:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['tsvgx', 21:49:32 INFO - 'tsvgr_opacity', 21:49:32 INFO - 'tart', 21:49:32 INFO - 'tscrollx', 21:49:32 INFO - 'cart']}, 21:49:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:49:32 INFO - 'tsvgr_opacity', 21:49:32 INFO - 'tart', 21:49:32 INFO - 'tscrollx', 21:49:32 INFO - 'cart']}, 21:49:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'talos_options': ['--disable-e10s'], 21:49:32 INFO - 'tests': ['tp5o']}, 21:49:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'tests': ['tp5o']}, 21:49:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'talos_options': ['--disable-e10s', 21:49:32 INFO - '--xperf_path', 21:49:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:49:32 INFO - 'tests': ['tp5n']}, 21:49:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:49:32 INFO - 'talos_options': ['--xperf_path', 21:49:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:49:32 INFO - 'tests': ['tp5n']}}, 21:49:32 INFO - 'talos.zip': {'path': '', 21:49:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:49:32 INFO - Running post-action listener: _resource_record_post_action 21:49:32 INFO - [mozharness: 2016-08-15 04:49:32.795591Z] Finished populate-webroot step (success) 21:49:32 INFO - [mozharness: 2016-08-15 04:49:32.795681Z] Running create-virtualenv step. 21:49:32 INFO - Running pre-action listener: _resource_record_pre_action 21:49:32 INFO - Running main action method: create_virtualenv 21:49:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:49:32 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:49:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:49:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:49:32 INFO - Using real prefix '/usr' 21:49:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:49:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:49:35 INFO - Installing pip.................done. 21:49:35 INFO - Return code: 0 21:49:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:49:35 INFO - Using env: {'DISPLAY': ':0', 21:49:35 INFO - 'HOME': '/home/cltbld', 21:49:35 INFO - 'LANG': 'en_US.UTF-8', 21:49:35 INFO - 'LANGUAGE': 'en_US:en', 21:49:35 INFO - 'LOGNAME': 'cltbld', 21:49:35 INFO - 'MAIL': '/var/mail/cltbld', 21:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:35 INFO - 'MOZ_NO_REMOTE': '1', 21:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:35 INFO - 'NO_EM_RESTART': '1', 21:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:35 INFO - 'PWD': '/builds/slave/test', 21:49:35 INFO - 'SHELL': '/bin/bash', 21:49:35 INFO - 'SHLVL': '1', 21:49:35 INFO - 'TERM': 'linux', 21:49:35 INFO - 'TMOUT': '86400', 21:49:35 INFO - 'USER': 'cltbld', 21:49:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:35 INFO - '_': '/tools/buildbot/bin/python'} 21:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:35 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:49:35 INFO - Cleaning up... 21:49:35 INFO - Return code: 0 21:49:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:49:35 INFO - Using env: {'DISPLAY': ':0', 21:49:35 INFO - 'HOME': '/home/cltbld', 21:49:35 INFO - 'LANG': 'en_US.UTF-8', 21:49:35 INFO - 'LANGUAGE': 'en_US:en', 21:49:35 INFO - 'LOGNAME': 'cltbld', 21:49:35 INFO - 'MAIL': '/var/mail/cltbld', 21:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:35 INFO - 'MOZ_NO_REMOTE': '1', 21:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:35 INFO - 'NO_EM_RESTART': '1', 21:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:35 INFO - 'PWD': '/builds/slave/test', 21:49:35 INFO - 'SHELL': '/bin/bash', 21:49:35 INFO - 'SHLVL': '1', 21:49:35 INFO - 'TERM': 'linux', 21:49:35 INFO - 'TMOUT': '86400', 21:49:35 INFO - 'USER': 'cltbld', 21:49:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:35 INFO - '_': '/tools/buildbot/bin/python'} 21:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:35 INFO - Downloading/unpacking psutil>=3.1.1 21:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:49:37 INFO - Installing collected packages: psutil 21:49:37 INFO - Running setup.py install for psutil 21:49:37 INFO - building 'psutil._psutil_linux' extension 21:49:37 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:49:38 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:49:38 INFO - building 'psutil._psutil_posix' extension 21:49:38 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:49:38 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:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:49:38 INFO - Successfully installed psutil 21:49:38 INFO - Cleaning up... 21:49:38 INFO - Return code: 0 21:49:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:49:38 INFO - Using env: {'DISPLAY': ':0', 21:49:38 INFO - 'HOME': '/home/cltbld', 21:49:38 INFO - 'LANG': 'en_US.UTF-8', 21:49:38 INFO - 'LANGUAGE': 'en_US:en', 21:49:38 INFO - 'LOGNAME': 'cltbld', 21:49:38 INFO - 'MAIL': '/var/mail/cltbld', 21:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:38 INFO - 'MOZ_NO_REMOTE': '1', 21:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:38 INFO - 'NO_EM_RESTART': '1', 21:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:38 INFO - 'PWD': '/builds/slave/test', 21:49:38 INFO - 'SHELL': '/bin/bash', 21:49:38 INFO - 'SHLVL': '1', 21:49:38 INFO - 'TERM': 'linux', 21:49:38 INFO - 'TMOUT': '86400', 21:49:38 INFO - 'USER': 'cltbld', 21:49:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:38 INFO - '_': '/tools/buildbot/bin/python'} 21:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:49:40 INFO - Installing collected packages: mozsystemmonitor 21:49:40 INFO - Running setup.py install for mozsystemmonitor 21:49:40 INFO - Successfully installed mozsystemmonitor 21:49:40 INFO - Cleaning up... 21:49:40 INFO - Return code: 0 21:49:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:49:40 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:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:40 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:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:40 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:40 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:49:40 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:49:40 INFO - Using env: {'DISPLAY': ':0', 21:49:40 INFO - 'HOME': '/home/cltbld', 21:49:40 INFO - 'LANG': 'en_US.UTF-8', 21:49:40 INFO - 'LANGUAGE': 'en_US:en', 21:49:40 INFO - 'LOGNAME': 'cltbld', 21:49:40 INFO - 'MAIL': '/var/mail/cltbld', 21:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:40 INFO - 'MOZ_NO_REMOTE': '1', 21:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:40 INFO - 'NO_EM_RESTART': '1', 21:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:40 INFO - 'PWD': '/builds/slave/test', 21:49:40 INFO - 'SHELL': '/bin/bash', 21:49:40 INFO - 'SHLVL': '1', 21:49:40 INFO - 'TERM': 'linux', 21:49:40 INFO - 'TMOUT': '86400', 21:49:40 INFO - 'USER': 'cltbld', 21:49:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:40 INFO - '_': '/tools/buildbot/bin/python'} 21:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:40 INFO - Downloading/unpacking jsonschema==2.5.1 21:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:49:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:49: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:49: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:49: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:49: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:49: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:49: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:49:42 INFO - Downloading functools32-3.2.3-2.tar.gz 21:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:49:42 INFO - warning: no files found matching '*.txt' 21:49:42 INFO - no previously-included directories found matching 'build' 21:49:42 INFO - no previously-included directories found matching 'dist' 21:49:42 INFO - no previously-included directories found matching '.git*' 21:49:42 INFO - Installing collected packages: jsonschema, functools32 21:49:43 INFO - Running setup.py install for functools32 21:49:43 INFO - warning: no files found matching '*.txt' 21:49:43 INFO - no previously-included directories found matching 'build' 21:49:43 INFO - no previously-included directories found matching 'dist' 21:49:43 INFO - no previously-included directories found matching '.git*' 21:49:43 INFO - Successfully installed jsonschema functools32 21:49:43 INFO - Cleaning up... 21:49:43 INFO - Return code: 0 21:49:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:49:43 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:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:43 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:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:43 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:43 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:49:43 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:49:43 INFO - Using env: {'DISPLAY': ':0', 21:49:43 INFO - 'HOME': '/home/cltbld', 21:49:43 INFO - 'LANG': 'en_US.UTF-8', 21:49:43 INFO - 'LANGUAGE': 'en_US:en', 21:49:43 INFO - 'LOGNAME': 'cltbld', 21:49:43 INFO - 'MAIL': '/var/mail/cltbld', 21:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:43 INFO - 'MOZ_NO_REMOTE': '1', 21:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:43 INFO - 'NO_EM_RESTART': '1', 21:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:43 INFO - 'PWD': '/builds/slave/test', 21:49:43 INFO - 'SHELL': '/bin/bash', 21:49:43 INFO - 'SHLVL': '1', 21:49:43 INFO - 'TERM': 'linux', 21:49:43 INFO - 'TMOUT': '86400', 21:49:43 INFO - 'USER': 'cltbld', 21:49:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:43 INFO - '_': '/tools/buildbot/bin/python'} 21:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:49:43 INFO - Cleaning up... 21:49:43 INFO - Return code: 0 21:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:49:43 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:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:43 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:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:43 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:43 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:49:43 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:49:43 INFO - Using env: {'DISPLAY': ':0', 21:49:43 INFO - 'HOME': '/home/cltbld', 21:49:43 INFO - 'LANG': 'en_US.UTF-8', 21:49:43 INFO - 'LANGUAGE': 'en_US:en', 21:49:43 INFO - 'LOGNAME': 'cltbld', 21:49:43 INFO - 'MAIL': '/var/mail/cltbld', 21:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:43 INFO - 'MOZ_NO_REMOTE': '1', 21:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:43 INFO - 'NO_EM_RESTART': '1', 21:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:43 INFO - 'PWD': '/builds/slave/test', 21:49:43 INFO - 'SHELL': '/bin/bash', 21:49:43 INFO - 'SHLVL': '1', 21:49:43 INFO - 'TERM': 'linux', 21:49:43 INFO - 'TMOUT': '86400', 21:49:43 INFO - 'USER': 'cltbld', 21:49:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:43 INFO - '_': '/tools/buildbot/bin/python'} 21:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:49:43 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:49:43 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:49:43 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:49:43 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:49:43 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:49:43 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:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:49:45 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:49:45 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:49:45 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:49:45 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:49:45 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:49:45 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:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:49:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:49:45 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:49:45 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:49:45 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:49:45 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:49:45 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:49:45 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:49:46 INFO - Downloading docopt-0.6.1.tar.gz 21:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:49:46 INFO - Running setup.py install for blobuploader 21:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:49:46 INFO - Running setup.py install for requests 21:49:46 INFO - Running setup.py install for docopt 21:49:46 INFO - Successfully installed blobuploader requests docopt 21:49:46 INFO - Cleaning up... 21:49:46 INFO - Return code: 0 21:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49: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:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49: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:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:46 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:46 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:49:46 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:49:46 INFO - Using env: {'DISPLAY': ':0', 21:49:46 INFO - 'HOME': '/home/cltbld', 21:49:46 INFO - 'LANG': 'en_US.UTF-8', 21:49:46 INFO - 'LANGUAGE': 'en_US:en', 21:49:46 INFO - 'LOGNAME': 'cltbld', 21:49:46 INFO - 'MAIL': '/var/mail/cltbld', 21:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:46 INFO - 'MOZ_NO_REMOTE': '1', 21:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:46 INFO - 'NO_EM_RESTART': '1', 21:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:46 INFO - 'PWD': '/builds/slave/test', 21:49:46 INFO - 'SHELL': '/bin/bash', 21:49:46 INFO - 'SHLVL': '1', 21:49:46 INFO - 'TERM': 'linux', 21:49:46 INFO - 'TMOUT': '86400', 21:49:46 INFO - 'USER': 'cltbld', 21:49:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:46 INFO - '_': '/tools/buildbot/bin/python'} 21:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:47 INFO - Running setup.py (path:/tmp/pip-YbAgb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:47 INFO - Running setup.py (path:/tmp/pip-3RfmsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:47 INFO - Running setup.py (path:/tmp/pip-vXK0oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:47 INFO - Running setup.py (path:/tmp/pip-btpULQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:47 INFO - Running setup.py (path:/tmp/pip-KIs57H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:47 INFO - Running setup.py (path:/tmp/pip-V4Ivp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:47 INFO - Running setup.py (path:/tmp/pip-g9L_m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:47 INFO - Running setup.py (path:/tmp/pip-jyoz9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:47 INFO - Running setup.py (path:/tmp/pip-3DLnRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:47 INFO - Running setup.py (path:/tmp/pip-NMo7e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:47 INFO - Running setup.py (path:/tmp/pip-Z_RHE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:47 INFO - Running setup.py (path:/tmp/pip-9b8Yeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:47 INFO - Running setup.py (path:/tmp/pip-70kTE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:47 INFO - Running setup.py (path:/tmp/pip-R51Hpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:48 INFO - Running setup.py (path:/tmp/pip-GREJna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:48 INFO - Running setup.py (path:/tmp/pip-BsGxTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:48 INFO - Running setup.py (path:/tmp/pip-3c3xHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:49:48 INFO - Running setup.py install for manifestparser 21:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:49:48 INFO - Running setup.py install for mozcrash 21:49:48 INFO - Running setup.py install for mozdebug 21:49:48 INFO - Running setup.py install for mozdevice 21:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:49:48 INFO - Running setup.py install for mozfile 21:49:48 INFO - Running setup.py install for mozhttpd 21:49:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:49:48 INFO - Running setup.py install for mozinfo 21:49:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:49:48 INFO - Running setup.py install for mozInstall 21:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Running setup.py install for mozleak 21:49:49 INFO - Running setup.py install for mozlog 21:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Running setup.py install for moznetwork 21:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Running setup.py install for mozprocess 21:49:49 INFO - Running setup.py install for mozprofile 21:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Running setup.py install for mozrunner 21:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:49:49 INFO - Running setup.py install for mozscreenshot 21:49:49 INFO - Running setup.py install for moztest 21:49:49 INFO - Running setup.py install for mozversion 21:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:49:50 INFO - Cleaning up... 21:49:50 INFO - Return code: 0 21:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:50 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:50 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:49:50 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:49:50 INFO - Using env: {'DISPLAY': ':0', 21:49:50 INFO - 'HOME': '/home/cltbld', 21:49:50 INFO - 'LANG': 'en_US.UTF-8', 21:49:50 INFO - 'LANGUAGE': 'en_US:en', 21:49:50 INFO - 'LOGNAME': 'cltbld', 21:49:50 INFO - 'MAIL': '/var/mail/cltbld', 21:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:50 INFO - 'MOZ_NO_REMOTE': '1', 21:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:50 INFO - 'NO_EM_RESTART': '1', 21:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:50 INFO - 'PWD': '/builds/slave/test', 21:49:50 INFO - 'SHELL': '/bin/bash', 21:49:50 INFO - 'SHLVL': '1', 21:49:50 INFO - 'TERM': 'linux', 21:49:50 INFO - 'TMOUT': '86400', 21:49:50 INFO - 'USER': 'cltbld', 21:49:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:50 INFO - '_': '/tools/buildbot/bin/python'} 21:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:50 INFO - Running setup.py (path:/tmp/pip-sDYfXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:50 INFO - Running setup.py (path:/tmp/pip-MkIzSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:50 INFO - Running setup.py (path:/tmp/pip-WV5q9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:50 INFO - Running setup.py (path:/tmp/pip-vrrWKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:50 INFO - Running setup.py (path:/tmp/pip-i09ro3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:50 INFO - Running setup.py (path:/tmp/pip-FwHMDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:50 INFO - Running setup.py (path:/tmp/pip-5lbFAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:50 INFO - Running setup.py (path:/tmp/pip-jNRzLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:50 INFO - Running setup.py (path:/tmp/pip-4iiQIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:50 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:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:50 INFO - Running setup.py (path:/tmp/pip-bTr1jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:51 INFO - Running setup.py (path:/tmp/pip-TIbKR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:51 INFO - Running setup.py (path:/tmp/pip-GEXkwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:51 INFO - Running setup.py (path:/tmp/pip-cZxKIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:51 INFO - Running setup.py (path:/tmp/pip-V9ie6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:51 INFO - Running setup.py (path:/tmp/pip-95S9GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:51 INFO - Running setup.py (path:/tmp/pip-YTSEls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:51 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:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:51 INFO - Running setup.py (path:/tmp/pip-CMTRY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:51 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:49:51 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:49:51 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:49:51 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:49:51 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:49:51 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:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:49: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:49: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:49: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:49: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:49: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:49: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:49:53 INFO - Downloading blessings-1.6.tar.gz 21:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:49:53 INFO - Installing collected packages: blessings 21:49:53 INFO - Running setup.py install for blessings 21:49:53 INFO - Successfully installed blessings 21:49:53 INFO - Cleaning up... 21:49:53 INFO - Return code: 0 21:49:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:53 INFO - Reading from file tmpfile_stdout 21:49:53 INFO - Current package versions: 21:49:53 INFO - argparse == 1.2.1 21:49:53 INFO - blessings == 1.6 21:49:53 INFO - blobuploader == 1.2.4 21:49:53 INFO - docopt == 0.6.1 21:49:53 INFO - functools32 == 3.2.3-2 21:49:53 INFO - jsonschema == 2.5.1 21:49:53 INFO - manifestparser == 1.1 21:49:53 INFO - mozInstall == 1.12 21:49:53 INFO - mozcrash == 0.17 21:49:53 INFO - mozdebug == 0.1 21:49:53 INFO - mozdevice == 0.48 21:49:53 INFO - mozfile == 1.2 21:49:53 INFO - mozhttpd == 0.7 21:49:53 INFO - mozinfo == 0.9 21:49:53 INFO - mozleak == 0.1 21:49:53 INFO - mozlog == 3.3 21:49:53 INFO - moznetwork == 0.27 21:49:53 INFO - mozprocess == 0.23 21:49:53 INFO - mozprofile == 0.28 21:49:53 INFO - mozrunner == 6.12 21:49:53 INFO - mozscreenshot == 0.1 21:49:53 INFO - mozsystemmonitor == 0.3 21:49:53 INFO - moztest == 0.7 21:49:53 INFO - mozversion == 1.4 21:49:53 INFO - psutil == 3.1.1 21:49:53 INFO - requests == 1.2.3 21:49:53 INFO - wsgiref == 0.1.2 21:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49: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:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49: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:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:53 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:53 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:49:53 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:49:53 INFO - Using env: {'DISPLAY': ':0', 21:49:53 INFO - 'HOME': '/home/cltbld', 21:49:53 INFO - 'LANG': 'en_US.UTF-8', 21:49:53 INFO - 'LANGUAGE': 'en_US:en', 21:49:53 INFO - 'LOGNAME': 'cltbld', 21:49:53 INFO - 'MAIL': '/var/mail/cltbld', 21:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:53 INFO - 'MOZ_NO_REMOTE': '1', 21:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:53 INFO - 'NO_EM_RESTART': '1', 21:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:53 INFO - 'PWD': '/builds/slave/test', 21:49:53 INFO - 'SHELL': '/bin/bash', 21:49:53 INFO - 'SHLVL': '1', 21:49:53 INFO - 'TERM': 'linux', 21:49:53 INFO - 'TMOUT': '86400', 21:49:53 INFO - 'USER': 'cltbld', 21:49:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:53 INFO - '_': '/tools/buildbot/bin/python'} 21:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 INFO - Cleaning up... 21:49:54 INFO - Return code: 0 21:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:54 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 0x2869030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a98400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', '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:49:54 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:49:54 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:49:54 INFO - Using env: {'DISPLAY': ':0', 21:49:54 INFO - 'HOME': '/home/cltbld', 21:49:54 INFO - 'LANG': 'en_US.UTF-8', 21:49:54 INFO - 'LANGUAGE': 'en_US:en', 21:49:54 INFO - 'LOGNAME': 'cltbld', 21:49:54 INFO - 'MAIL': '/var/mail/cltbld', 21:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:54 INFO - 'MOZ_NO_REMOTE': '1', 21:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:54 INFO - 'NO_EM_RESTART': '1', 21:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:54 INFO - 'PWD': '/builds/slave/test', 21:49:54 INFO - 'SHELL': '/bin/bash', 21:49:54 INFO - 'SHLVL': '1', 21:49:54 INFO - 'TERM': 'linux', 21:49:54 INFO - 'TMOUT': '86400', 21:49:54 INFO - 'USER': 'cltbld', 21:49:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:54 INFO - '_': '/tools/buildbot/bin/python'} 21:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:49:54 INFO - Cleaning up... 21:49:54 INFO - Return code: 0 21:49:54 INFO - Running post-action listener: _resource_record_post_action 21:49:54 INFO - Running post-action listener: _start_resource_monitoring 21:49:54 INFO - Starting resource monitoring. 21:49:54 INFO - [mozharness: 2016-08-15 04:49:54.341139Z] Finished create-virtualenv step (success) 21:49:54 INFO - [mozharness: 2016-08-15 04:49:54.341620Z] Running install step. 21:49:54 INFO - Running pre-action listener: _resource_record_pre_action 21:49:54 INFO - Running main action method: install 21:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:54 INFO - Reading from file tmpfile_stdout 21:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 21:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:49:54 INFO - Reading from file tmpfile_stdout 21:49:54 INFO - Output received: 21:49:54 INFO - Usage: mozinstall [options] installer 21:49:54 INFO - Options: 21:49:54 INFO - -h, --help show this help message and exit 21:49:54 INFO - -d DEST, --destination=DEST 21:49:54 INFO - Directory to install application into. [default: 21:49:54 INFO - "/builds/slave/test"] 21:49:54 INFO - --app=APP Application being installed. [default: firefox] 21:49:54 INFO - mkdir: /builds/slave/test/build/application 21:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:50:10 INFO - Reading from file tmpfile_stdout 21:50:10 INFO - Output received: 21:50:10 INFO - /builds/slave/test/build/application/firefox/firefox 21:50:10 INFO - Running post-action listener: _resource_record_post_action 21:50:10 INFO - [mozharness: 2016-08-15 04:50:10.605175Z] Finished install step (success) 21:50:10 INFO - [mozharness: 2016-08-15 04:50:10.605459Z] Running run-tests step. 21:50:10 INFO - Running pre-action listener: _resource_record_pre_action 21:50:10 INFO - Running main action method: run_tests 21:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:50:10 INFO - Python 2.7.3 21:50:10 INFO - Return code: 0 21:50:10 INFO - grabbing minidump binary from tooltool 21:50:10 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:50:10 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 0x2b27570>, '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 0x2b28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b28900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:50:10 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:50:10 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:50:10 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:50:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:50:10 INFO - Return code: 0 21:50:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:50:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:50:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:50:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:50:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:50:10 INFO - Using env: {'DISPLAY': ':0', 21:50:10 INFO - 'HOME': '/home/cltbld', 21:50:10 INFO - 'LANG': 'en_US.UTF-8', 21:50:10 INFO - 'LANGUAGE': 'en_US:en', 21:50:10 INFO - 'LOGNAME': 'cltbld', 21:50:10 INFO - 'MAIL': '/var/mail/cltbld', 21:50:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:50:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:10 INFO - 'MOZ_NO_REMOTE': '1', 21:50:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:10 INFO - 'NO_EM_RESTART': '1', 21:50:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:10 INFO - 'PWD': '/builds/slave/test', 21:50:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:50:10 INFO - 'SHELL': '/bin/bash', 21:50:10 INFO - 'SHLVL': '1', 21:50:10 INFO - 'TERM': 'linux', 21:50:10 INFO - 'TMOUT': '86400', 21:50:10 INFO - 'USER': 'cltbld', 21:50:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643', 21:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:10 INFO - '_': '/tools/buildbot/bin/python'} 21:50:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:50:10 INFO - mozversion application_buildid: 20160814185116 21:50:10 INFO - mozversion application_changeset: 96c1a1c7fbaad98436cde8821e959bb0e32adacd 21:50:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:50:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:50:10 INFO - mozversion application_name: Firefox 21:50:10 INFO - mozversion application_remotingname: firefox-dev 21:50:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:50:10 INFO - mozversion application_vendor: Mozilla 21:50:10 INFO - mozversion application_version: 50.0a2 21:50:10 INFO - mozversion platform_buildid: 20160814185116 21:50:10 INFO - mozversion platform_changeset: 96c1a1c7fbaad98436cde8821e959bb0e32adacd 21:50:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:50:10 INFO - mozversion platform_version: 50.0a2 21:50:10 INFO - using testdate: 1471236610 21:50:10 INFO - actual date: 1471236610 21:50:10 INFO - starting webserver on 'localhost:45728' 21:50:10 INFO - SUITE-START | Running 2 tests 21:50:10 INFO - TEST-START | dromaeo_css 21:50:10 INFO - operating with platform_type : linux_ 21:50:10 INFO - Initialising browser for dromaeo_css test... 21:50:10 INFO - TEST-INFO | started process 15388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQrqOX/profile http://localhost:45728/getInfo.html) 21:50:15 INFO - PROCESS | 15388 | __metrics Screen width/height:1600/1200 21:50:15 INFO - PROCESS | 15388 | colorDepth:24 21:50:15 INFO - PROCESS | 15388 | Browser inner width/height: 1024/697 21:50:15 INFO - PROCESS | 15388 | __metrics 21:50:16 ERROR - PROCESS | 15388 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:50:16 INFO - TEST-INFO | 15388: exit 0 21:50:16 INFO - Browser initialized. 21:50:16 INFO - Running cycle 1/1 for dromaeo_css test... 21:50:16 INFO - TEST-INFO | started process 15513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQrqOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:50:28 INFO - PROCESS | 15513 | RSS: Main: 152231936 21:50:28 INFO - PROCESS | 15513 | 21:51:18 INFO - PROCESS | 15513 | 1471236678181 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:53:26 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45728/tests/dromaeo/cssquery-ext.html) 21:53:27 INFO - PROCESS | 15513 | RSS: Main: 158486528 21:53:27 INFO - PROCESS | 15513 | 21:56:29 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-ext.html (next: http://localhost:45728/tests/dromaeo/cssquery-jquery.html) 21:56:30 INFO - PROCESS | 15513 | RSS: Main: 153501696 21:56:30 INFO - PROCESS | 15513 | 21:59:32 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45728/tests/dromaeo/cssquery-mootools.html) 21:59:32 INFO - PROCESS | 15513 | RSS: Main: 155066368 21:59:32 INFO - PROCESS | 15513 | 22:02:34 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45728/tests/dromaeo/cssquery-prototype.html) 22:02:35 INFO - PROCESS | 15513 | RSS: Main: 152346624 22:02:35 INFO - PROCESS | 15513 | 22:05:37 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45728/tests/dromaeo/cssquery-yui.html) 22:05:38 INFO - PROCESS | 15513 | RSS: Main: 155373568 22:05:38 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | Cycle 1(1): loaded http://localhost:45728/tests/dromaeo/cssquery-yui.html (next: http://localhost:45728/tests/dromaeo/cssquery-dojo.html) 22:08:40 INFO - PROCESS | 15513 | RSS: Main: 156147712 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | __start_tp_report 22:08:40 INFO - PROCESS | 15513 | _x_x_mozilla_page_load 22:08:40 INFO - PROCESS | 15513 | _x_x_mozilla_page_load_details 22:08:40 INFO - PROCESS | 15513 | |i|pagename|runs| 22:08:40 INFO - PROCESS | 15513 | |0;dojo.html;3278.2787786686927;3306.5866766654167;3306.6032076150864;3308.2391050058473;3324.6841550052736;5730.484256416927;5821.155932389801;5821.912671309934;5858.794942177019;5874.765009399624;5804.187413762077;5856.590038697283;5886.028805247129;5889.116632505126;5894.705264736767;5298.973505132488;5300.946990530094;5314.229436731691;5356.625036247464;5367.516923476886;5178.378594568657;5180.715060671661;5238.60710446718;5274.235235890794;5319.5744340452675;5252.8686782830355;5274.604404669646;5288.709120998344;5295.0468915595175;5362.839114826562;5342.946570534304;5353.0899747043095;5357.330333708267;5364.739286267724;5382.950324686688;5101.387833459971;5162.148245539482;5224.346956630421;5242.475752424727;5260.158374660036;5580.19087232349;5697.287839020122;5702.515286200678;5761.107028410603;5778.306603207642;6173.783917562909;6206.162168107293;6209.285932117774;6217.067439884008;6235.282942461584;5977.970110149465;6136.7545298188015;6205.689715514206;6215.223097112861;6219.253689557237;5782.074868021138;5877.23595932526;5878.970605147032;5908.615939963888;5917.852053698649;6373;6388.456981156561;6392.648404337713;6414.775482858077;6432.2281326241155;5919.526437884959;6079.848003799941;6178.845528861724;6188.009918413032;6188.845278868064;6121.727351053096;6249.468795152463;6282.685865706696;6289.245290565162;6293.716782744696;6240.625562466266;6241.375862413723;6243;6247.531435142382;6272.498200143978;6026.7890623828835;6091.634501929899;6220.657863817443;6250.781222657185;6263.154474146023;4661.906761864811;4754.191787396151;4762.309465127537;4768.928466073012;4773.570378665937;4222.493300803923;4243.978780106079;4248.362745588187;4272.850450234227;4282.186384586918;5797.768089276382;5824.301083869878;5909.497692696083;5956.463918247378;5957.046872500379;6116.969415152896;6188.81433556985;6218.533609979269;6224.968875155595;6248.28144763349;5865.530757539386;5886.58793884424;5897.469227769521;5919.704014799329;5935.940640593625;5043.52086551777;5181.5595674368105;5209.6874187548865;5213.713245771519;5231.790728370898;6351.714172862232;6555.2133743951035;6558.114654521579;6561.5734977227285;6566.934330656728;6286.74853005893;6301.306856245717;6305.464035557029;6305.621662700252;6322.36776322364;6199.969000154971;6284.214473190851;6450.48396128318;6532.934670653232;6536.607803531613;6013.849653758691;6135.417135372132;6143.232095988002;6177.444030037318;6194.783182588588;6234.096056071935;6242.094896239929;6242.375762423903;6249.250089989048;6267.843303917256;5971.193888824953;6066.120412540069;6086.695665216633;6087.8782424350375;6111.052786818051;6052.394760523913;6151.446369826737;6165;6173.290071641819;6174.629522228681;6049.939500604937;6099.573029887865;6101.566699181792;6107.389261073857;6112.689653113243;5910.320313163869;6040.818775436744;6167.167432396569;6171.9691401542705;6189.597676151036;5930.466258036625;6045.576809623284;6046.2139921809885;6054.243219597551;6095.177151084724 22:08:40 INFO - PROCESS | 15513 | |1;ext.html;579.4350508254449;627.5011365964061;634.6794868591362;645.5771469687355;669.7789729389302;41552;45303.32045019327;45391.77304113479;45516.54483455164;45792.084158316815;46210.76894615531;46731.29903051457;46879;46889.53110468894;47107.29339059908;9084.954575227115;9266.953665231698;9279.768005799842;9292.442453452815;9310.581023853909;9175.311851611155;9218.124278193562;9281.35030547862;9309.208717259007;9356.578953947055;9290.76773080675;9355.391899526543;9391.295652826031;9410.670626528039;9412.199963003153;9260.861087083698;9295.2099071579;9348.67279645216;9402.059794020577;9435.481048542328;9206.815863682756;9297.395669281543;9325.114114159143;9334.533273336374;9335.486548239844;44295;44307.11385772267;44379.112417751785;44407.11185776266;44462.77768611169;3667.9816600917093;3867.0525721198205;3884.6892248620325;3908.6482216600643;4112.609302116294;34777.65222347769;35226.29547409037;35320.82339588311;35330;35473.82263088694;4626.1441633297945;4663.860084197479;4729.50340214276;4759.333693282943;4815;254194;255895;256844;256895.71552142306;257990;63876.36123638797;64214;64343;64348.356516434236;64369.67815160894;39290;39803.60196398057;40026.79986600048;42457.36313955293;68273.65863170751;19717.309894153637;19934.401967940987;20024.098915548835;20052.29816956429;20111.899440502704;15232.162231077176;15380.538583842503;15390.923045384701;15394.923025385026;15398.153101579297;20983.580328393346;21364;21369.572608547744;21464.4633884151;21535.60018598786;7555.16893141754;7710.537367757953;7747.767566973;7884.921150788418;7954.403419743542;1019.887812340642;1086.5002099034375;1097.0620119797459;1133.1105082510355;1172.7888979983684;33402.83298583492;33764;33793.66206337955;34054.48918266228;34247.58124534855;1120.227043340109;1155.283724091069;1174.9647510574696;1210.1952201785714;1225.779359715242;17690;17821;17997.1001449927;18029.639407211784;18060.09699515019;621816;623153;627658;628007;634187;64079;64833;64933.675331623985;64964;64977.35022649713;1433.978490322646;1454.7308747881464;1467.713795809807;1493.6415260337658;1504.0674781635237;33027.66972330246;33266.16834579155;33411.49882751712;33688.32623347568;33984;57490;57772.422275776706;58068.70965645145;58089.709551451975;58206;498499;499140;505363;506263;506525;29760.851195743882;31789.36421271608;31895.20261993376;31909.6809031916;31920.52119218167;51710.74144629253;52298.477015229364;52372.738136309075;53107.73446132745;54079.72960135174;44814.55185448234;44896.36839685922;45063.32405013862;46284.53715462937;46805.53194468148;43586.564134358254;44959.55040449554;44966;45532.77233613811;45684.54315456936;44401.33397999097;45173.54826451693;45394.54605453903;46134.538654613025;48064.5193548074;39670;39728.60271397365;39802.40296395614;40151;40741;29846.701532984393;30932;30966.380672386877;30986.69013309928;31278.06165815029 22:08:40 INFO - PROCESS | 15513 | |2;jquery.html;408.8099033949213;415.7256210900805;416.41493701349594;419.4777502009998;426.09880103580934;18773.43679689608;19976.801391916477;20548.17807287707;20800.271990480338;21072.473188170305;19491.902540487314;19652.508687282825;20006.59986800263;20018;20150.69773953392;5681.318241810978;5859.736311865976;5898.941010589903;5902.675352855591;5910.172575839386;5762.53899688026;5787.623804452718;5791.507721843648;5816.738246778884;5828.650280983134;5616.410276920926;5798.449147330997;5799.884002319951;5804.100364443497;5826.650400975934;5742.971285143548;5784.537237021028;5788.363280039213;5789.073748200289;5810.360860305363;5239.633225674204;5243.580513558906;5251.658642188246;5253.842384728464;5264.447233040514;22033.889830550906;22382.32853014412;22571.435714107116;22917.54164916709;23747.287581372588;2532.4048848520583;2560.807939404552;2656.468706258756;2851.5152424087955;2894.6671132819783;15349.846501534954;15431.305591248421;15467.226638668135;15595.298211580506;15807.367705291774;1965.6756635155182;1994.7931501441565;2038.6636205026152;2039.5309078911932;2092.184048221195;80682.86159128057;81305;82357.58821205916;82737.58631206866;82850.58574707087;9530.666426675032;10075.193984481224;10176.084152426169;10444.63443779464;11145.108391328675;14103.71792564143;14119.85880141206;14147.787783183261;14221.502247421291;14245.358958846877;7726.34326082278;7907.920920790719;7948.324392426593;7982.840343193104;8036.156203598655;8206.630701618442;8242.134575869448;8280.171982801672;8316.085230624627;8400.285975692135;4304.677149213821;4361.890952726144;4388.144311859157;4464.732116073046;4471.642268618502;2107.430993631711;2134.914603415846;2144.0994782191206;2157.751858536257;2170.088562803595;992.667456402099;995.8008398320364;1039.8180318444242;1058.3226734889677;1083.230906056693;19660.70508942367;19817.405477835688;19837.20651173937;19955.501112472306;20317.18731250763;1015.3653966271081;1016.1159790981745;1023.902729240721;1025.2669341420772;1037.6886933919945;10983.890161098287;11274.210805243718;11342.092632589372;11358.60244891425;11480.31118132898;464522;466003;481275;486481;491012;88419;95591;98363.99999999857;100553.49723251483;105079.47460262649;1045.2265323660436;1066.333541536524;1083.3554035348955;1084.9240553161203;1093.6227001684406;16439.753403699193;18505.81494185041;18599.814001860348;18660.346887859403;18868.622627547647;37858.62141378551;45444.772776135906;46006.3452219085;46139.76930115328;46206.76896615495;59476.10785838129;62416;64058.67970660117;64262;64813.67593162004;8713.390062695551;8961.820763584823;9033.638654453749;9042.593083311136;9055;11464.598739044428;13324.40040198174;13509.864901351253;13567.59297221085;14079.577612671636;11188.328700278009;11579.768404631692;11903.82144267854;11907;12213.755724885275;11548.364839933884;11753.588624398106;11917.52329906794;12018.699532511757;12046;11633.418329083343;12252.938735306267;12283.508659653513;12520.561780337644;12792.360381980678;8853.203211710977;8932.19610235082;9040;9231.35380523357;9234.9538252311;10436.58253669875;11746.647600571996;12096;12332.075094368138;12395.814062789246 22:08:40 INFO - PROCESS | 15513 | |3;mootools.html;1483.525271912988;1519.7340465418552;1586.159335552157;1690.408357075023;1712.2893998990419;8222.095569487352;8966.23786978107;9217.90782092179;9713.757156071093;9736.6592169274;9266.90733092669;9723.07630775077;9729.562169702363;9754.707358779231;9757.463339516324;2503.1739525956436;2532.7973762098986;2533.6959564852245;2533.898644054236;2538.2512158913164;2433.3551608823677;2548.413864811085;2563.8078293593476;2571.215779187347;2576.896924123033;2509.3224829296078;2519.596864501671;2536.2898388451263;2547.4013606802387;2547.5541780188487;2471.616899380599;2471.7157526884457;2472.5673007223754;2480.6279058141245;2504.8246622736415;2460.606302991531;2464.1006032798077;2474.4308808974038;2481;2508;9730.708078757649;9790.657326993593;9804.117629413387;9805.90194098057;9824.164945979528;5567.331920169606;5668.829935101953;5698.173764804122;5733.799317023926;5736.282964629421;3573.9642603573893;3690.9630903690886;3766.510353654035;3769.5288088988877;3786.9053273668105;1129.717570607348;1172.3903570143564;1190.053907143814;1194.2416565480896;1203.939803009846;12960.222386656736;12963.15739476931;12967.870321296761;12969.157004794752;13007.219566826021;4842.176829938919;4992.8751781205765;5042.243663450438;5156.974215128976;5250.317458730341;10454;10477.266591338534;10480;10501.474926253657;10502.894971050191;5597.412271711493;5610.97194514033;5626.409227031185;5631.493165615032;5634.60557760961;4570.908581828411;5176.741162941913;5243.187305967581;5279.788808447696;5288.048151332797;4002.219567184371;4065.735727177724;4091.1408604192857;4093.85671501496;4179.749215047107;1165.7085728567858;1174.8002839517303;1185.1644590563633;1201.2972411139406;1212.490753883371;1018.9133923616428;1019.4749703902496;1051.8211903976342;1067.685032915292;1071.2554774431694;6538.084668146464;6539.411452969255;6608.86782264352;6610;6641.402273795382;1030.6701855406347;1105.0993440346092;1151.1711567671264;1176.3765204441659;1188.6018183908316;4504.301833215792;4513.729176249435;4550.772461376918;4586.472555656075;4649.535046495391;11723.76552468946;11928.224665396721;11934.582289619822;11944.522219111312;12005.279683219034;12040.578579749841;12100.273983561014;12120.212186207867;12252.264864108181;12258.08064395174;8779.341549383695;8865.778355541033;8953.910460895308;8956.28349732033;8998.59506322217;6458.709358078804;6593.175853018372;6622.801315960529;6624.271330153583;6634.137562117087;11092.279001864854;11119.944400277947;11533.596324128615;11538.88461115378;11599.6520104397;11203;11233.887661123284;11468;11535.192536522363;11620.186586938833;7455.739049133254;8160.5103693778565;8319.292860106716;8348.206920342558;8520.403571749917;9504.904950950679;9585.712428627152;9587.089226523469;9598;9616.615335386507;8231.09457959612;8320.667173312999;8334.666613335641;8361.581920904053;8477.533735644598;8278.503289802631;8306.127856574973;8340;8345;8424;7651.770446886602;7868.72459463916;7896.802579935547;7947.801304967422;7984.481008734414;5505.311836020497;5556.222128902038;5568.053430916835;5646.181303711021;5696.344920334214;5619.381867994435;5679.375268720355;5714.571407144564;5747.252857128547;5886.146508756292 22:08:40 INFO - PROCESS | 15513 | |4;prototype.html;356.59526437493435;357.7013193983024;360.5421115183715;363.2553265805099;365.6215816629787;5944.732487038083;5971.924458903668;5983.282006159262;6002.129691194785;6010.218671572689;5633.690147041911;5843.824685259438;5857.355690874011;5859.238299021121;5877.588568800185;4488.68579199457;4514.390557274775;4532.320151977214;4534.523874993128;4536.183486972343;4530.592246697796;4533;4546.954530454703;4549.407707302451;4565.908681826361;4478.305862591304;4517.525659805722;4523.36672865799;4526.909461810762;4564.612007979325;4305.6124948754605;4458.308962110878;4510.6918993491845;4517.2094883395275;4537.366548042702;3935.960640393588;3952.407138929155;3967.7024223183375;3968.1270120573427;3977.622125898035;5659.943400566024;5708.942910570882;5723.427657234285;5737.139429085671;5770.16332631766;5010.72441015744;5146.757542748082;5217.191335343028;5220.738963051832;5245.291885595434;6074.848128796772;6124.908126378108;6185.536084793614;6185.628862268279;6190.721417536221;4364.825406983717;4383.364412160219;4460.4647442306805;4463.933041004388;4474.239379305526;6150.985087460608;6314.273858506284;6435.8391040223905;6453.451456626192;6473.190851143607;4392.5607439256455;4399.196329504952;4435.024294655171;4437.378766972626;4439.511653718088;4453.463555073495;4472.284434490466;4474.686771925999;4480;4503.211937910853;5024.171011783088;5190.885468718739;5202.3497062867145;5225.608079394061;5226.817061402909;6145.600535965148;6145.723442445101;6146.832101900624;6172.321044685081;6172.475339596095;1553.7824704541374;1564.9843501565067;1567.686462707463;1581.1066747287746;1583.4853672556465;943.7640589852537;991.8710567626307;996.5151923633879;1003.1924300937669;1010.1565193063874;5281.603879709037;5298.496642818926;5320.647991765163;5338;5359.812406565751;5566;5619.129034999582;5632.831015069554;5641.492265696025;5646.943530564724;5076.6192535559985;5168.328117344721;5236;5244.767479642281;5344.091504444176;2957.2015555800244;2979.333496520602;2993.476141675198;2998.190488568118;3030.742241969558;5514.641548299348;5698.373178950312;5713.2572765541045;5714.0571805652435;5749.367569567345;5563.693996830213;5604.019296623074;5613.326400831927;5630.746616402272;5677.041420709848;5659.971700141473;5697.686627235459;5715.914261286084;5766.452187042224;5789.652620842763;5259.710715910662;5545.667259964253;5559.360673522597;5564.690653378964;5665.461781130786;5500.744694675164;5545.500904918576;5558.527525160407;5581.553475722014;5590.301212348457;6282.528810339151;6312.4634406074165;6448.967755161382;6493.935060649333;6513.967430162819;4387.385765992827;4403.691741578059;4412.2499175139665;4424.955750442583;4427.092446048488;6221.191245138103;6283.49732021428;6345.2702939160745;6370.694007728497;6410.044936294288;6141.539384546266;6185.3095152458945;6197.907031394623;6203.2245969253845;6221.751129954751;5900.734466949083;6179.81460556184;6198.411150940653;6238.344973777869;6255;6087.391260873877;6089.817305480843;6119.204503414706;6124.173236613178;6134.8159555213415;6219.191505104308;6261.405166509175;6285.74857005733;6298.433141017331;6339.5562310637815;5847.356790752929;6028.563718680311;6080.118382834376;6107.9389206109145;6115.4190351916495 22:08:40 INFO - PROCESS | 15513 | |5;yui.html;828.2504333578111;842.3934766967785;871.8125602995354;873.5195642396682;923.9538023098852;16030.602524410571;18002.909985450053;18289.908550457247;18325.633487330262;18326.81673183271;15728.764068538952;15753.60615984601;16101.275442605081;16111.758323625156;16118.919405402987;852.4288726553209;870.138562822804;871.0984131423977;871.4988881393192;873.2359185712502;860.2472836268265;863.5293764898146;896.753392816974;900.4057322167371;908.0783005249676;946.5645802930626;946.6497395963503;947.853082772168;949.4113649537296;949.5299826585815;947.3415975896754;950;950.097407462913;950.5199874063588;950.6435086842434;694.2571448550053;694.2744831650937;696.5054811084136;696.954697944632;697.8569393274366;16948.0678562679;16992.40526581576;16994.745078823704;17005.319787208497;17021.23404446803;15353.462628807938;16328.83671163297;16330.510084697478;16498.83501164985;16844.66310673792;13976.231307278096;13982;13985.720285594332;14000.719985600334;14042.36809343582;4116.320807066831;4118.382242663594;4180.686448516343;4206;4263.765492897889;87504.56247718785;88449.55775221148;88542.55728721315;88645.55677221637;90297;12528.185667931555;12532.696575776807;12567.120301578985;12578.748425031448;12581.056420768478;24328.513429731305;24472.14347497829;24528;24531.38671533226;24783.87608061984;8689.782755431039;8830;8945.23965462943;9067.863982040275;9294.302927280482;4877.7565315506445;4951;4974.867383227758;5039.949600503948;5110.897782044412;3847.9230415391535;3963.801809909493;3993.0416699991792;3994.6205110514456;3998.0004998750314;596.3201949777257;667.5794249622803;669.3072669786748;670.53062856001;671.6373158494358;661.3650895140622;748.9888650322022;756.8145804277877;757.9734709285149;767.4666107055655;9172.082791720775;10176.135028522658;10609.310394824312;10734.409607471507;10975.945120274348;646.3471893387618;646.5829539946802;665.3280187011154;751.2149803455402;751.3275618321571;4959.504049595012;4997.050560393586;5005.524475174852;5094.133997220481;5108.080545501845;130857.34571327083;132739.33630331786;134526.32736836254;135273;139457;111539;113950;116093.41953290348;118608;120238;102123;104799;105009.47495262627;105816.47091764493;108498;8948.373613847229;9655.613775448903;9659.758506037124;9771.169450596495;9935.155511781579;57885.421145788;58906;59717.7014114944;60525.69737151286;61578;81557.18442815496;86540.56729716563;87489.56255218684;88870.55564722135;91855;11199.272047316897;11251.099912007183;11315.886841131483;11705;11992.580259690869;12834.807477887653;12848.935755321163;12963.41664625113;13055.281959491938;13489.865101348862;12914.418851151533;13054.738905222031;13144.737105257651;13342.19946803195;13447.193168409927;12872.485100595872;12995.155314904501;13023.47906083746;13145.60563183106;13214.735705286033;10889.945550272514;11276.379799111128;11292.876516631275;11430.599929002778;11487.19589628718;10458;10551.736206594589;10563.841542377024;10705.304155229886;10810.972957569333;11044.116470682166;11133.777324453304;11227;11244.66266012021;11299.209055366046 22:08:40 INFO - PROCESS | 15513 | __end_tp_report 22:08:40 INFO - PROCESS | 15513 | __start_cc_report 22:08:40 INFO - PROCESS | 15513 | _x_x_mozilla_cycle_collect,315 22:08:40 INFO - PROCESS | 15513 | __end_cc_report 22:08:40 INFO - PROCESS | 15513 | __startTimestamp1471237720748__endTimestamp 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | ------- Summary: start ------- 22:08:40 INFO - PROCESS | 15513 | Number of tests: 6 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#0] dojo.html Cycles:165 Average:5779.58 Median:6040.82 stddev:674.32 (11.2%) stddev-sans-first:647.21 22:08:40 INFO - PROCESS | 15513 | Values: 3278.3 3306.6 3306.6 3308.2 3324.7 5730.5 5821.2 5821.9 5858.8 5874.8 5804.2 5856.6 5886.0 5889.1 5894.7 5299.0 5300.9 5314.2 5356.6 5367.5 5178.4 5180.7 5238.6 5274.2 5319.6 5252.9 5274.6 5288.7 5295.0 5362.8 5342.9 5353.1 5357.3 5364.7 5383.0 5101.4 5162.1 5224.3 5242.5 5260.2 5580.2 5697.3 5702.5 5761.1 5778.3 6173.8 6206.2 6209.3 6217.1 6235.3 5978.0 6136.8 6205.7 6215.2 6219.3 5782.1 5877.2 5879.0 5908.6 5917.9 6373.0 6388.5 6392.6 6414.8 6432.2 5919.5 6079.8 6178.8 6188.0 6188.8 6121.7 6249.5 6282.7 6289.2 6293.7 6240.6 6241.4 6243.0 6247.5 6272.5 6026.8 6091.6 6220.7 6250.8 6263.2 4661.9 4754.2 4762.3 4768.9 4773.6 4222.5 4244.0 4248.4 4272.9 4282.2 5797.8 5824.3 5909.5 5956.5 5957.0 6117.0 6188.8 6218.5 6225.0 6248.3 5865.5 5886.6 5897.5 5919.7 5935.9 5043.5 5181.6 5209.7 5213.7 5231.8 6351.7 6555.2 6558.1 6561.6 6566.9 6286.7 6301.3 6305.5 6305.6 6322.4 6200.0 6284.2 6450.5 6532.9 6536.6 6013.8 6135.4 6143.2 6177.4 6194.8 6234.1 6242.1 6242.4 6249.3 6267.8 5971.2 6066.1 6086.7 6087.9 6111.1 6052.4 6151.4 6165.0 6173.3 6174.6 6049.9 6099.6 6101.6 6107.4 6112.7 5910.3 6040.8 6167.2 6172.0 6189.6 5930.5 6045.6 6046.2 6054.2 6095.2 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#1] ext.html Cycles:180 Average:63638.74 Median:45014.66 stddev:129918.14 (288.6%) stddev-sans-first:130196.33 22:08:40 INFO - PROCESS | 15513 | Values: 579.4 627.5 634.7 645.6 669.8 41552.0 45303.3 45391.8 45516.5 45792.1 46210.8 46731.3 46879.0 46889.5 47107.3 9085.0 9267.0 9279.8 9292.4 9310.6 9175.3 9218.1 9281.4 9309.2 9356.6 9290.8 9355.4 9391.3 9410.7 9412.2 9260.9 9295.2 9348.7 9402.1 9435.5 9206.8 9297.4 9325.1 9334.5 9335.5 44295.0 44307.1 44379.1 44407.1 44462.8 3668.0 3867.1 3884.7 3908.6 4112.6 34777.7 35226.3 35320.8 35330.0 35473.8 4626.1 4663.9 4729.5 4759.3 4815.0 254194.0 255895.0 256844.0 256895.7 257990.0 63876.4 64214.0 64343.0 64348.4 64369.7 39290.0 39803.6 40026.8 42457.4 68273.7 19717.3 19934.4 20024.1 20052.3 20111.9 15232.2 15380.5 15390.9 15394.9 15398.2 20983.6 21364.0 21369.6 21464.5 21535.6 7555.2 7710.5 7747.8 7884.9 7954.4 1019.9 1086.5 1097.1 1133.1 1172.8 33402.8 33764.0 33793.7 34054.5 34247.6 1120.2 1155.3 1175.0 1210.2 1225.8 17690.0 17821.0 17997.1 18029.6 18060.1 621816.0 623153.0 627658.0 628007.0 634187.0 64079.0 64833.0 64933.7 64964.0 64977.4 1434.0 1454.7 1467.7 1493.6 1504.1 33027.7 33266.2 33411.5 33688.3 33984.0 57490.0 57772.4 58068.7 58089.7 58206.0 498499.0 499140.0 505363.0 506263.0 506525.0 29760.9 31789.4 31895.2 31909.7 31920.5 51710.7 52298.5 52372.7 53107.7 54079.7 44814.6 44896.4 45063.3 46284.5 46805.5 43586.6 44959.6 44966.0 45532.8 45684.5 44401.3 45173.5 45394.5 46134.5 48064.5 39670.0 39728.6 39802.4 40151.0 40741.0 29846.7 30932.0 30966.4 30986.7 31278.1 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#2] jquery.html Cycles:180 Average:29316.74 Median:22476.88 stddev:79051.27 (351.7%) stddev-sans-first:79243.23 22:08:40 INFO - PROCESS | 15513 | Values: 408.8 415.7 416.4 419.5 426.1 18773.4 19976.8 20548.2 20800.3 21072.5 19491.9 19652.5 20006.6 20018.0 20150.7 5681.3 5859.7 5898.9 5902.7 5910.2 5762.5 5787.6 5791.5 5816.7 5828.7 5616.4 5798.4 5799.9 5804.1 5826.7 5743.0 5784.5 5788.4 5789.1 5810.4 5239.6 5243.6 5251.7 5253.8 5264.4 22033.9 22382.3 22571.4 22917.5 23747.3 2532.4 2560.8 2656.5 2851.5 2894.7 15349.8 15431.3 15467.2 15595.3 15807.4 1965.7 1994.8 2038.7 2039.5 2092.2 80682.9 81305.0 82357.6 82737.6 82850.6 9530.7 10075.2 10176.1 10444.6 11145.1 14103.7 14119.9 14147.8 14221.5 14245.4 7726.3 7907.9 7948.3 7982.8 8036.2 8206.6 8242.1 8280.2 8316.1 8400.3 4304.7 4361.9 4388.1 4464.7 4471.6 2107.4 2134.9 2144.1 2157.8 2170.1 992.7 995.8 1039.8 1058.3 1083.2 19660.7 19817.4 19837.2 19955.5 20317.2 1015.4 1016.1 1023.9 1025.3 1037.7 10983.9 11274.2 11342.1 11358.6 11480.3 464522.0 466003.0 481275.0 486481.0 491012.0 88419.0 95591.0 98364.0 100553.5 105079.5 1045.2 1066.3 1083.4 1084.9 1093.6 16439.8 18505.8 18599.8 18660.3 18868.6 37858.6 45444.8 46006.3 46139.8 46206.8 59476.1 62416.0 64058.7 64262.0 64813.7 8713.4 8961.8 9033.6 9042.6 9055.0 11464.6 13324.4 13509.9 13567.6 14079.6 11188.3 11579.8 11903.8 11907.0 12213.8 11548.4 11753.6 11917.5 12018.7 12046.0 11633.4 12252.9 12283.5 12520.6 12792.4 8853.2 8932.2 9040.0 9231.4 9235.0 10436.6 11746.6 12096.0 12332.1 12395.8 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#3] mootools.html Cycles:180 Average:6309.73 Median:4509.02 stddev:3599.46 (79.8%) stddev-sans-first:3591.28 22:08:40 INFO - PROCESS | 15513 | Values: 1483.5 1519.7 1586.2 1690.4 1712.3 8222.1 8966.2 9217.9 9713.8 9736.7 9266.9 9723.1 9729.6 9754.7 9757.5 2503.2 2532.8 2533.7 2533.9 2538.3 2433.4 2548.4 2563.8 2571.2 2576.9 2509.3 2519.6 2536.3 2547.4 2547.6 2471.6 2471.7 2472.6 2480.6 2504.8 2460.6 2464.1 2474.4 2481.0 2508.0 9730.7 9790.7 9804.1 9805.9 9824.2 5567.3 5668.8 5698.2 5733.8 5736.3 3574.0 3691.0 3766.5 3769.5 3786.9 1129.7 1172.4 1190.1 1194.2 1203.9 12960.2 12963.2 12967.9 12969.2 13007.2 4842.2 4992.9 5042.2 5157.0 5250.3 10454.0 10477.3 10480.0 10501.5 10502.9 5597.4 5611.0 5626.4 5631.5 5634.6 4570.9 5176.7 5243.2 5279.8 5288.0 4002.2 4065.7 4091.1 4093.9 4179.7 1165.7 1174.8 1185.2 1201.3 1212.5 1018.9 1019.5 1051.8 1067.7 1071.3 6538.1 6539.4 6608.9 6610.0 6641.4 1030.7 1105.1 1151.2 1176.4 1188.6 4504.3 4513.7 4550.8 4586.5 4649.5 11723.8 11928.2 11934.6 11944.5 12005.3 12040.6 12100.3 12120.2 12252.3 12258.1 8779.3 8865.8 8953.9 8956.3 8998.6 6458.7 6593.2 6622.8 6624.3 6634.1 11092.3 11119.9 11533.6 11538.9 11599.7 11203.0 11233.9 11468.0 11535.2 11620.2 7455.7 8160.5 8319.3 8348.2 8520.4 9504.9 9585.7 9587.1 9598.0 9616.6 8231.1 8320.7 8334.7 8361.6 8477.5 8278.5 8306.1 8340.0 8345.0 8424.0 7651.8 7868.7 7896.8 7947.8 7984.5 5505.3 5556.2 5568.1 5646.2 5696.3 5619.4 5679.4 5714.6 5747.3 5886.1 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#4] prototype.html Cycles:180 Average:4998.82 Median:5565.35 stddev:1461.94 (26.3%) stddev-sans-first:1423.91 22:08:40 INFO - PROCESS | 15513 | Values: 356.6 357.7 360.5 363.3 365.6 5944.7 5971.9 5983.3 6002.1 6010.2 5633.7 5843.8 5857.4 5859.2 5877.6 4488.7 4514.4 4532.3 4534.5 4536.2 4530.6 4533.0 4547.0 4549.4 4565.9 4478.3 4517.5 4523.4 4526.9 4564.6 4305.6 4458.3 4510.7 4517.2 4537.4 3936.0 3952.4 3967.7 3968.1 3977.6 5659.9 5708.9 5723.4 5737.1 5770.2 5010.7 5146.8 5217.2 5220.7 5245.3 6074.8 6124.9 6185.5 6185.6 6190.7 4364.8 4383.4 4460.5 4463.9 4474.2 6151.0 6314.3 6435.8 6453.5 6473.2 4392.6 4399.2 4435.0 4437.4 4439.5 4453.5 4472.3 4474.7 4480.0 4503.2 5024.2 5190.9 5202.3 5225.6 5226.8 6145.6 6145.7 6146.8 6172.3 6172.5 1553.8 1565.0 1567.7 1581.1 1583.5 943.8 991.9 996.5 1003.2 1010.2 5281.6 5298.5 5320.6 5338.0 5359.8 5566.0 5619.1 5632.8 5641.5 5646.9 5076.6 5168.3 5236.0 5244.8 5344.1 2957.2 2979.3 2993.5 2998.2 3030.7 5514.6 5698.4 5713.3 5714.1 5749.4 5563.7 5604.0 5613.3 5630.7 5677.0 5660.0 5697.7 5715.9 5766.5 5789.7 5259.7 5545.7 5559.4 5564.7 5665.5 5500.7 5545.5 5558.5 5581.6 5590.3 6282.5 6312.5 6449.0 6493.9 6514.0 4387.4 4403.7 4412.2 4425.0 4427.1 6221.2 6283.5 6345.3 6370.7 6410.0 6141.5 6185.3 6197.9 6203.2 6221.8 5900.7 6179.8 6198.4 6238.3 6255.0 6087.4 6089.8 6119.2 6124.2 6134.8 6219.2 6261.4 6285.7 6298.4 6339.6 5847.4 6028.6 6080.1 6107.9 6115.4 22:08:40 INFO - PROCESS | 15513 | 22:08:40 INFO - PROCESS | 15513 | [#5] yui.html Cycles:180 Average:23552.32 Median:3978.42 stddev:35547.61 (893.5%) stddev-sans-first:35606.38 22:08:40 INFO - PROCESS | 15513 | Values: 828.3 842.4 871.8 873.5 924.0 16030.6 18002.9 18289.9 18325.6 18326.8 15728.8 15753.6 16101.3 16111.8 16118.9 852.4 870.1 871.1 871.5 873.2 860.2 863.5 896.8 900.4 908.1 946.6 946.6 947.9 949.4 949.5 947.3 950.0 950.1 950.5 950.6 694.3 694.3 696.5 697.0 697.9 16948.1 16992.4 16994.7 17005.3 17021.2 15353.5 16328.8 16330.5 16498.8 16844.7 13976.2 13982.0 13985.7 14000.7 14042.4 4116.3 4118.4 4180.7 4206.0 4263.8 87504.6 88449.6 88542.6 88645.6 90297.0 12528.2 12532.7 12567.1 12578.7 12581.1 24328.5 24472.1 24528.0 24531.4 24783.9 8689.8 8830.0 8945.2 9067.9 9294.3 4877.8 4951.0 4974.9 5039.9 5110.9 3847.9 3963.8 3993.0 3994.6 3998.0 596.3 667.6 669.3 670.5 671.6 661.4 749.0 756.8 758.0 767.5 9172.1 10176.1 10609.3 10734.4 10975.9 646.3 646.6 665.3 751.2 751.3 4959.5 4997.1 5005.5 5094.1 5108.1 130857.3 132739.3 134526.3 135273.0 139457.0 111539.0 113950.0 116093.4 118608.0 120238.0 102123.0 104799.0 105009.5 105816.5 108498.0 8948.4 9655.6 9659.8 9771.2 9935.2 57885.4 58906.0 59717.7 60525.7 61578.0 81557.2 86540.6 87489.6 88870.6 91855.0 11199.3 11251.1 11315.9 11705.0 11992.6 12834.8 12848.9 12963.4 13055.3 13489.9 12914.4 13054.7 13144.7 13342.2 13447.2 12872.5 12995.2 13023.5 13145.6 13214.7 10889.9 11276.4 11292.9 11430.6 11487.2 10458.0 10551.7 10563.8 10705.3 10811.0 11044.1 11133.8 11227.0 11244.7 11299.2 22:08:40 INFO - PROCESS | 15513 | -------- Summary: end -------- 22:08:40 INFO - PROCESS | 15513 | 22:08:41 INFO - TEST-INFO | 15513: exit 0 22:08:41 INFO - TEST-OK | dromaeo_css | took 1110595ms 22:08:41 INFO - TEST-START | kraken 22:08:41 INFO - operating with platform_type : linux_ 22:08:41 INFO - Initialising browser for kraken test... 22:08:41 INFO - TEST-INFO | started process 15773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIFDaA8/profile http://localhost:45728/getInfo.html) 22:08:45 INFO - PROCESS | 15773 | __metrics Screen width/height:1600/1200 22:08:45 INFO - PROCESS | 15773 | colorDepth:24 22:08:45 INFO - PROCESS | 15773 | Browser inner width/height: 1024/697 22:08:45 INFO - PROCESS | 15773 | __metrics 22:08:46 ERROR - PROCESS | 15773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:08:47 INFO - TEST-INFO | 15773: exit 0 22:08:47 INFO - Browser initialized. 22:08:47 INFO - Running cycle 1/1 for kraken test... 22:08:47 INFO - TEST-INFO | started process 15899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIFDaA8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:59 INFO - PROCESS | 15899 | RSS: Main: 152817664 22:08:59 INFO - PROCESS | 15899 | 22:09:01 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45728/tests/kraken/driver.html?testName=audio-beat-detection) 22:09:02 INFO - PROCESS | 15899 | RSS: Main: 157982720 22:09:02 INFO - PROCESS | 15899 | 22:09:05 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45728/tests/kraken/driver.html?testName=audio-dft) 22:09:05 INFO - PROCESS | 15899 | RSS: Main: 156680192 22:09:05 INFO - PROCESS | 15899 | 22:09:08 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45728/tests/kraken/driver.html?testName=audio-fft) 22:09:09 INFO - PROCESS | 15899 | RSS: Main: 156962816 22:09:09 INFO - PROCESS | 15899 | 22:09:11 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45728/tests/kraken/driver.html?testName=audio-oscillator) 22:09:11 INFO - PROCESS | 15899 | RSS: Main: 157085696 22:09:11 INFO - PROCESS | 15899 | 22:09:14 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:09:14 INFO - PROCESS | 15899 | RSS: Main: 156729344 22:09:14 INFO - PROCESS | 15899 | 22:09:17 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45728/tests/kraken/driver.html?testName=imaging-darkroom) 22:09:18 INFO - PROCESS | 15899 | RSS: Main: 156729344 22:09:18 INFO - PROCESS | 15899 | 22:09:21 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45728/tests/kraken/driver.html?testName=imaging-desaturate) 22:09:22 INFO - PROCESS | 15899 | RSS: Main: 156499968 22:09:22 INFO - PROCESS | 15899 | 22:09:25 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45728/tests/kraken/driver.html?testName=json-parse-financial) 22:09:25 INFO - PROCESS | 15899 | RSS: Main: 157630464 22:09:25 INFO - PROCESS | 15899 | 22:09:27 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:09:27 INFO - PROCESS | 15899 | RSS: Main: 157126656 22:09:27 INFO - PROCESS | 15899 | 22:09:29 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:09:30 INFO - PROCESS | 15899 | RSS: Main: 157020160 22:09:30 INFO - PROCESS | 15899 | 22:09:32 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:09:33 INFO - PROCESS | 15899 | RSS: Main: 157380608 22:09:33 INFO - PROCESS | 15899 | 22:09:35 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:09:36 INFO - PROCESS | 15899 | RSS: Main: 157790208 22:09:36 INFO - PROCESS | 15899 | 22:09:38 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:09:39 INFO - PROCESS | 15899 | RSS: Main: 157757440 22:09:39 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | Cycle 1(1): loaded http://localhost:45728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45728/tests/kraken/driver.html?testName=ai-astar) 22:09:41 INFO - PROCESS | 15899 | RSS: Main: 159113216 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | __start_tp_report 22:09:41 INFO - PROCESS | 15899 | _x_x_mozilla_page_load 22:09:41 INFO - PROCESS | 15899 | _x_x_mozilla_page_load_details 22:09:41 INFO - PROCESS | 15899 | |i|pagename|runs| 22:09:41 INFO - PROCESS | 15899 | |0;ai-astar;100;111;104;111;112;112;110;109;111;111 22:09:41 INFO - PROCESS | 15899 | |1;audio-beat-detection;144;119;137;179;116;145;143;117;180;117 22:09:41 INFO - PROCESS | 15899 | |2;audio-dft;167;162;161;161;161;160;162;162;162;160 22:09:41 INFO - PROCESS | 15899 | |3;audio-fft;74;77;76;173;76;76;76;77;175;76 22:09:41 INFO - PROCESS | 15899 | |4;audio-oscillator;82;85;148;83;83;84;147;84;84;143 22:09:41 INFO - PROCESS | 15899 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;117;117;118 22:09:41 INFO - PROCESS | 15899 | |6;imaging-darkroom;147;149;147;147;148;147;147;147;149;150 22:09:41 INFO - PROCESS | 15899 | |7;imaging-desaturate;96;96;95;94;95;95;96;96;95;95 22:09:41 INFO - PROCESS | 15899 | |8;json-parse-financial;55;56;53;51;51;57;53;52;51;55 22:09:41 INFO - PROCESS | 15899 | |9;json-stringify-tinderbox;62;60;60;61;60;59;60;61;60;61 22:09:41 INFO - PROCESS | 15899 | |10;stanford-crypto-aes;73;73;72;73;72;73;73;71;77;72 22:09:41 INFO - PROCESS | 15899 | |11;stanford-crypto-ccm;124;121;122;116;124;117;129;117;157;130 22:09:41 INFO - PROCESS | 15899 | |12;stanford-crypto-pbkdf2;155;151;156;152;154;151;151;151;153;150 22:09:41 INFO - PROCESS | 15899 | |13;stanford-crypto-sha256-iterative;61;63;62;61;66;72;62;61;59;61 22:09:41 INFO - PROCESS | 15899 | __end_tp_report 22:09:41 INFO - PROCESS | 15899 | __start_cc_report 22:09:41 INFO - PROCESS | 15899 | _x_x_mozilla_cycle_collect,833 22:09:41 INFO - PROCESS | 15899 | __end_cc_report 22:09:41 INFO - PROCESS | 15899 | __startTimestamp1471237781300__endTimestamp 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | ------- Summary: start ------- 22:09:41 INFO - PROCESS | 15899 | Number of tests: 14 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.96 (3.6%) stddev-sans-first:2.47 22:09:41 INFO - PROCESS | 15899 | Values: 100.0 111.0 104.0 111.0 112.0 112.0 110.0 109.0 111.0 111.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:143.50 stddev:24.16 (16.8%) stddev-sans-first:25.58 22:09:41 INFO - PROCESS | 15899 | Values: 144.0 119.0 137.0 179.0 116.0 145.0 143.0 117.0 180.0 117.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.99 (1.2%) stddev-sans-first:0.83 22:09:41 INFO - PROCESS | 15899 | Values: 167.0 162.0 161.0 161.0 161.0 160.0 162.0 162.0 162.0 160.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.33 (54.4%) stddev-sans-first:43.09 22:09:41 INFO - PROCESS | 15899 | Values: 74.0 77.0 76.0 173.0 76.0 76.0 76.0 77.0 175.0 76.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.50 stddev:30.19 (36.2%) stddev-sans-first:31.12 22:09:41 INFO - PROCESS | 15899 | Values: 82.0 85.0 148.0 83.0 83.0 84.0 147.0 84.0 84.0 143.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:09:41 INFO - PROCESS | 15899 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.14 (0.8%) stddev-sans-first:1.17 22:09:41 INFO - PROCESS | 15899 | Values: 147.0 149.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 150.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 22:09:41 INFO - PROCESS | 15899 | Values: 96.0 96.0 95.0 94.0 95.0 95.0 96.0 96.0 95.0 95.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:2.22 (4.1%) stddev-sans-first:2.28 22:09:41 INFO - PROCESS | 15899 | Values: 55.0 56.0 53.0 51.0 51.0 57.0 53.0 52.0 51.0 55.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 22:09:41 INFO - PROCESS | 15899 | Values: 62.0 60.0 60.0 61.0 60.0 59.0 60.0 61.0 60.0 61.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.60 (2.2%) stddev-sans-first:1.69 22:09:41 INFO - PROCESS | 15899 | Values: 73.0 73.0 72.0 73.0 72.0 73.0 73.0 71.0 77.0 72.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:124.00 stddev:12.00 (9.7%) stddev-sans-first:12.71 22:09:41 INFO - PROCESS | 15899 | Values: 124.0 121.0 122.0 116.0 124.0 117.0 129.0 117.0 157.0 130.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.50 stddev:2.01 (1.3%) stddev-sans-first:1.90 22:09:41 INFO - PROCESS | 15899 | Values: 155.0 151.0 156.0 152.0 154.0 151.0 151.0 151.0 153.0 150.0 22:09:41 INFO - PROCESS | 15899 | 22:09:41 INFO - PROCESS | 15899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:3.71 (6.0%) stddev-sans-first:3.87 22:09:41 INFO - PROCESS | 15899 | Values: 61.0 63.0 62.0 61.0 66.0 72.0 62.0 61.0 59.0 61.0 22:09:41 INFO - PROCESS | 15899 | -------- Summary: end -------- 22:09:41 INFO - PROCESS | 15899 | 22:09:42 INFO - TEST-INFO | 15899: exit 0 22:09:42 INFO - TEST-OK | kraken | took 60810ms 22:09:42 INFO - SUITE-END | took 1171s 22:09:42 INFO - Completed test suite (00:19:31) 22:09:42 INFO - javascript benchmark 22:09:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.034090029604, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.2787786686927, 3306.5866766654167, 3306.6032076150864, 3308.2391050058473, 3324.6841550052736, 5730.484256416927, 5821.155932389801, 5821.912671309934, 5858.794942177019, 5874.765009399624, 5804.187413762077, 5856.590038697283, 5886.028805247129, 5889.116632505126, 5894.705264736767, 5298.973505132488, 5300.946990530094, 5314.229436731691, 5356.625036247464, 5367.516923476886, 5178.378594568657, 5180.715060671661, 5238.60710446718, 5274.235235890794, 5319.5744340452675, 5252.8686782830355, 5274.604404669646, 5288.709120998344, 5295.0468915595175, 5362.839114826562, 5342.946570534304, 5353.0899747043095, 5357.330333708267, 5364.739286267724, 5382.950324686688, 5101.387833459971, 5162.148245539482, 5224.346956630421, 5242.475752424727, 5260.158374660036, 5580.19087232349, 5697.287839020122, 5702.515286200678, 5761.107028410603, 5778.306603207642, 6173.783917562909, 6206.162168107293, 6209.285932117774, 6217.067439884008, 6235.282942461584, 5977.970110149465, 6136.7545298188015, 6205.689715514206, 6215.223097112861, 6219.253689557237, 5782.074868021138, 5877.23595932526, 5878.970605147032, 5908.615939963888, 5917.852053698649, 6373.0, 6388.456981156561, 6392.648404337713, 6414.775482858077, 6432.2281326241155, 5919.526437884959, 6079.848003799941, 6178.845528861724, 6188.009918413032, 6188.845278868064, 6121.727351053096, 6249.468795152463, 6282.685865706696, 6289.245290565162, 6293.716782744696, 6240.625562466266, 6241.375862413723, 6243.0, 6247.531435142382, 6272.498200143978, 6026.7890623828835, 6091.634501929899, 6220.657863817443, 6250.781222657185, 6263.154474146023, 4661.906761864811, 4754.191787396151, 4762.309465127537, 4768.928466073012, 4773.570378665937, 4222.493300803923, 4243.978780106079, 4248.362745588187, 4272.850450234227, 4282.186384586918, 5797.768089276382, 5824.301083869878, 5909.497692696083, 5956.463918247378, 5957.046872500379, 6116.969415152896, 6188.81433556985, 6218.533609979269, 6224.968875155595, 6248.28144763349, 5865.530757539386, 5886.58793884424, 5897.469227769521, 5919.704014799329, 5935.940640593625, 5043.52086551777, 5181.5595674368105, 5209.6874187548865, 5213.713245771519, 5231.790728370898, 6351.714172862232, 6555.2133743951035, 6558.114654521579, 6561.5734977227285, 6566.934330656728, 6286.74853005893, 6301.306856245717, 6305.464035557029, 6305.621662700252, 6322.36776322364, 6199.969000154971, 6284.214473190851, 6450.48396128318, 6532.934670653232, 6536.607803531613, 6013.849653758691, 6135.417135372132, 6143.232095988002, 6177.444030037318, 6194.783182588588, 6234.096056071935, 6242.094896239929, 6242.375762423903, 6249.250089989048, 6267.843303917256, 5971.193888824953, 6066.120412540069, 6086.695665216633, 6087.8782424350375, 6111.052786818051, 6052.394760523913, 6151.446369826737, 6165.0, 6173.290071641819, 6174.629522228681, 6049.939500604937, 6099.573029887865, 6101.566699181792, 6107.389261073857, 6112.689653113243, 5910.320313163869, 6040.818775436744, 6167.167432396569, 6171.9691401542705, 6189.597676151036, 5930.466258036625, 6045.576809623284, 6046.2139921809885, 6054.243219597551, 6095.177151084724], "value": 5732.647514968727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4350508254449, 627.5011365964061, 634.6794868591362, 645.5771469687355, 669.7789729389302, 41552.0, 45303.32045019327, 45391.77304113479, 45516.54483455164, 45792.084158316815, 46210.76894615531, 46731.29903051457, 46879.0, 46889.53110468894, 47107.29339059908, 9084.954575227115, 9266.953665231698, 9279.768005799842, 9292.442453452815, 9310.581023853909, 9175.311851611155, 9218.124278193562, 9281.35030547862, 9309.208717259007, 9356.578953947055, 9290.76773080675, 9355.391899526543, 9391.295652826031, 9410.670626528039, 9412.199963003153, 9260.861087083698, 9295.2099071579, 9348.67279645216, 9402.059794020577, 9435.481048542328, 9206.815863682756, 9297.395669281543, 9325.114114159143, 9334.533273336374, 9335.486548239844, 44295.0, 44307.11385772267, 44379.112417751785, 44407.11185776266, 44462.77768611169, 3667.9816600917093, 3867.0525721198205, 3884.6892248620325, 3908.6482216600643, 4112.609302116294, 34777.65222347769, 35226.29547409037, 35320.82339588311, 35330.0, 35473.82263088694, 4626.1441633297945, 4663.860084197479, 4729.50340214276, 4759.333693282943, 4815.0, 254194.0, 255895.0, 256844.0, 256895.71552142306, 257990.0, 63876.36123638797, 64214.0, 64343.0, 64348.356516434236, 64369.67815160894, 39290.0, 39803.60196398057, 40026.79986600048, 42457.36313955293, 68273.65863170751, 19717.309894153637, 19934.401967940987, 20024.098915548835, 20052.29816956429, 20111.899440502704, 15232.162231077176, 15380.538583842503, 15390.923045384701, 15394.923025385026, 15398.153101579297, 20983.580328393346, 21364.0, 21369.572608547744, 21464.4633884151, 21535.60018598786, 7555.16893141754, 7710.537367757953, 7747.767566973, 7884.921150788418, 7954.403419743542, 1019.887812340642, 1086.5002099034375, 1097.0620119797459, 1133.1105082510355, 1172.7888979983684, 33402.83298583492, 33764.0, 33793.66206337955, 34054.48918266228, 34247.58124534855, 1120.227043340109, 1155.283724091069, 1174.9647510574696, 1210.1952201785714, 1225.779359715242, 17690.0, 17821.0, 17997.1001449927, 18029.639407211784, 18060.09699515019, 621816.0, 623153.0, 627658.0, 628007.0, 634187.0, 64079.0, 64833.0, 64933.675331623985, 64964.0, 64977.35022649713, 1433.978490322646, 1454.7308747881464, 1467.713795809807, 1493.6415260337658, 1504.0674781635237, 33027.66972330246, 33266.16834579155, 33411.49882751712, 33688.32623347568, 33984.0, 57490.0, 57772.422275776706, 58068.70965645145, 58089.709551451975, 58206.0, 498499.0, 499140.0, 505363.0, 506263.0, 506525.0, 29760.851195743882, 31789.36421271608, 31895.20261993376, 31909.6809031916, 31920.52119218167, 51710.74144629253, 52298.477015229364, 52372.738136309075, 53107.73446132745, 54079.72960135174, 44814.55185448234, 44896.36839685922, 45063.32405013862, 46284.53715462937, 46805.53194468148, 43586.564134358254, 44959.55040449554, 44966.0, 45532.77233613811, 45684.54315456936, 44401.33397999097, 45173.54826451693, 45394.54605453903, 46134.538654613025, 48064.5193548074, 39670.0, 39728.60271397365, 39802.40296395614, 40151.0, 40741.0, 29846.701532984393, 30932.0, 30966.380672386877, 30986.69013309928, 31278.06165815029], "value": 21480.828625677237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.8099033949213, 415.7256210900805, 416.41493701349594, 419.4777502009998, 426.09880103580934, 18773.43679689608, 19976.801391916477, 20548.17807287707, 20800.271990480338, 21072.473188170305, 19491.902540487314, 19652.508687282825, 20006.59986800263, 20018.0, 20150.69773953392, 5681.318241810978, 5859.736311865976, 5898.941010589903, 5902.675352855591, 5910.172575839386, 5762.53899688026, 5787.623804452718, 5791.507721843648, 5816.738246778884, 5828.650280983134, 5616.410276920926, 5798.449147330997, 5799.884002319951, 5804.100364443497, 5826.650400975934, 5742.971285143548, 5784.537237021028, 5788.363280039213, 5789.073748200289, 5810.360860305363, 5239.633225674204, 5243.580513558906, 5251.658642188246, 5253.842384728464, 5264.447233040514, 22033.889830550906, 22382.32853014412, 22571.435714107116, 22917.54164916709, 23747.287581372588, 2532.4048848520583, 2560.807939404552, 2656.468706258756, 2851.5152424087955, 2894.6671132819783, 15349.846501534954, 15431.305591248421, 15467.226638668135, 15595.298211580506, 15807.367705291774, 1965.6756635155182, 1994.7931501441565, 2038.6636205026152, 2039.5309078911932, 2092.184048221195, 80682.86159128057, 81305.0, 82357.58821205916, 82737.58631206866, 82850.58574707087, 9530.666426675032, 10075.193984481224, 10176.084152426169, 10444.63443779464, 11145.108391328675, 14103.71792564143, 14119.85880141206, 14147.787783183261, 14221.502247421291, 14245.358958846877, 7726.34326082278, 7907.920920790719, 7948.324392426593, 7982.840343193104, 8036.156203598655, 8206.630701618442, 8242.134575869448, 8280.171982801672, 8316.085230624627, 8400.285975692135, 4304.677149213821, 4361.890952726144, 4388.144311859157, 4464.732116073046, 4471.642268618502, 2107.430993631711, 2134.914603415846, 2144.0994782191206, 2157.751858536257, 2170.088562803595, 992.667456402099, 995.8008398320364, 1039.8180318444242, 1058.3226734889677, 1083.230906056693, 19660.70508942367, 19817.405477835688, 19837.20651173937, 19955.501112472306, 20317.18731250763, 1015.3653966271081, 1016.1159790981745, 1023.902729240721, 1025.2669341420772, 1037.6886933919945, 10983.890161098287, 11274.210805243718, 11342.092632589372, 11358.60244891425, 11480.31118132898, 464522.0, 466003.0, 481275.0, 486481.0, 491012.0, 88419.0, 95591.0, 98363.99999999857, 100553.49723251483, 105079.47460262649, 1045.2265323660436, 1066.333541536524, 1083.3554035348955, 1084.9240553161203, 1093.6227001684406, 16439.753403699193, 18505.81494185041, 18599.814001860348, 18660.346887859403, 18868.622627547647, 37858.62141378551, 45444.772776135906, 46006.3452219085, 46139.76930115328, 46206.76896615495, 59476.10785838129, 62416.0, 64058.67970660117, 64262.0, 64813.67593162004, 8713.390062695551, 8961.820763584823, 9033.638654453749, 9042.593083311136, 9055.0, 11464.598739044428, 13324.40040198174, 13509.864901351253, 13567.59297221085, 14079.577612671636, 11188.328700278009, 11579.768404631692, 11903.82144267854, 11907.0, 12213.755724885275, 11548.364839933884, 11753.588624398106, 11917.52329906794, 12018.699532511757, 12046.0, 11633.418329083343, 12252.938735306267, 12283.508659653513, 12520.561780337644, 12792.360381980678, 8853.203211710977, 8932.19610235082, 9040.0, 9231.35380523357, 9234.9538252311, 10436.58253669875, 11746.647600571996, 12096.0, 12332.075094368138, 12395.814062789246], "value": 9546.03603674398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.525271912988, 1519.7340465418552, 1586.159335552157, 1690.408357075023, 1712.2893998990419, 8222.095569487352, 8966.23786978107, 9217.90782092179, 9713.757156071093, 9736.6592169274, 9266.90733092669, 9723.07630775077, 9729.562169702363, 9754.707358779231, 9757.463339516324, 2503.1739525956436, 2532.7973762098986, 2533.6959564852245, 2533.898644054236, 2538.2512158913164, 2433.3551608823677, 2548.413864811085, 2563.8078293593476, 2571.215779187347, 2576.896924123033, 2509.3224829296078, 2519.596864501671, 2536.2898388451263, 2547.4013606802387, 2547.5541780188487, 2471.616899380599, 2471.7157526884457, 2472.5673007223754, 2480.6279058141245, 2504.8246622736415, 2460.606302991531, 2464.1006032798077, 2474.4308808974038, 2481.0, 2508.0, 9730.708078757649, 9790.657326993593, 9804.117629413387, 9805.90194098057, 9824.164945979528, 5567.331920169606, 5668.829935101953, 5698.173764804122, 5733.799317023926, 5736.282964629421, 3573.9642603573893, 3690.9630903690886, 3766.510353654035, 3769.5288088988877, 3786.9053273668105, 1129.717570607348, 1172.3903570143564, 1190.053907143814, 1194.2416565480896, 1203.939803009846, 12960.222386656736, 12963.15739476931, 12967.870321296761, 12969.157004794752, 13007.219566826021, 4842.176829938919, 4992.8751781205765, 5042.243663450438, 5156.974215128976, 5250.317458730341, 10454.0, 10477.266591338534, 10480.0, 10501.474926253657, 10502.894971050191, 5597.412271711493, 5610.97194514033, 5626.409227031185, 5631.493165615032, 5634.60557760961, 4570.908581828411, 5176.741162941913, 5243.187305967581, 5279.788808447696, 5288.048151332797, 4002.219567184371, 4065.735727177724, 4091.1408604192857, 4093.85671501496, 4179.749215047107, 1165.7085728567858, 1174.8002839517303, 1185.1644590563633, 1201.2972411139406, 1212.490753883371, 1018.9133923616428, 1019.4749703902496, 1051.8211903976342, 1067.685032915292, 1071.2554774431694, 6538.084668146464, 6539.411452969255, 6608.86782264352, 6610.0, 6641.402273795382, 1030.6701855406347, 1105.0993440346092, 1151.1711567671264, 1176.3765204441659, 1188.6018183908316, 4504.301833215792, 4513.729176249435, 4550.772461376918, 4586.472555656075, 4649.535046495391, 11723.76552468946, 11928.224665396721, 11934.582289619822, 11944.522219111312, 12005.279683219034, 12040.578579749841, 12100.273983561014, 12120.212186207867, 12252.264864108181, 12258.08064395174, 8779.341549383695, 8865.778355541033, 8953.910460895308, 8956.28349732033, 8998.59506322217, 6458.709358078804, 6593.175853018372, 6622.801315960529, 6624.271330153583, 6634.137562117087, 11092.279001864854, 11119.944400277947, 11533.596324128615, 11538.88461115378, 11599.6520104397, 11203.0, 11233.887661123284, 11468.0, 11535.192536522363, 11620.186586938833, 7455.739049133254, 8160.5103693778565, 8319.292860106716, 8348.206920342558, 8520.403571749917, 9504.904950950679, 9585.712428627152, 9587.089226523469, 9598.0, 9616.615335386507, 8231.09457959612, 8320.667173312999, 8334.666613335641, 8361.581920904053, 8477.533735644598, 8278.503289802631, 8306.127856574973, 8340.0, 8345.0, 8424.0, 7651.770446886602, 7868.72459463916, 7896.802579935547, 7947.801304967422, 7984.481008734414, 5505.311836020497, 5556.222128902038, 5568.053430916835, 5646.181303711021, 5696.344920334214, 5619.381867994435, 5679.375268720355, 5714.571407144564, 5747.252857128547, 5886.146508756292], "value": 5027.937124906621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.59526437493435, 357.7013193983024, 360.5421115183715, 363.2553265805099, 365.6215816629787, 5944.732487038083, 5971.924458903668, 5983.282006159262, 6002.129691194785, 6010.218671572689, 5633.690147041911, 5843.824685259438, 5857.355690874011, 5859.238299021121, 5877.588568800185, 4488.68579199457, 4514.390557274775, 4532.320151977214, 4534.523874993128, 4536.183486972343, 4530.592246697796, 4533.0, 4546.954530454703, 4549.407707302451, 4565.908681826361, 4478.305862591304, 4517.525659805722, 4523.36672865799, 4526.909461810762, 4564.612007979325, 4305.6124948754605, 4458.308962110878, 4510.6918993491845, 4517.2094883395275, 4537.366548042702, 3935.960640393588, 3952.407138929155, 3967.7024223183375, 3968.1270120573427, 3977.622125898035, 5659.943400566024, 5708.942910570882, 5723.427657234285, 5737.139429085671, 5770.16332631766, 5010.72441015744, 5146.757542748082, 5217.191335343028, 5220.738963051832, 5245.291885595434, 6074.848128796772, 6124.908126378108, 6185.536084793614, 6185.628862268279, 6190.721417536221, 4364.825406983717, 4383.364412160219, 4460.4647442306805, 4463.933041004388, 4474.239379305526, 6150.985087460608, 6314.273858506284, 6435.8391040223905, 6453.451456626192, 6473.190851143607, 4392.5607439256455, 4399.196329504952, 4435.024294655171, 4437.378766972626, 4439.511653718088, 4453.463555073495, 4472.284434490466, 4474.686771925999, 4480.0, 4503.211937910853, 5024.171011783088, 5190.885468718739, 5202.3497062867145, 5225.608079394061, 5226.817061402909, 6145.600535965148, 6145.723442445101, 6146.832101900624, 6172.321044685081, 6172.475339596095, 1553.7824704541374, 1564.9843501565067, 1567.686462707463, 1581.1066747287746, 1583.4853672556465, 943.7640589852537, 991.8710567626307, 996.5151923633879, 1003.1924300937669, 1010.1565193063874, 5281.603879709037, 5298.496642818926, 5320.647991765163, 5338.0, 5359.812406565751, 5566.0, 5619.129034999582, 5632.831015069554, 5641.492265696025, 5646.943530564724, 5076.6192535559985, 5168.328117344721, 5236.0, 5244.767479642281, 5344.091504444176, 2957.2015555800244, 2979.333496520602, 2993.476141675198, 2998.190488568118, 3030.742241969558, 5514.641548299348, 5698.373178950312, 5713.2572765541045, 5714.0571805652435, 5749.367569567345, 5563.693996830213, 5604.019296623074, 5613.326400831927, 5630.746616402272, 5677.041420709848, 5659.971700141473, 5697.686627235459, 5715.914261286084, 5766.452187042224, 5789.652620842763, 5259.710715910662, 5545.667259964253, 5559.360673522597, 5564.690653378964, 5665.461781130786, 5500.744694675164, 5545.500904918576, 5558.527525160407, 5581.553475722014, 5590.301212348457, 6282.528810339151, 6312.4634406074165, 6448.967755161382, 6493.935060649333, 6513.967430162819, 4387.385765992827, 4403.691741578059, 4412.2499175139665, 4424.955750442583, 4427.092446048488, 6221.191245138103, 6283.49732021428, 6345.2702939160745, 6370.694007728497, 6410.044936294288, 6141.539384546266, 6185.3095152458945, 6197.907031394623, 6203.2245969253845, 6221.751129954751, 5900.734466949083, 6179.81460556184, 6198.411150940653, 6238.344973777869, 6255.0, 6087.391260873877, 6089.817305480843, 6119.204503414706, 6124.173236613178, 6134.8159555213415, 6219.191505104308, 6261.405166509175, 6285.74857005733, 6298.433141017331, 6339.5562310637815, 5847.356790752929, 6028.563718680311, 6080.118382834376, 6107.9389206109145, 6115.4190351916495], "value": 4533.513327931952, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.2504333578111, 842.3934766967785, 871.8125602995354, 873.5195642396682, 923.9538023098852, 16030.602524410571, 18002.909985450053, 18289.908550457247, 18325.633487330262, 18326.81673183271, 15728.764068538952, 15753.60615984601, 16101.275442605081, 16111.758323625156, 16118.919405402987, 852.4288726553209, 870.138562822804, 871.0984131423977, 871.4988881393192, 873.2359185712502, 860.2472836268265, 863.5293764898146, 896.753392816974, 900.4057322167371, 908.0783005249676, 946.5645802930626, 946.6497395963503, 947.853082772168, 949.4113649537296, 949.5299826585815, 947.3415975896754, 950.0, 950.097407462913, 950.5199874063588, 950.6435086842434, 694.2571448550053, 694.2744831650937, 696.5054811084136, 696.954697944632, 697.8569393274366, 16948.0678562679, 16992.40526581576, 16994.745078823704, 17005.319787208497, 17021.23404446803, 15353.462628807938, 16328.83671163297, 16330.510084697478, 16498.83501164985, 16844.66310673792, 13976.231307278096, 13982.0, 13985.720285594332, 14000.719985600334, 14042.36809343582, 4116.320807066831, 4118.382242663594, 4180.686448516343, 4206.0, 4263.765492897889, 87504.56247718785, 88449.55775221148, 88542.55728721315, 88645.55677221637, 90297.0, 12528.185667931555, 12532.696575776807, 12567.120301578985, 12578.748425031448, 12581.056420768478, 24328.513429731305, 24472.14347497829, 24528.0, 24531.38671533226, 24783.87608061984, 8689.782755431039, 8830.0, 8945.23965462943, 9067.863982040275, 9294.302927280482, 4877.7565315506445, 4951.0, 4974.867383227758, 5039.949600503948, 5110.897782044412, 3847.9230415391535, 3963.801809909493, 3993.0416699991792, 3994.6205110514456, 3998.0004998750314, 596.3201949777257, 667.5794249622803, 669.3072669786748, 670.53062856001, 671.6373158494358, 661.3650895140622, 748.9888650322022, 756.8145804277877, 757.9734709285149, 767.4666107055655, 9172.082791720775, 10176.135028522658, 10609.310394824312, 10734.409607471507, 10975.945120274348, 646.3471893387618, 646.5829539946802, 665.3280187011154, 751.2149803455402, 751.3275618321571, 4959.504049595012, 4997.050560393586, 5005.524475174852, 5094.133997220481, 5108.080545501845, 130857.34571327083, 132739.33630331786, 134526.32736836254, 135273.0, 139457.0, 111539.0, 113950.0, 116093.41953290348, 118608.0, 120238.0, 102123.0, 104799.0, 105009.47495262627, 105816.47091764493, 108498.0, 8948.373613847229, 9655.613775448903, 9659.758506037124, 9771.169450596495, 9935.155511781579, 57885.421145788, 58906.0, 59717.7014114944, 60525.69737151286, 61578.0, 81557.18442815496, 86540.56729716563, 87489.56255218684, 88870.55564722135, 91855.0, 11199.272047316897, 11251.099912007183, 11315.886841131483, 11705.0, 11992.580259690869, 12834.807477887653, 12848.935755321163, 12963.41664625113, 13055.281959491938, 13489.865101348862, 12914.418851151533, 13054.738905222031, 13144.737105257651, 13342.19946803195, 13447.193168409927, 12872.485100595872, 12995.155314904501, 13023.47906083746, 13145.60563183106, 13214.735705286033, 10889.945550272514, 11276.379799111128, 11292.876516631275, 11430.599929002778, 11487.19589628718, 10458.0, 10551.736206594589, 10563.841542377024, 10705.304155229886, 10810.972957569333, 11044.116470682166, 11133.777324453304, 11227.0, 11244.66266012021, 11299.209055366046], "value": 8079.607058092942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 104.0, 111.0, 112.0, 112.0, 110.0, 109.0, 111.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 137.0, 179.0, 116.0, 145.0, 143.0, 117.0, 180.0, 117.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 173.0, 76.0, 76.0, 76.0, 77.0, 175.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 148.0, 83.0, 83.0, 84.0, 147.0, 84.0, 84.0, 143.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 150.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 51.0, 51.0, 57.0, 53.0, 52.0, 51.0, 55.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 72.0, 73.0, 73.0, 71.0, 77.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 122.0, 116.0, 124.0, 117.0, 129.0, 117.0, 157.0, 130.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 156.0, 152.0, 154.0, 151.0, 151.0, 151.0, 153.0, 150.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 66.0, 72.0, 62.0, 61.0, 59.0, 61.0], "value": 62.8, "unit": "score"}]}]} 22:09:42 INFO - Return code: 0 22:09:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:09:42 ERROR - # TBPL SUCCESS # 22:09:42 INFO - Running post-action listener: _resource_record_post_action 22:09:42 INFO - [mozharness: 2016-08-15 05:09:42.591256Z] Finished run-tests step (success) 22:09:42 INFO - Running post-run listener: _resource_record_post_run 22:09:42 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327839744; Read time: 28; Write time: 204016 22:09:42 INFO - TinderboxPrint: CPU usage
13.3% 22:09:42 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 22:09:42 INFO - TinderboxPrint: I/O write bytes / time
327,839,744 / 204,016 22:09:42 INFO - TinderboxPrint: CPU idle
8,218.1 (86.7%) 22:09:42 INFO - TinderboxPrint: CPU user
1,205.1 (12.7%) 22:09:42 INFO - TinderboxPrint: Swap in / out
0 / 0 22:09:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77074432; Read time: 0; Write time: 67356 22:09:42 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248213504; Read time: 12; Write time: 136416 22:09:43 INFO - Running post-run listener: _upload_blobber_files 22:09:43 INFO - Blob upload gear active. 22:09:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:09:43 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 22:09:43 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:09:43 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:09:43 INFO - (blobuploader) - INFO - Open directory for files ... 22:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:46 INFO - (blobuploader) - INFO - Done attempting. 22:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:48 INFO - (blobuploader) - INFO - Done attempting. 22:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:49 INFO - (blobuploader) - INFO - Done attempting. 22:09:49 INFO - (blobuploader) - INFO - Iteration through files over. 22:09:49 INFO - Return code: 0 22:09:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:09:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:09:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86540e87e740bf658a00baf349b659eee008535d08b763fc7346eea1671725357ebe09b28ba2d3177dee6ed8de86057c9cf5d322c1c27c984836e4d09d75d12e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d8c12757826bff3e8a48f082de2011d182f669dc8611b7d50b9a81d39ae8ce1b405d82dc319df499f09a32e0df954b5e2e33b6d0befd75d2d25c37e6146004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07c6395c1516fff68e7e09279827682215ca264ae5b706a49e465d3abe96ba8ce2f489e6ed727b264dd9daaaf58040f9b3f7df9dbac325d77c90f70955323625"} 22:09:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:09:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:09:49 INFO - Contents: 22:09:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86540e87e740bf658a00baf349b659eee008535d08b763fc7346eea1671725357ebe09b28ba2d3177dee6ed8de86057c9cf5d322c1c27c984836e4d09d75d12e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d8c12757826bff3e8a48f082de2011d182f669dc8611b7d50b9a81d39ae8ce1b405d82dc319df499f09a32e0df954b5e2e33b6d0befd75d2d25c37e6146004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07c6395c1516fff68e7e09279827682215ca264ae5b706a49e465d3abe96ba8ce2f489e6ed727b264dd9daaaf58040f9b3f7df9dbac325d77c90f70955323625"} 22:09:49 INFO - Running post-run listener: copy_logs_to_upload_dir 22:09:49 INFO - Copying logs to upload dir... 22:09:49 INFO - mkdir: /builds/slave/test/build/upload/logs 22:09:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.314635 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-14 22:09:49.400116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-14 22:09:49.403501) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 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-Aurora/sha512/86540e87e740bf658a00baf349b659eee008535d08b763fc7346eea1671725357ebe09b28ba2d3177dee6ed8de86057c9cf5d322c1c27c984836e4d09d75d12e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d8c12757826bff3e8a48f082de2011d182f669dc8611b7d50b9a81d39ae8ce1b405d82dc319df499f09a32e0df954b5e2e33b6d0befd75d2d25c37e6146004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07c6395c1516fff68e7e09279827682215ca264ae5b706a49e465d3abe96ba8ce2f489e6ed727b264dd9daaaf58040f9b3f7df9dbac325d77c90f70955323625"} build_url:https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/efpiLEEwRa-8z3YaDagAlg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86540e87e740bf658a00baf349b659eee008535d08b763fc7346eea1671725357ebe09b28ba2d3177dee6ed8de86057c9cf5d322c1c27c984836e4d09d75d12e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d8c12757826bff3e8a48f082de2011d182f669dc8611b7d50b9a81d39ae8ce1b405d82dc319df499f09a32e0df954b5e2e33b6d0befd75d2d25c37e6146004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07c6395c1516fff68e7e09279827682215ca264ae5b706a49e465d3abe96ba8ce2f489e6ed727b264dd9daaaf58040f9b3f7df9dbac325d77c90f70955323625"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-14 22:09:49.427983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 22:09:49.428277) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1471235845.595722-1515198643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-14 22:09:49.513976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-14 22:09:49.514295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-14 22:09:49.514577) ========= ========= Total master_lag: 0.17 =========