builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1471602734.99 results: success (0) buildid: 20160819004015 builduid: 71500e51c7be4040aa3163130cd4ed8c revision: 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:14.993796) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:14.994156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:14.994419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.011377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.011644) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 03:32:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.51M=0.002s 2016-08-19 03:32:15 (7.51 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124019 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.154061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.154339) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022626 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.205392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.205694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 --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 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 --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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 03:32:15,527 truncating revision to first 12 chars 2016-08-19 03:32:15,527 Setting DEBUG logging. 2016-08-19 03:32:15,527 attempt 1/10 2016-08-19 03:32:15,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b2e1f4c1af3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 03:32:15,900 unpacking tar archive at: mozilla-aurora-0b2e1f4c1af3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.921084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.921347) ========= script_repo_revision: 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.921717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.921974) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 03:32:15.933059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-08-19 03:32:15.933319) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:16 INFO - MultiFileLogger online at 20160819 03:32:16 in /builds/slave/test 03:32:16 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 03:32:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:16 INFO - {'append_to_log': False, 03:32:16 INFO - 'base_work_dir': '/builds/slave/test', 03:32:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:16 INFO - 'branch': 'Mozilla-Aurora', 03:32:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:16 INFO - 'config_files': ('talos/linux_config.py',), 03:32:16 INFO - 'default_actions': ('clobber', 03:32:16 INFO - 'read-buildbot-config', 03:32:16 INFO - 'download-and-extract', 03:32:16 INFO - 'populate-webroot', 03:32:16 INFO - 'create-virtualenv', 03:32:16 INFO - 'install', 03:32:16 INFO - 'run-tests'), 03:32:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:16 INFO - 'download_minidump_stackwalk': True, 03:32:16 INFO - 'download_symbols': 'ondemand', 03:32:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:16 INFO - 'installer_path': 'installer.exe', 03:32:16 INFO - 'log_level': 'info', 03:32:16 INFO - 'log_name': 'talos', 03:32:16 INFO - 'log_to_console': True, 03:32:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:16 INFO - 'opt_config_files': (), 03:32:16 INFO - 'pip_index': False, 03:32:16 INFO - 'sps_profile': False, 03:32:16 INFO - 'sps_profile_interval': 0, 03:32:16 INFO - 'suite': 'dromaeojs-e10s', 03:32:16 INFO - 'system_bits': '32', 03:32:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:16 INFO - 'title': 'talos-linux64-ix-019', 03:32:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:16 INFO - 'use_talos_json': True, 03:32:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:16 INFO - 'work_dir': 'build'} 03:32:16 INFO - [mozharness: 2016-08-19 10:32:16.346008Z] Running clobber step. 03:32:16 INFO - Running pre-action listener: _resource_record_pre_action 03:32:16 INFO - Running main action method: clobber 03:32:16 INFO - rmtree: /builds/slave/test/build 03:32:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:16 INFO - Running post-action listener: _resource_record_post_action 03:32:16 INFO - [mozharness: 2016-08-19 10:32:16.801014Z] Finished clobber step (success) 03:32:16 INFO - [mozharness: 2016-08-19 10:32:16.801114Z] Running read-buildbot-config step. 03:32:16 INFO - Running pre-action listener: _resource_record_pre_action 03:32:16 INFO - Running main action method: read_buildbot_config 03:32:16 INFO - Using buildbot properties: 03:32:16 INFO - { 03:32:16 INFO - "project": "", 03:32:16 INFO - "product": "firefox", 03:32:16 INFO - "script_repo_revision": "production", 03:32:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:16 INFO - "repository": "", 03:32:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:16 INFO - "buildid": "20160819004015", 03:32:16 INFO - "stage_platform": "linux64-pgo", 03:32:16 INFO - "basedir": "/builds/slave/test", 03:32:16 INFO - "nightly_build": "True", 03:32:16 INFO - "buildnumber": 507, 03:32:16 INFO - "slavename": "talos-linux64-ix-019", 03:32:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:32:16 INFO - "platform": "ubuntu64_hw", 03:32:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:16 INFO - "branch": "mozilla-aurora", 03:32:16 INFO - "repo_path": "releases/mozilla-aurora", 03:32:16 INFO - "revision": "0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0", 03:32:16 INFO - "pgo_build": "True", 03:32:16 INFO - "builduid": "71500e51c7be4040aa3163130cd4ed8c", 03:32:16 INFO - "slavebuilddir": "test" 03:32:16 INFO - } 03:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:32:16 INFO - Running post-action listener: _resource_record_post_action 03:32:16 INFO - [mozharness: 2016-08-19 10:32:16.803655Z] Finished read-buildbot-config step (success) 03:32:16 INFO - [mozharness: 2016-08-19 10:32:16.803744Z] Running download-and-extract step. 03:32:16 INFO - Running pre-action listener: _resource_record_pre_action 03:32:16 INFO - Running main action method: download_and_extract 03:32:16 INFO - mkdir: /builds/slave/test/build/tests 03:32:16 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')]} 03:32:16 INFO - https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:32:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:32:16 INFO - retry: Failed, sleeping 30 seconds before retrying 03:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:32:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:32:46 INFO - retry: Failed, sleeping 60 seconds before retrying 03:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:33:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:33:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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! 03:33:46 INFO - Caught exception: HTTP Error 404: Not Found 03:33:46 INFO - Caught exception: HTTP Error 404: Not Found 03:33:46 INFO - Caught exception: HTTP Error 404: Not Found 03:33:46 INFO - trying https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:46 INFO - Downloading https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:33:47 INFO - Downloaded 1361 bytes. 03:33:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:47 INFO - Using the following test package requirements: 03:33:47 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:47 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:47 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:33:47 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'jsshell-linux-x86_64.zip'], 03:33:47 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:47 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:47 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:33:47 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:33:47 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:47 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:47 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:47 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:47 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')]} 03:33:47 INFO - https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:33:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:33:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:33:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:33:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:33:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:33:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:34:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:34:17 INFO - retry: Failed, sleeping 60 seconds before retrying 03:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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! 03:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - Caught exception: HTTP Error 404: Not Found 03:35:17 INFO - trying https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:18 INFO - Downloaded 21766596 bytes. 03:35:18 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'] 03:35:18 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 03:35:19 INFO - Return code: 0 03:35:19 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 03:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:19 INFO - https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:35:19 INFO - retry: Failed, sleeping 30 seconds before retrying 03:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:35:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:35:49 INFO - retry: Failed, sleeping 60 seconds before retrying 03:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:36:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:36:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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! 03:36:49 INFO - Caught exception: HTTP Error 404: Not Found 03:36:49 INFO - Caught exception: HTTP Error 404: Not Found 03:36:49 INFO - Caught exception: HTTP Error 404: Not Found 03:36:49 INFO - trying https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:49 INFO - Downloading https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:36:52 INFO - Downloaded 21766596 bytes. 03:36:52 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'] 03:36:52 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 03:36:53 INFO - Return code: 0 03:36: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')]} 03:36:53 INFO - https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:36:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:36:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:36:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:36:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:36:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:36:53 INFO - retry: Failed, sleeping 30 seconds before retrying 03:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:37:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:37:23 INFO - retry: Failed, sleeping 60 seconds before retrying 03:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:38:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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! 03:38:23 INFO - Caught exception: HTTP Error 404: Not Found 03:38:23 INFO - Caught exception: HTTP Error 404: Not Found 03:38:23 INFO - Caught exception: HTTP Error 404: Not Found 03:38:23 INFO - trying https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:23 INFO - Downloading https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:24 INFO - Downloaded 14413723 bytes. 03:38:24 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'] 03:38:24 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 03:38:24 INFO - Return code: 0 03:38: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')]} 03:38:24 INFO - https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:38:24 INFO - retry: Failed, sleeping 30 seconds before retrying 03:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:38:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:38:54 INFO - retry: Failed, sleeping 60 seconds before retrying 03:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:39:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:39:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bf-8i5L8SEKcBddaSxwSuw/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! 03:39:54 INFO - Caught exception: HTTP Error 404: Not Found 03:39:54 INFO - Caught exception: HTTP Error 404: Not Found 03:39:54 INFO - Caught exception: HTTP Error 404: Not Found 03:39:54 INFO - trying https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:54 INFO - Downloading https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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 03:39:56 INFO - Downloaded 63745839 bytes. 03:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:56 INFO - mkdir: /builds/slave/test/properties 03:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:56 INFO - Contents: 03:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:56 INFO - Running post-action listener: _resource_record_post_action 03:39:56 INFO - Running post-action listener: set_extra_try_arguments 03:39:56 INFO - [mozharness: 2016-08-19 10:39:56.636048Z] Finished download-and-extract step (success) 03:39:56 INFO - [mozharness: 2016-08-19 10:39:56.636280Z] Running populate-webroot step. 03:39:56 INFO - Running pre-action listener: _resource_record_pre_action 03:39:56 INFO - Running main action method: populate_webroot 03:39:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:56 INFO - '--tppagecycles', 03:39:56 INFO - '7'], 03:39:56 INFO - 'tests': ['tsvgm']}}, 03:39:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['damp', 'tps']}, 03:39:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'tests': ['damp', 'tps']}, 03:39:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['dromaeo_dom']}, 03:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['basic_compositor_video']}, 03:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['a11yr', 03:39:56 INFO - 'ts_paint', 03:39:56 INFO - 'tpaint', 03:39:56 INFO - 'sessionrestore', 03:39:56 INFO - 'sessionrestore_no_auto_restore', 03:39:56 INFO - 'tabpaint']}, 03:39:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['tsvgx', 03:39:56 INFO - 'tsvgr_opacity', 03:39:56 INFO - 'tart', 03:39:56 INFO - 'tscrollx', 03:39:56 INFO - 'cart']}, 03:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:56 INFO - 'tsvgr_opacity', 03:39:56 INFO - 'tart', 03:39:56 INFO - 'tscrollx', 03:39:56 INFO - 'cart']}, 03:39:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'talos_options': ['--disable-e10s'], 03:39:56 INFO - 'tests': ['tp5o']}, 03:39:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'tests': ['tp5o']}, 03:39:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'talos_options': ['--disable-e10s', 03:39:56 INFO - '--xperf_path', 03:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:56 INFO - 'tests': ['tp5n']}, 03:39:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:56 INFO - 'talos_options': ['--xperf_path', 03:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:56 INFO - 'tests': ['tp5n']}}, 03:39:56 INFO - 'talos.zip': {'path': '', 03:39:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:56 INFO - Running post-action listener: _resource_record_post_action 03:39:56 INFO - [mozharness: 2016-08-19 10:39:56.652893Z] Finished populate-webroot step (success) 03:39:56 INFO - [mozharness: 2016-08-19 10:39:56.652982Z] Running create-virtualenv step. 03:39:56 INFO - Running pre-action listener: _resource_record_pre_action 03:39:56 INFO - Running main action method: create_virtualenv 03:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:56 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 03:39:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:56 INFO - Using real prefix '/usr' 03:39:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:59 INFO - Installing pip.................done. 03:39:59 INFO - Return code: 0 03:39:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:59 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:39:59 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 03:39:59 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 03:39:59 INFO - Using env: {'DISPLAY': ':0', 03:39:59 INFO - 'HOME': '/home/cltbld', 03:39:59 INFO - 'LANG': 'en_US.UTF-8', 03:39:59 INFO - 'LANGUAGE': 'en_US:en', 03:39:59 INFO - 'LOGNAME': 'cltbld', 03:39:59 INFO - 'MAIL': '/var/mail/cltbld', 03:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:59 INFO - 'MOZ_NO_REMOTE': '1', 03:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:59 INFO - 'NO_EM_RESTART': '1', 03:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:59 INFO - 'PWD': '/builds/slave/test', 03:39:59 INFO - 'SHELL': '/bin/bash', 03:39:59 INFO - 'SHLVL': '1', 03:39:59 INFO - 'TERM': 'linux', 03:39:59 INFO - 'TMOUT': '86400', 03:39:59 INFO - 'USER': 'cltbld', 03:39:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:59 INFO - '_': '/tools/buildbot/bin/python'} 03:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:59 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 03:39:59 INFO - Cleaning up... 03:39:59 INFO - Return code: 0 03:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:59 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:39:59 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 03:39:59 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 03:39:59 INFO - Using env: {'DISPLAY': ':0', 03:39:59 INFO - 'HOME': '/home/cltbld', 03:39:59 INFO - 'LANG': 'en_US.UTF-8', 03:39:59 INFO - 'LANGUAGE': 'en_US:en', 03:39:59 INFO - 'LOGNAME': 'cltbld', 03:39:59 INFO - 'MAIL': '/var/mail/cltbld', 03:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:59 INFO - 'MOZ_NO_REMOTE': '1', 03:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:59 INFO - 'NO_EM_RESTART': '1', 03:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:59 INFO - 'PWD': '/builds/slave/test', 03:39:59 INFO - 'SHELL': '/bin/bash', 03:39:59 INFO - 'SHLVL': '1', 03:39:59 INFO - 'TERM': 'linux', 03:39:59 INFO - 'TMOUT': '86400', 03:39:59 INFO - 'USER': 'cltbld', 03:39:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:59 INFO - '_': '/tools/buildbot/bin/python'} 03:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:59 INFO - Downloading/unpacking psutil>=3.1.1 03:39:59 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 03:39:59 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 03:39:59 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 03:39:59 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 03:39:59 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 03:39:59 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 03:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:01 INFO - Installing collected packages: psutil 03:40:01 INFO - Running setup.py install for psutil 03:40:01 INFO - building 'psutil._psutil_linux' extension 03:40:01 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 03:40:01 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 03:40:01 INFO - building 'psutil._psutil_posix' extension 03:40:01 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 03:40:02 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 03:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:02 INFO - Successfully installed psutil 03:40:02 INFO - Cleaning up... 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:02 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')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 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')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:02 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 03:40:02 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 03:40:02 INFO - Using env: {'DISPLAY': ':0', 03:40:02 INFO - 'HOME': '/home/cltbld', 03:40:02 INFO - 'LANG': 'en_US.UTF-8', 03:40:02 INFO - 'LANGUAGE': 'en_US:en', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MAIL': '/var/mail/cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SHLVL': '1', 03:40:02 INFO - 'TERM': 'linux', 03:40:02 INFO - 'TMOUT': '86400', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - '_': '/tools/buildbot/bin/python'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:02 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 03:40:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:04 INFO - Installing collected packages: mozsystemmonitor 03:40:04 INFO - Running setup.py install for mozsystemmonitor 03:40:04 INFO - Successfully installed mozsystemmonitor 03:40:04 INFO - Cleaning up... 03:40:04 INFO - Return code: 0 03:40:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:04 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')]} 03:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:04 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')]} 03:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:04 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:04 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 03:40:04 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 03:40:04 INFO - Using env: {'DISPLAY': ':0', 03:40:04 INFO - 'HOME': '/home/cltbld', 03:40:04 INFO - 'LANG': 'en_US.UTF-8', 03:40:04 INFO - 'LANGUAGE': 'en_US:en', 03:40:04 INFO - 'LOGNAME': 'cltbld', 03:40:04 INFO - 'MAIL': '/var/mail/cltbld', 03:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:04 INFO - 'MOZ_NO_REMOTE': '1', 03:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:04 INFO - 'NO_EM_RESTART': '1', 03:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:04 INFO - 'PWD': '/builds/slave/test', 03:40:04 INFO - 'SHELL': '/bin/bash', 03:40:04 INFO - 'SHLVL': '1', 03:40:04 INFO - 'TERM': 'linux', 03:40:04 INFO - 'TMOUT': '86400', 03:40:04 INFO - 'USER': 'cltbld', 03:40:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:04 INFO - '_': '/tools/buildbot/bin/python'} 03:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:04 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:04 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 03:40:04 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 03:40:04 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 03:40:04 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 03:40:04 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 03:40:04 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 03:40:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:06 INFO - warning: no files found matching '*.txt' 03:40:06 INFO - no previously-included directories found matching 'build' 03:40:06 INFO - no previously-included directories found matching 'dist' 03:40:06 INFO - no previously-included directories found matching '.git*' 03:40:06 INFO - Installing collected packages: jsonschema, functools32 03:40:06 INFO - Running setup.py install for functools32 03:40:06 INFO - warning: no files found matching '*.txt' 03:40:06 INFO - no previously-included directories found matching 'build' 03:40:06 INFO - no previously-included directories found matching 'dist' 03:40:06 INFO - no previously-included directories found matching '.git*' 03:40:07 INFO - Successfully installed jsonschema functools32 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:07 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 03:40:07 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 03:40:07 INFO - Using env: {'DISPLAY': ':0', 03:40:07 INFO - 'HOME': '/home/cltbld', 03:40:07 INFO - 'LANG': 'en_US.UTF-8', 03:40:07 INFO - 'LANGUAGE': 'en_US:en', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MAIL': '/var/mail/cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SHLVL': '1', 03:40:07 INFO - 'TERM': 'linux', 03:40:07 INFO - 'TMOUT': '86400', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - '_': '/tools/buildbot/bin/python'} 03:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:07 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 03:40:07 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 03:40:07 INFO - Using env: {'DISPLAY': ':0', 03:40:07 INFO - 'HOME': '/home/cltbld', 03:40:07 INFO - 'LANG': 'en_US.UTF-8', 03:40:07 INFO - 'LANGUAGE': 'en_US:en', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MAIL': '/var/mail/cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SHLVL': '1', 03:40:07 INFO - 'TERM': 'linux', 03:40:07 INFO - 'TMOUT': '86400', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - '_': '/tools/buildbot/bin/python'} 03:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:07 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 03:40:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:09 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 03:40:09 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 03:40:09 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 03:40:09 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 03:40:09 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 03:40:09 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 03:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:10 INFO - Downloading docopt-0.6.1.tar.gz 03:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:10 INFO - Running setup.py install for blobuploader 03:40:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:10 INFO - Running setup.py install for requests 03:40:10 INFO - Running setup.py install for docopt 03:40:10 INFO - Successfully installed blobuploader requests docopt 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:10 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 03:40:10 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 03:40:10 INFO - Using env: {'DISPLAY': ':0', 03:40:10 INFO - 'HOME': '/home/cltbld', 03:40:10 INFO - 'LANG': 'en_US.UTF-8', 03:40:10 INFO - 'LANGUAGE': 'en_US:en', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MAIL': '/var/mail/cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SHLVL': '1', 03:40:10 INFO - 'TERM': 'linux', 03:40:10 INFO - 'TMOUT': '86400', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - '_': '/tools/buildbot/bin/python'} 03:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:11 INFO - Running setup.py (path:/tmp/pip-dwYLwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:11 INFO - Running setup.py (path:/tmp/pip-agqDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:11 INFO - Running setup.py (path:/tmp/pip-oPqLJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:11 INFO - Running setup.py (path:/tmp/pip-CxGTbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:11 INFO - Running setup.py (path:/tmp/pip-xn_Am_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:11 INFO - Running setup.py (path:/tmp/pip-pUFD8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:11 INFO - Running setup.py (path:/tmp/pip-YkygcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:11 INFO - Running setup.py (path:/tmp/pip-APhz1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:11 INFO - Running setup.py (path:/tmp/pip-Jvr6RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:11 INFO - Running setup.py (path:/tmp/pip-ERuQQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:11 INFO - Running setup.py (path:/tmp/pip-P0GCOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:11 INFO - Running setup.py (path:/tmp/pip-_Rj1hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:12 INFO - Running setup.py (path:/tmp/pip-76G0lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:12 INFO - Running setup.py (path:/tmp/pip-bfadwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:12 INFO - Running setup.py (path:/tmp/pip-bQGWl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:12 INFO - Running setup.py (path:/tmp/pip-pzLaq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:12 INFO - Running setup.py (path:/tmp/pip-xjJhXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:12 INFO - Running setup.py install for manifestparser 03:40:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozcrash 03:40:12 INFO - Running setup.py install for mozdebug 03:40:12 INFO - Running setup.py install for mozdevice 03:40:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Running setup.py install for mozfile 03:40:12 INFO - Running setup.py install for mozhttpd 03:40:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozinfo 03:40:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozInstall 03:40:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozleak 03:40:13 INFO - Running setup.py install for mozlog 03:40:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for moznetwork 03:40:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozprocess 03:40:13 INFO - Running setup.py install for mozprofile 03:40:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozrunner 03:40:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Running setup.py install for mozscreenshot 03:40:13 INFO - Running setup.py install for moztest 03:40:14 INFO - Running setup.py install for mozversion 03:40:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:14 INFO - Cleaning up... 03:40:14 INFO - Return code: 0 03:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:14 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')]} 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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')]} 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:14 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 03:40:14 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 03:40:14 INFO - Using env: {'DISPLAY': ':0', 03:40:14 INFO - 'HOME': '/home/cltbld', 03:40:14 INFO - 'LANG': 'en_US.UTF-8', 03:40:14 INFO - 'LANGUAGE': 'en_US:en', 03:40:14 INFO - 'LOGNAME': 'cltbld', 03:40:14 INFO - 'MAIL': '/var/mail/cltbld', 03:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:14 INFO - 'MOZ_NO_REMOTE': '1', 03:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:14 INFO - 'NO_EM_RESTART': '1', 03:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:14 INFO - 'PWD': '/builds/slave/test', 03:40:14 INFO - 'SHELL': '/bin/bash', 03:40:14 INFO - 'SHLVL': '1', 03:40:14 INFO - 'TERM': 'linux', 03:40:14 INFO - 'TMOUT': '86400', 03:40:14 INFO - 'USER': 'cltbld', 03:40:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:14 INFO - '_': '/tools/buildbot/bin/python'} 03:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:14 INFO - Running setup.py (path:/tmp/pip-IAJaSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:14 INFO - Running setup.py (path:/tmp/pip-lqYjeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:14 INFO - Running setup.py (path:/tmp/pip-2DfmOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:14 INFO - Running setup.py (path:/tmp/pip-S4OWUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:14 INFO - Running setup.py (path:/tmp/pip-Jgpf77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:14 INFO - Running setup.py (path:/tmp/pip-SJNKLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:14 INFO - Running setup.py (path:/tmp/pip-BP3CPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:14 INFO - Running setup.py (path:/tmp/pip-0TwlKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:15 INFO - Running setup.py (path:/tmp/pip-g6BPY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:15 INFO - Running setup.py (path:/tmp/pip-I1hL4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:15 INFO - Running setup.py (path:/tmp/pip-963yiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:15 INFO - Running setup.py (path:/tmp/pip-lO4qg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:15 INFO - Running setup.py (path:/tmp/pip-8UZAjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:15 INFO - Running setup.py (path:/tmp/pip-Ztod0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:15 INFO - Running setup.py (path:/tmp/pip-Lfs0x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:15 INFO - Running setup.py (path:/tmp/pip-fCUH2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:15 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)) 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:15 INFO - Running setup.py (path:/tmp/pip-lPRpdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 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)) 03:40:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:15 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 03:40:15 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 03:40:15 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 03:40:15 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 03:40:15 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 03:40:15 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 03:40:17 INFO - Downloading blessings-1.6.tar.gz 03:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:17 INFO - Installing collected packages: blessings 03:40:17 INFO - Running setup.py install for blessings 03:40:17 INFO - Successfully installed blessings 03:40:17 INFO - Cleaning up... 03:40:17 INFO - Return code: 0 03:40:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:18 INFO - Reading from file tmpfile_stdout 03:40:18 INFO - Current package versions: 03:40:18 INFO - argparse == 1.2.1 03:40:18 INFO - blessings == 1.6 03:40:18 INFO - blobuploader == 1.2.4 03:40:18 INFO - docopt == 0.6.1 03:40:18 INFO - functools32 == 3.2.3-2 03:40:18 INFO - jsonschema == 2.5.1 03:40:18 INFO - manifestparser == 1.1 03:40:18 INFO - mozInstall == 1.12 03:40:18 INFO - mozcrash == 0.17 03:40:18 INFO - mozdebug == 0.1 03:40:18 INFO - mozdevice == 0.48 03:40:18 INFO - mozfile == 1.2 03:40:18 INFO - mozhttpd == 0.7 03:40:18 INFO - mozinfo == 0.9 03:40:18 INFO - mozleak == 0.1 03:40:18 INFO - mozlog == 3.3 03:40:18 INFO - moznetwork == 0.27 03:40:18 INFO - mozprocess == 0.23 03:40:18 INFO - mozprofile == 0.28 03:40:18 INFO - mozrunner == 6.12 03:40:18 INFO - mozscreenshot == 0.1 03:40:18 INFO - mozsystemmonitor == 0.3 03:40:18 INFO - moztest == 0.7 03:40:18 INFO - mozversion == 1.4 03:40:18 INFO - psutil == 3.1.1 03:40:18 INFO - requests == 1.2.3 03:40:18 INFO - wsgiref == 0.1.2 03:40:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:18 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')]} 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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')]} 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:18 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 03:40:18 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 03:40:18 INFO - Using env: {'DISPLAY': ':0', 03:40:18 INFO - 'HOME': '/home/cltbld', 03:40:18 INFO - 'LANG': 'en_US.UTF-8', 03:40:18 INFO - 'LANGUAGE': 'en_US:en', 03:40:18 INFO - 'LOGNAME': 'cltbld', 03:40:18 INFO - 'MAIL': '/var/mail/cltbld', 03:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:18 INFO - 'MOZ_NO_REMOTE': '1', 03:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:18 INFO - 'NO_EM_RESTART': '1', 03:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:18 INFO - 'PWD': '/builds/slave/test', 03:40:18 INFO - 'SHELL': '/bin/bash', 03:40:18 INFO - 'SHLVL': '1', 03:40:18 INFO - 'TERM': 'linux', 03:40:18 INFO - 'TMOUT': '86400', 03:40:18 INFO - 'USER': 'cltbld', 03:40:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:18 INFO - '_': '/tools/buildbot/bin/python'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 INFO - Cleaning up... 03:40:18 INFO - Return code: 0 03:40:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:18 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')]} 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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')]} 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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 0xc65030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe94400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', '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 03:40:18 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 03:40:18 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 03:40:18 INFO - Using env: {'DISPLAY': ':0', 03:40:18 INFO - 'HOME': '/home/cltbld', 03:40:18 INFO - 'LANG': 'en_US.UTF-8', 03:40:18 INFO - 'LANGUAGE': 'en_US:en', 03:40:18 INFO - 'LOGNAME': 'cltbld', 03:40:18 INFO - 'MAIL': '/var/mail/cltbld', 03:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:18 INFO - 'MOZ_NO_REMOTE': '1', 03:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:18 INFO - 'NO_EM_RESTART': '1', 03:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:18 INFO - 'PWD': '/builds/slave/test', 03:40:18 INFO - 'SHELL': '/bin/bash', 03:40:18 INFO - 'SHLVL': '1', 03:40:18 INFO - 'TERM': 'linux', 03:40:18 INFO - 'TMOUT': '86400', 03:40:18 INFO - 'USER': 'cltbld', 03:40:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:18 INFO - '_': '/tools/buildbot/bin/python'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:18 INFO - Cleaning up... 03:40:18 INFO - Return code: 0 03:40:18 INFO - Running post-action listener: _resource_record_post_action 03:40:18 INFO - Running post-action listener: _start_resource_monitoring 03:40:18 INFO - Starting resource monitoring. 03:40:18 INFO - [mozharness: 2016-08-19 10:40:18.496803Z] Finished create-virtualenv step (success) 03:40:18 INFO - [mozharness: 2016-08-19 10:40:18.497410Z] Running install step. 03:40:18 INFO - Running pre-action listener: _resource_record_pre_action 03:40:18 INFO - Running main action method: install 03:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:18 INFO - Reading from file tmpfile_stdout 03:40:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:18 INFO - Reading from file tmpfile_stdout 03:40:18 INFO - Output received: 03:40:18 INFO - Usage: mozinstall [options] installer 03:40:18 INFO - Options: 03:40:18 INFO - -h, --help show this help message and exit 03:40:18 INFO - -d DEST, --destination=DEST 03:40:18 INFO - Directory to install application into. [default: 03:40:18 INFO - "/builds/slave/test"] 03:40:18 INFO - --app=APP Application being installed. [default: firefox] 03:40:18 INFO - mkdir: /builds/slave/test/build/application 03:40:18 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'] 03:40:18 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 03:40:34 INFO - Reading from file tmpfile_stdout 03:40:34 INFO - Output received: 03:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:34 INFO - Running post-action listener: _resource_record_post_action 03:40:34 INFO - [mozharness: 2016-08-19 10:40:34.763326Z] Finished install step (success) 03:40:34 INFO - [mozharness: 2016-08-19 10:40:34.763599Z] Running run-tests step. 03:40:34 INFO - Running pre-action listener: _resource_record_pre_action 03:40:34 INFO - Running main action method: run_tests 03:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:34 INFO - Python 2.7.3 03:40:34 INFO - Return code: 0 03:40:34 INFO - grabbing minidump binary from tooltool 03:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:34 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 0xf23570>, '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 0xf24470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf24900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:34 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 03:40:34 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 03:40:34 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 03:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:34 INFO - Return code: 0 03:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:34 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/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:40:34 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/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 03:40:34 INFO - Using env: {'DISPLAY': ':0', 03:40:34 INFO - 'HOME': '/home/cltbld', 03:40:34 INFO - 'LANG': 'en_US.UTF-8', 03:40:34 INFO - 'LANGUAGE': 'en_US:en', 03:40:34 INFO - 'LOGNAME': 'cltbld', 03:40:34 INFO - 'MAIL': '/var/mail/cltbld', 03:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:34 INFO - 'MOZ_NO_REMOTE': '1', 03:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:34 INFO - 'NO_EM_RESTART': '1', 03:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:34 INFO - 'PWD': '/builds/slave/test', 03:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:34 INFO - 'SHELL': '/bin/bash', 03:40:34 INFO - 'SHLVL': '1', 03:40:34 INFO - 'TERM': 'linux', 03:40:34 INFO - 'TMOUT': '86400', 03:40:34 INFO - 'USER': 'cltbld', 03:40:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534', 03:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:34 INFO - '_': '/tools/buildbot/bin/python'} 03:40:34 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/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:40:35 INFO - mozversion application_buildid: 20160819004015 03:40:35 INFO - mozversion application_changeset: 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 03:40:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:35 INFO - mozversion application_name: Firefox 03:40:35 INFO - mozversion application_remotingname: firefox-dev 03:40:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:35 INFO - mozversion application_vendor: Mozilla 03:40:35 INFO - mozversion application_version: 50.0a2 03:40:35 INFO - mozversion platform_buildid: 20160819004015 03:40:35 INFO - mozversion platform_changeset: 0b2e1f4c1af39800b1e33d2f2e5e88f9aee5e8a0 03:40:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:35 INFO - mozversion platform_version: 50.0a2 03:40:35 INFO - using testdate: 1471603235 03:40:35 INFO - actual date: 1471603235 03:40:35 INFO - starting webserver on 'localhost:34129' 03:40:35 INFO - SUITE-START | Running 2 tests 03:40:35 INFO - TEST-START | dromaeo_css 03:40:35 INFO - operating with platform_type : linux_ 03:40:35 INFO - Initialising browser for dromaeo_css test... 03:40:35 INFO - TEST-INFO | started process 12828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqTuTAA/profile http://localhost:34129/getInfo.html) 03:40:39 INFO - PROCESS | 12828 | __metrics Screen width/height:1600/1200 03:40:39 INFO - PROCESS | 12828 | colorDepth:24 03:40:39 INFO - PROCESS | 12828 | Browser inner width/height: 1024/697 03:40:39 INFO - PROCESS | 12828 | __metrics 03:40:40 ERROR - PROCESS | 12828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:40:41 INFO - TEST-INFO | 12828: exit 0 03:40:41 INFO - Browser initialized. 03:40:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:41 INFO - TEST-INFO | started process 12954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqTuTAA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:53 INFO - PROCESS | 12954 | RSS: Main: 152817664 03:40:53 INFO - PROCESS | 12954 | 03:41:42 INFO - PROCESS | 12954 | 1471603302861 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] 03:43:51 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34129/tests/dromaeo/cssquery-ext.html) 03:43:52 INFO - PROCESS | 12954 | RSS: Main: 157855744 03:43:52 INFO - PROCESS | 12954 | 03:46:54 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-ext.html (next: http://localhost:34129/tests/dromaeo/cssquery-jquery.html) 03:46:55 INFO - PROCESS | 12954 | RSS: Main: 154136576 03:46:55 INFO - PROCESS | 12954 | 03:49:56 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34129/tests/dromaeo/cssquery-mootools.html) 03:49:57 INFO - PROCESS | 12954 | RSS: Main: 154300416 03:49:57 INFO - PROCESS | 12954 | 03:52:59 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34129/tests/dromaeo/cssquery-prototype.html) 03:52:59 INFO - PROCESS | 12954 | RSS: Main: 153194496 03:52:59 INFO - PROCESS | 12954 | 03:56:02 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34129/tests/dromaeo/cssquery-yui.html) 03:56:03 INFO - PROCESS | 12954 | RSS: Main: 155160576 03:56:03 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | Cycle 1(1): loaded http://localhost:34129/tests/dromaeo/cssquery-yui.html (next: http://localhost:34129/tests/dromaeo/cssquery-dojo.html) 03:59:05 INFO - PROCESS | 12954 | RSS: Main: 156307456 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | __start_tp_report 03:59:05 INFO - PROCESS | 12954 | _x_x_mozilla_page_load 03:59:05 INFO - PROCESS | 12954 | _x_x_mozilla_page_load_details 03:59:05 INFO - PROCESS | 12954 | |i|pagename|runs| 03:59:05 INFO - PROCESS | 12954 | |0;dojo.html;3293.4071867063926;3311.2417406243912;3316.5688460500132;3335.2328964338185;3349.0790032740993;5704.600677952545;5744.4829965303115;5769.076947688371;5782.306123265214;5796.971015144918;5644.238027866237;5704.515116215127;5711.114777209529;5743.856403589913;5744.937186620478;5167.844964651057;5217.243499692542;5248.0553500369915;5271.604629652772;5276.472352764731;5141.357330333708;5155.871103222412;5196.92204616931;5216.035033518811;5248.895022099556;5276.15581506959;5279.313689220396;5283.735813209343;5336.839894803162;5350.170723537838;5327.307450031491;5331.600129990247;5334.03987282289;5341.0653135701095;5344.465553444663;4987.576056035241;5115.641905066647;5228.738563071869;5240.475952404767;5312.60155488336;5690.829275121753;5750;5764.250647415851;5770.826875193751;5787.623804452697;6150.077488376734;6173.567850250484;6195.349488303754;6209;6209.627422354628;5919.1417244499735;6095.9695201524155;6185.536084793614;6262.154609127755;6279.49764018882;5692.544596432317;5782.884342313214;5782.942170578324;5795.1017592273265;5805.216295800055;6300.779472718433;6324.9051264231075;6327.525435592349;6345.428911397904;6360.650164241011;5796.362400135981;5918.822435326947;5985.072313791369;6070.757169713251;6097.115918191837;6013.819585412444;6116.204893363834;6116.602420842631;6137.263528376623;6140.600860944024;6073.1497590337385;6116.021436570128;6126.23422072241;6130.264368275835;6154.261488621394;5901.409859014064;6099.725512351954;6119.969400152971;6136.048912418582;6144.754209831646;4687.156311863897;4748.240281554935;4767.4517430495935;4776.522347765265;4778;4212.304969679968;4226.070264541796;4231.661467082626;4250.362445633118;4262.4458820353775;5750.051241545182;5849.590528662953;5992.34084250732;5994.580379373489;6018.127371531104;6143.354947730513;6179.104029915727;6206.875862482725;6208.0998255253635;6242.938700420848;5949.762009519571;5949.940500595025;5957.493613042853;5967.134765459071;5986.910196347058;5193.662411943287;5261.657992230493;5354.651947623392;5357.571394288448;5372.677639341652;6292.339304373067;6436.485081193493;6443.6455994920725;6447.838804029843;6453.838654033687;6182.752689892533;6193.411625895533;6211.81364559064;6217.409346112112;6218.875622487615;6197.597156184834;6302.558820882494;6395.20059992501;6431.228252609717;6461.709223085067;5975.731092100953;6123.984276525883;6124.411449640054;6128.720082208532;6144.631322120687;6196.597221180609;6213.254409470893;6218.347073557211;6220.222472190976;6229.408206220402;5820.970895145667;5930.258717660293;6042.90935635957;6063.787767428119;6070.271567411763;5963.612365196248;6021.879562408815;6024.3975602439405;6034.849128771816;6063.72713227897;5931.436513531207;5953.672548009901;5963.761449542143;5972.880542389041;5976.61152025117;5793.131030345482;5993.041113421831;6022.096685497036;6054;6077.058056001327;5766.625169363978;5928.8814223716145;5964.343922168645;5971.193888825127;5992.98119319708 03:59:05 INFO - PROCESS | 12954 | |1;ext.html;592.1473078766578;636.4590098416347;664.1432552007908;674.086612639873;687.5633972427507;41030.79484602577;46103.53896461034;46136.3079553807;46322.536774632244;46355.30467042993;45685.086298274095;46305.305420418634;46468;46579.30131048037;46587.06825863489;9049.592768325425;9154.588043538057;9223.677171299007;9246.491442970633;9259.814803703955;9171.312151588625;9197;9264.073592640749;9272;9279.628814847398;9235.353525253202;9333.673321433751;9349.392289501195;9352.111549402796;9355.391899526508;9194.999999999967;9224.538773061353;9252;9267.119623635745;9278.814423711556;9181.081891810833;9245.583948722324;9257.768555786091;9266.397684150576;9271.258299336105;44014.55985440168;44239.115217695464;44350.11299773987;44373.77813110946;44401.333979990326;3643.85424583019;3859.112404147062;3873.6320049595242;3999.14018486024;4572.108438854425;34282.48576271358;34757.47863782045;34779.6522034779;35087.4736878947;35927.64072359269;4755.429348478205;4761.833335833229;4813.08551375241;4826.712929727974;4839.959408727105;249566;251300;251851;252735;253076.99999999817;61062.389376106556;61890.69054654698;62041.68979155075;62061.069083963775;62081.689591552655;39885.80057099754;40883.59116408798;40898.591014090074;67232.6638366805;67299;15866.761998570031;15969.281382337822;16001.439949601709;16009.679806403807;16066.357345706274;13202.867971320164;13254.73490530184;13258.27079510617;13260.53588124411;13267.004974626941;20518.58962820735;20788.792112078685;20961.68557471639;21185.258515951868;21233.93830308509;7696.26833962354;7746.302832744967;7815.80460488481;7850.921490785133;7882.290593846466;1056.3767377247461;1061.6125114333213;1082.5074591061048;1131.1685910855515;1263.2483672215017;33459.66540334614;33603.495947560805;33616;34172.658273417444;34291;1142.954281828734;1149.9942500287445;1152.193464574801;1155.8439610652622;1258.584667059868;17367.739483907753;17546.210420531108;17987.820121798613;18185.45443636693;18246.63506729858;661886;662786;665360;665514;669153;64871.67564162243;65334.67332663306;65404;65542.34457655363;65621;1433.5922589983913;1462.1008080030704;1471.1834931613057;1473.3959076778683;1482.058503360601;32626.51060234146;32940.1764955878;33287.066748255595;33365.833170834965;33586.49620255747;57765.71117144555;58132;58173;58234;58583.414165857794;498050;501390;502066;502482;502639;31022.689773102884;31318.373632527677;31972;32120;33286.66713332836;52534.73732631312;53052.20421693601;53075.469245308595;53624.46375536195;54732.45267547433;44877.77561112304;45743.54256457526;45919.54080459286;46528.767356163;46798.298025528966;43377.3493397593;45060;45334.319985200906;46203.07593848037;46530.767346163055;44010.33984490299;44040;44957;45135;45419.54580454285;37018.25963480769;39116;39183;39932.600673992885;40089.19598618011;29459;29630.703692963656;29911;29931.55102673505;29988.962527531843 03:59:05 INFO - PROCESS | 12954 | |2;jquery.html;409.34096105270515;409.6251929484522;411.4198979438992;415.6882338246314;432.14004131777773;19784.40646780595;20102.73219675013;20471.795282047176;21123;21317.040733167025;17418.216180271887;17813.37653182139;18769.06154692267;18924.71612925807;19041.143148558313;5826.650400975934;5867.7066146692705;6037.63774173551;6051.788187413419;6075.119107729377;5378.8924221515545;5903.822885313448;5940.613860099102;5971.701414929258;5976.970115149418;5498.505134537891;5586.720663966806;5623.943760562403;5636.633618814784;5650.350209725893;5631.943680563183;6567.179102612174;6679.398854103129;6692.83267918306;6698.129243198402;5962.25471816023;5971.313298970587;5991.64050156992;5996.890575243594;6010.699465026775;22720.886395568083;23234;23751.287461376185;24116.51766964651;24323.756762432327;2512.7110382305905;2904.8983285585114;3069.8311592862383;3071.17078388836;3131.984340078285;14418.13491190532;14734.115953042852;14955.40178392863;15055.247237638074;15528.145951972638;1915.6839121544929;2003.5692326149801;2047.7133201351824;2054.342610364684;2075.3670130610158;80865.59567202185;84555;84894.5755271226;85454.57272713659;85642;11118.166137539554;11448.141389395829;11479.13906457019;11494.94252528732;11614.941925290488;16226.432074877323;16277.593060173354;16331.510054698378;16363.427280045142;16396.590085247964;7465.664045117983;7644.617769111522;7723.459357845009;7845.097813751491;7851.097123830718;6993.930060699429;7065.894011589728;7068.681909314093;7228.38558722504;7386.409087273005;4575.3365761965;4609.308603709471;4941.407031156285;4978.402591688948;5000.74996250186;1846.7322238275374;1899.2308115213084;1994.9002549872448;2114.904829282686;2125.8724476531456;914.1498406481903;971.8396464583406;986.5757724178528;1036.1400037968467;1073.9314382189616;19263.711044334344;19566.413007609794;20279.594408111756;20348.79651203469;20533.794662053486;1039.719275795531;1039.8648175737258;1083.3229231730168;1103.768208676187;1111.8165502692127;10199.949000254952;10992.780144397067;11113.333200008025;11137.777244455065;11184.38485883268;400049;405018;405649;576513;579950;91367.54316228376;94634.52682736542;102252;104953.47523262334;106534.46732766286;1065.2064212161988;1072.0137473524533;1091.9344839309667;1091.9454027298762;1095.6165342130191;17322.566935826704;17776.200070996576;17966.820331797036;18125.456236312933;18399.35602253915;34622.13444663904;43237.3514397278;44097.338539922566;44692.32961505515;45029.54970450253;60744;63929;65984.67007664932;66509.66745166437;67307.66346168237;8288.958555207186;8378.120297368689;8422.705205317785;8453.365997550085;8659.610317535851;11831.70420739454;13507.864921351054;13658.590242292747;13863.376148073563;13971.930140349234;11268.887311127111;11858.703532411759;12120.757584848077;12190.939045305071;12485.500579976699;11378.886211137782;11855.52577896909;12065.457054432747;12093.213941093802;12319.44562494672;11299.152563557602;11703.648890533297;11897.583584574499;12193.146479746332;12490.562830300896;7455.366293865082;7783.610819459118;7808.141104478616;7978.880316795369;8910;10686.89313106859;11251.268667536584;11255.155863310121;11367.772644546898;11458.312501249951 03:59:05 INFO - PROCESS | 12954 | |3;mootools.html;1568.0905075056469;1571.536396762955;1772.122799214389;1821.297087223447;1869.8691091623575;8533.829323413527;9328.48693321867;9338;10011.799764004725;10012.249081318903;9613.519324033789;9674.274429417786;9683.225341972642;9690.176335011533;9694.32139750216;2482.404222986488;2515.811314151437;2521.0924067335836;2535.6450096986346;2539.492101579682;2409.734929157791;2531.5696331623576;2533.100749234023;2534.6704928359286;2536.7970562354967;2500.737422570631;2501.7498250175017;2537.5432422164004;2555.8722063896826;2561.5389229938605;2458.4345600511892;2482;2487.5273697997413;2493.1024831060895;2494.2641920633273;2432.744561821001;2441.963370549443;2445;2447.1312683997103;2452.3746444656676;9694.418334899858;9800.166985806214;9859.605615775432;9861.950690246504;9932.304738668296;5537.473939975736;5684.062129748587;5690.459406356389;5693.77224911003;5694.174344720034;3393.86424543018;3432.4508078707536;3483.425234836249;3487.6861082502696;3596.8021758803256;1215.4955693387233;1227.0551675210038;1230.6278499473024;1257.9685507862284;1275.66692806017;13375;13479.19124852512;13522.256275904821;13523.256220907846;13582.25297608631;4915.066137433876;5008.84973450797;5066.847994560169;5189.922151167735;5264.394594621591;10684.786304273872;10726.088282496075;10733.946330268454;10758;10783.299085559414;5751.654900705971;5755.769769209185;5761.107028410603;5761.654300741885;5776.537876969833;4524.886877828015;5067.5185857343495;5238.659487133325;5250.763715632729;5386.434424385461;4116.9003808058105;4204.642605378516;4267.871963841089;4270.359446083113;4289.755970768442;1177.4054102678265;1180.3213152437384;1199.2205066706535;1199.2384835629439;1231.5812623707982;920.3097676742443;923.3490389275679;1054.9419781911915;1060.8302671572512;1064.5582083435288;6420.903686444707;6666.400023997767;6682.797096522672;6730.293319201512;6911.5853048817235;452.7690877652421;457.28663285275076;459.76092431935206;472.1996216413215;474.7127987567541;4312.417823593837;4447.288433850633;4539.818407263739;4575.2450845610765;4657.60410365116;12197.69505762363;12400.689982750322;12437.067219958539;12523.56167534132;12571.559995400117;11311.151663625262;11872.881271187178;12301.75396492083;12407.813882791765;12463.189892656948;8607.096254893146;8816.735497935073;8818.338624603051;8818.470891746516;8820.470771753715;6591.274959754327;6783.830404239933;6799.490038247251;6845.315468453115;6913.827154321182;10862.34825910448;11035.39305338214;11052.171087168334;11123.221374503708;11309.377984210618;11250.93116153964;11391.202615817145;11464.369459679465;11487.48306326234;11571.074314055024;7780.066392032993;8523.445976011539;8616.224539791448;8641.438306510057;8918.420302680304;9615.759606009906;9719.9028009719;9727.221822254061;9732.854007189757;9735.9026409735;8300.54347010896;8544.2310192083;8654.394192406471;8696;8698.652053917773;8372.497650141011;8421.24208821209;8437.451565648213;8531.616077276662;8722.084181160886;8157.30662893637;8179.67281308741;8205.71280005197;8232.094469608219;8240.83518329618;5775.133729940542;5907.232059832194;5923.851903702442;6001.879962400815;6005.39946005396;5629.605927585029;5893.882122357614;5897.64614123154;5997.940020599738;6008.128821320972 03:59:05 INFO - PROCESS | 12954 | |4;prototype.html;326.92187145894906;336.9932601347973;347.22915128414917;349.26305495404705;351.906744712651;5726.7422965966525;5746.827595172141;5918.585699001066;5993.351828247234;6011.038233882574;5694.2312787773635;5711.7715291388295;5747.080467125261;5775.10485874689;5790.565707571928;4512.12013657337;4514.593686568208;4541.591256786888;4560.726356418609;4577.656675749332;4412.294032954728;4454.220511410506;4460.8884777880485;4511.849478383024;4566.835456958471;4438.822447102112;4440.200763862504;4444.311131774564;4449.755263460508;4517.570830771088;4517.006258623098;4520.977395113036;4524.45706515217;4525.570070843298;4526.796294166754;3837.2901013312626;3889.144388234584;3911.9217615647526;3923.9607603923882;3970.7419017763755;5607.158926161109;5607.43925607436;5615.719214039323;5629.296337957755;5641.633293835928;5068.138416469173;5114.232865070232;5137.255098010804;5158.97420512895;5172.870678233036;5957;5962.97018514909;5999.160117583542;6015.157877897098;6026.276846778371;4317.805698743564;4322.697411181219;4324.091940692459;4330.761808100553;4336.8265269389185;6156.815295541141;6304;6315.273743519462;6320.241571011508;6324.241091069055;4405.889852753707;4416.779161041935;4426.336049592587;4429.962217380042;4443.800028998703;4512.405366914038;4517.6837621366185;4520.638348932078;4523.751193684313;4529.162105010583;5098;5151.5106064923775;5185.974070129625;5206.167013277857;5207.583393328525;5929.940700593025;6037.54718396122;6044.546659000593;6058;6072.574919755575;1514.1451721640901;1527.106642614061;1533.2027345780132;1533.2487081330069;1535.2093671759053;926.7775733823834;954.8185844689486;961.8749562556962;976.3702411944256;980.0885176785658;5141.511556402136;5146.922796158061;5209.71346575942;5268.394134674561;5292.391374991926;5424.864378390493;5492.64948381487;5508.81560464502;5537.252470916455;5561.555075594024;5065.620078494054;5224.294720212799;5231.529162375405;5252.947470525246;5258.71077090756;2943.6026136471733;2948.007772111309;2949.837758923237;2955.3350496138196;2960.2303401115864;5737.823746132033;5773.278340207474;5783.595148339576;5787.07406814916;5799.739011744482;5192.792288308501;5474.315710536183;5532.948739739437;5575.972120139454;5608.383077861514;5723.051094744613;5726.942730572641;5767.36558978512;5787.623804452697;5810.389909059488;5558.749856256559;5566.192902029264;5586.301712285965;5772.624779389326;6172.567920245539;6191.823553524816;6195.96902015487;6232.563720539519;6247.750089996531;6250.749970001149;6368.745250189941;6510.218773746991;6572.441342485942;6589.110470086477;6601.867962640624;4367.8861890217795;4386.605205531389;4390.692651514363;4394.560543945579;4402.723210268986;6036.456718895321;6089.756409743561;6279.497640188865;6286.748530058747;6357.427831495188;6097.512199024156;6107.328193898757;6117.879881260678;6125.418085281891;6130.754769809158;6112.755489780537;6123.908141377794;6154.8610208794735;6187.412195841388;6205.348438414082;5839.854003649943;6063.878722425438;6094.603850749687;6113.816585502442;6115.541334400027;6192.81421557354;6197.783077592263;6251.312355640966;6253;6265.780697675742;5924.496417804535;6002;6018.458338749533;6022.909656355246;6051.1830902829315 03:59:05 INFO - PROCESS | 12954 | |5;yui.html;824.7319621123136;825.2242891681818;825.9876101858476;854.7179430787841;953.070756012888;15518;16290.42983495578;16528.256228469716;16633.334666613337;16764.161791910417;15540.378384864593;15643.374265029413;15661.608459788511;15666.451674191405;15724.37102515898;882.9249513791335;886.2511178054533;909.168111178271;913.3789023464042;918.4718786697642;917.0279503726039;919.6827094652334;919.9816003679922;920.5995392004467;922.2207234886544;959.6689142245914;964.9179819715332;965.1506674126758;965.652365148546;966.6085235479642;959.4770849886794;960.7694153403168;962.9181519570844;963.5375019990408;963.5760265483235;702.6943279673308;708.4934271995496;709.170270783185;709.8118998465411;711.6512908674712;16099.517014489584;16186;16194.271257793427;16227.350905963747;16277.837221627751;15999.200039997953;16487.83512164875;16505.927114737624;16878.49364519054;17038.488845334537;12756.790259214436;12810.42353094113;12953.611391658265;13046.347682615926;13281.070325077248;4133.669306455507;4220.577942205786;4225.894352641178;4235.131797981407;4302.311630139194;88581.55709221477;88783.55608221982;90611.54694226553;90649.09350906407;92744;11161.107111431229;11666.416679166008;11666.88333116675;11793.469293881795;11937.46281417321;22494.550108998057;22496.775032249796;22819.201327953775;22846;23170.073197071928;8423.452475589067;8526.87209691855;8541.359398045048;8647.8026359453;8886.60010299538;4973.47778483254;4981.701097934063;4988.351514303117;4990.251462280687;5008.6243531734535;3864.613538646113;3990.4612877261197;4039.111395492987;4040.5555388907196;4042.919141617151;644.2397970394885;652.7519542573791;655.2562841175205;658.9901151482732;665.8468552233013;623.4482483002575;692.3007762160154;709.5884387055495;717.6411794102949;722.3823630795699;9062.04848490899;10417.374957502574;10649.201309901788;10696.62561810333;11440.256383335056;662.7150325360142;725.677073702208;736.2858027713216;762.4738930138298;785.1834092543804;4900.166971614834;5221.477852214824;5274.129768588216;5308.495692909168;5314.1497360422145;116683.833161669;116716;117038;118950;121028;60796;62731.686341568;70264.2973570268;82682;101809;64671.67664161743;66023;84947.5752621233;85685;94776;9476.857847132436;9494.715158545254;9611.855822162534;9749.56126974302;9773.169280610944;51177.232341514165;51203.4398280092;51234.23148652699;52611.73694131505;53680.73159634177;76443.23556764361;80693;83008.58495707483;83400;84393;12490.75018499643;12515.624531264077;12770.872291276968;12960.027997900384;13029.934850326066;14409.567712968628;15427.842911781438;16134.919325403298;16708.49874503767;17405.21676524585;14001.229932353412;14208.502702405367;14804.333804979016;15189.240537973279;15621.453249136226;14839.703205935604;15066;15193.92403038022;15209.31558079867;15864.44474443389;14060.78908816389;14266.500672476413;14818.851811481747;15224.391024358902;15607.063576185465;11915.880841191478;12495.625131246077;12602.621921342374;12623;12992.675183120498;12093.837674354003;12635.810462842881;12984.740305193654;13015.544455943997;13077.738445231233 03:59:05 INFO - PROCESS | 12954 | __end_tp_report 03:59:05 INFO - PROCESS | 12954 | __start_cc_report 03:59:05 INFO - PROCESS | 12954 | _x_x_mozilla_cycle_collect,331 03:59:05 INFO - PROCESS | 12954 | __end_cc_report 03:59:05 INFO - PROCESS | 12954 | __startTimestamp1471604345590__endTimestamp 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | ------- Summary: start ------- 03:59:05 INFO - PROCESS | 12954 | Number of tests: 6 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#0] dojo.html Cycles:165 Average:5728.94 Median:5963.76 stddev:647.98 (10.9%) stddev-sans-first:621.16 03:59:05 INFO - PROCESS | 12954 | Values: 3293.4 3311.2 3316.6 3335.2 3349.1 5704.6 5744.5 5769.1 5782.3 5797.0 5644.2 5704.5 5711.1 5743.9 5744.9 5167.8 5217.2 5248.1 5271.6 5276.5 5141.4 5155.9 5196.9 5216.0 5248.9 5276.2 5279.3 5283.7 5336.8 5350.2 5327.3 5331.6 5334.0 5341.1 5344.5 4987.6 5115.6 5228.7 5240.5 5312.6 5690.8 5750.0 5764.3 5770.8 5787.6 6150.1 6173.6 6195.3 6209.0 6209.6 5919.1 6096.0 6185.5 6262.2 6279.5 5692.5 5782.9 5782.9 5795.1 5805.2 6300.8 6324.9 6327.5 6345.4 6360.7 5796.4 5918.8 5985.1 6070.8 6097.1 6013.8 6116.2 6116.6 6137.3 6140.6 6073.1 6116.0 6126.2 6130.3 6154.3 5901.4 6099.7 6120.0 6136.0 6144.8 4687.2 4748.2 4767.5 4776.5 4778.0 4212.3 4226.1 4231.7 4250.4 4262.4 5750.1 5849.6 5992.3 5994.6 6018.1 6143.4 6179.1 6206.9 6208.1 6242.9 5949.8 5949.9 5957.5 5967.1 5986.9 5193.7 5261.7 5354.7 5357.6 5372.7 6292.3 6436.5 6443.6 6447.8 6453.8 6182.8 6193.4 6211.8 6217.4 6218.9 6197.6 6302.6 6395.2 6431.2 6461.7 5975.7 6124.0 6124.4 6128.7 6144.6 6196.6 6213.3 6218.3 6220.2 6229.4 5821.0 5930.3 6042.9 6063.8 6070.3 5963.6 6021.9 6024.4 6034.8 6063.7 5931.4 5953.7 5963.8 5972.9 5976.6 5793.1 5993.0 6022.1 6054.0 6077.1 5766.6 5928.9 5964.3 5971.2 5993.0 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#1] ext.html Cycles:180 Average:64382.53 Median:45376.93 stddev:134298.02 (296.0%) stddev-sans-first:134589.35 03:59:05 INFO - PROCESS | 12954 | Values: 592.1 636.5 664.1 674.1 687.6 41030.8 46103.5 46136.3 46322.5 46355.3 45685.1 46305.3 46468.0 46579.3 46587.1 9049.6 9154.6 9223.7 9246.5 9259.8 9171.3 9197.0 9264.1 9272.0 9279.6 9235.4 9333.7 9349.4 9352.1 9355.4 9195.0 9224.5 9252.0 9267.1 9278.8 9181.1 9245.6 9257.8 9266.4 9271.3 44014.6 44239.1 44350.1 44373.8 44401.3 3643.9 3859.1 3873.6 3999.1 4572.1 34282.5 34757.5 34779.7 35087.5 35927.6 4755.4 4761.8 4813.1 4826.7 4840.0 249566.0 251300.0 251851.0 252735.0 253077.0 61062.4 61890.7 62041.7 62061.1 62081.7 39885.8 40883.6 40898.6 67232.7 67299.0 15866.8 15969.3 16001.4 16009.7 16066.4 13202.9 13254.7 13258.3 13260.5 13267.0 20518.6 20788.8 20961.7 21185.3 21233.9 7696.3 7746.3 7815.8 7850.9 7882.3 1056.4 1061.6 1082.5 1131.2 1263.2 33459.7 33603.5 33616.0 34172.7 34291.0 1143.0 1150.0 1152.2 1155.8 1258.6 17367.7 17546.2 17987.8 18185.5 18246.6 661886.0 662786.0 665360.0 665514.0 669153.0 64871.7 65334.7 65404.0 65542.3 65621.0 1433.6 1462.1 1471.2 1473.4 1482.1 32626.5 32940.2 33287.1 33365.8 33586.5 57765.7 58132.0 58173.0 58234.0 58583.4 498050.0 501390.0 502066.0 502482.0 502639.0 31022.7 31318.4 31972.0 32120.0 33286.7 52534.7 53052.2 53075.5 53624.5 54732.5 44877.8 45743.5 45919.5 46528.8 46798.3 43377.3 45060.0 45334.3 46203.1 46530.8 44010.3 44040.0 44957.0 45135.0 45419.5 37018.3 39116.0 39183.0 39932.6 40089.2 29459.0 29630.7 29911.0 29931.6 29989.0 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#2] jquery.html Cycles:180 Average:29330.54 Median:22977.44 stddev:79740.67 (347.0%) stddev-sans-first:79934.80 03:59:05 INFO - PROCESS | 12954 | Values: 409.3 409.6 411.4 415.7 432.1 19784.4 20102.7 20471.8 21123.0 21317.0 17418.2 17813.4 18769.1 18924.7 19041.1 5826.7 5867.7 6037.6 6051.8 6075.1 5378.9 5903.8 5940.6 5971.7 5977.0 5498.5 5586.7 5623.9 5636.6 5650.4 5631.9 6567.2 6679.4 6692.8 6698.1 5962.3 5971.3 5991.6 5996.9 6010.7 22720.9 23234.0 23751.3 24116.5 24323.8 2512.7 2904.9 3069.8 3071.2 3132.0 14418.1 14734.1 14955.4 15055.2 15528.1 1915.7 2003.6 2047.7 2054.3 2075.4 80865.6 84555.0 84894.6 85454.6 85642.0 11118.2 11448.1 11479.1 11494.9 11614.9 16226.4 16277.6 16331.5 16363.4 16396.6 7465.7 7644.6 7723.5 7845.1 7851.1 6993.9 7065.9 7068.7 7228.4 7386.4 4575.3 4609.3 4941.4 4978.4 5000.7 1846.7 1899.2 1994.9 2114.9 2125.9 914.1 971.8 986.6 1036.1 1073.9 19263.7 19566.4 20279.6 20348.8 20533.8 1039.7 1039.9 1083.3 1103.8 1111.8 10199.9 10992.8 11113.3 11137.8 11184.4 400049.0 405018.0 405649.0 576513.0 579950.0 91367.5 94634.5 102252.0 104953.5 106534.5 1065.2 1072.0 1091.9 1091.9 1095.6 17322.6 17776.2 17966.8 18125.5 18399.4 34622.1 43237.4 44097.3 44692.3 45029.5 60744.0 63929.0 65984.7 66509.7 67307.7 8289.0 8378.1 8422.7 8453.4 8659.6 11831.7 13507.9 13658.6 13863.4 13971.9 11268.9 11858.7 12120.8 12190.9 12485.5 11378.9 11855.5 12065.5 12093.2 12319.4 11299.2 11703.6 11897.6 12193.1 12490.6 7455.4 7783.6 7808.1 7978.9 8910.0 10686.9 11251.3 11255.2 11367.8 11458.3 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#3] mootools.html Cycles:180 Average:6379.28 Median:2516.27 stddev:3695.52 (146.9%) stddev-sans-first:3688.20 03:59:05 INFO - PROCESS | 12954 | Values: 1568.1 1571.5 1772.1 1821.3 1869.9 8533.8 9328.5 9338.0 10011.8 10012.2 9613.5 9674.3 9683.2 9690.2 9694.3 2482.4 2515.8 2521.1 2535.6 2539.5 2409.7 2531.6 2533.1 2534.7 2536.8 2500.7 2501.7 2537.5 2555.9 2561.5 2458.4 2482.0 2487.5 2493.1 2494.3 2432.7 2442.0 2445.0 2447.1 2452.4 9694.4 9800.2 9859.6 9862.0 9932.3 5537.5 5684.1 5690.5 5693.8 5694.2 3393.9 3432.5 3483.4 3487.7 3596.8 1215.5 1227.1 1230.6 1258.0 1275.7 13375.0 13479.2 13522.3 13523.3 13582.3 4915.1 5008.8 5066.8 5189.9 5264.4 10684.8 10726.1 10733.9 10758.0 10783.3 5751.7 5755.8 5761.1 5761.7 5776.5 4524.9 5067.5 5238.7 5250.8 5386.4 4116.9 4204.6 4267.9 4270.4 4289.8 1177.4 1180.3 1199.2 1199.2 1231.6 920.3 923.3 1054.9 1060.8 1064.6 6420.9 6666.4 6682.8 6730.3 6911.6 452.8 457.3 459.8 472.2 474.7 4312.4 4447.3 4539.8 4575.2 4657.6 12197.7 12400.7 12437.1 12523.6 12571.6 11311.2 11872.9 12301.8 12407.8 12463.2 8607.1 8816.7 8818.3 8818.5 8820.5 6591.3 6783.8 6799.5 6845.3 6913.8 10862.3 11035.4 11052.2 11123.2 11309.4 11250.9 11391.2 11464.4 11487.5 11571.1 7780.1 8523.4 8616.2 8641.4 8918.4 9615.8 9719.9 9727.2 9732.9 9735.9 8300.5 8544.2 8654.4 8696.0 8698.7 8372.5 8421.2 8437.5 8531.6 8722.1 8157.3 8179.7 8205.7 8232.1 8240.8 5775.1 5907.2 5923.9 6001.9 6005.4 5629.6 5893.9 5897.6 5997.9 6008.1 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#4] prototype.html Cycles:180 Average:4983.01 Median:5581.14 stddev:1468.82 (26.3%) stddev-sans-first:1430.76 03:59:05 INFO - PROCESS | 12954 | Values: 326.9 337.0 347.2 349.3 351.9 5726.7 5746.8 5918.6 5993.4 6011.0 5694.2 5711.8 5747.1 5775.1 5790.6 4512.1 4514.6 4541.6 4560.7 4577.7 4412.3 4454.2 4460.9 4511.8 4566.8 4438.8 4440.2 4444.3 4449.8 4517.6 4517.0 4521.0 4524.5 4525.6 4526.8 3837.3 3889.1 3911.9 3924.0 3970.7 5607.2 5607.4 5615.7 5629.3 5641.6 5068.1 5114.2 5137.3 5159.0 5172.9 5957.0 5963.0 5999.2 6015.2 6026.3 4317.8 4322.7 4324.1 4330.8 4336.8 6156.8 6304.0 6315.3 6320.2 6324.2 4405.9 4416.8 4426.3 4430.0 4443.8 4512.4 4517.7 4520.6 4523.8 4529.2 5098.0 5151.5 5186.0 5206.2 5207.6 5929.9 6037.5 6044.5 6058.0 6072.6 1514.1 1527.1 1533.2 1533.2 1535.2 926.8 954.8 961.9 976.4 980.1 5141.5 5146.9 5209.7 5268.4 5292.4 5424.9 5492.6 5508.8 5537.3 5561.6 5065.6 5224.3 5231.5 5252.9 5258.7 2943.6 2948.0 2949.8 2955.3 2960.2 5737.8 5773.3 5783.6 5787.1 5799.7 5192.8 5474.3 5532.9 5576.0 5608.4 5723.1 5726.9 5767.4 5787.6 5810.4 5558.7 5566.2 5586.3 5772.6 6172.6 6191.8 6196.0 6232.6 6247.8 6250.7 6368.7 6510.2 6572.4 6589.1 6601.9 4367.9 4386.6 4390.7 4394.6 4402.7 6036.5 6089.8 6279.5 6286.7 6357.4 6097.5 6107.3 6117.9 6125.4 6130.8 6112.8 6123.9 6154.9 6187.4 6205.3 5839.9 6063.9 6094.6 6113.8 6115.5 6192.8 6197.8 6251.3 6253.0 6265.8 5924.5 6002.0 6018.5 6022.9 6051.2 03:59:05 INFO - PROCESS | 12954 | 03:59:05 INFO - PROCESS | 12954 | [#5] yui.html Cycles:180 Average:21174.92 Median:4936.82 stddev:29589.98 (599.4%) stddev-sans-first:29633.54 03:59:05 INFO - PROCESS | 12954 | Values: 824.7 825.2 826.0 854.7 953.1 15518.0 16290.4 16528.3 16633.3 16764.2 15540.4 15643.4 15661.6 15666.5 15724.4 882.9 886.3 909.2 913.4 918.5 917.0 919.7 920.0 920.6 922.2 959.7 964.9 965.2 965.7 966.6 959.5 960.8 962.9 963.5 963.6 702.7 708.5 709.2 709.8 711.7 16099.5 16186.0 16194.3 16227.4 16277.8 15999.2 16487.8 16505.9 16878.5 17038.5 12756.8 12810.4 12953.6 13046.3 13281.1 4133.7 4220.6 4225.9 4235.1 4302.3 88581.6 88783.6 90611.5 90649.1 92744.0 11161.1 11666.4 11666.9 11793.5 11937.5 22494.6 22496.8 22819.2 22846.0 23170.1 8423.5 8526.9 8541.4 8647.8 8886.6 4973.5 4981.7 4988.4 4990.3 5008.6 3864.6 3990.5 4039.1 4040.6 4042.9 644.2 652.8 655.3 659.0 665.8 623.4 692.3 709.6 717.6 722.4 9062.0 10417.4 10649.2 10696.6 11440.3 662.7 725.7 736.3 762.5 785.2 4900.2 5221.5 5274.1 5308.5 5314.1 116683.8 116716.0 117038.0 118950.0 121028.0 60796.0 62731.7 70264.3 82682.0 101809.0 64671.7 66023.0 84947.6 85685.0 94776.0 9476.9 9494.7 9611.9 9749.6 9773.2 51177.2 51203.4 51234.2 52611.7 53680.7 76443.2 80693.0 83008.6 83400.0 84393.0 12490.8 12515.6 12770.9 12960.0 13029.9 14409.6 15427.8 16134.9 16708.5 17405.2 14001.2 14208.5 14804.3 15189.2 15621.5 14839.7 15066.0 15193.9 15209.3 15864.4 14060.8 14266.5 14818.9 15224.4 15607.1 11915.9 12495.6 12602.6 12623.0 12992.7 12093.8 12635.8 12984.7 13015.5 13077.7 03:59:05 INFO - PROCESS | 12954 | -------- Summary: end -------- 03:59:05 INFO - PROCESS | 12954 | 03:59:06 INFO - TEST-INFO | 12954: exit 0 03:59:06 INFO - TEST-OK | dromaeo_css | took 1111291ms 03:59:06 INFO - TEST-START | kraken 03:59:06 INFO - operating with platform_type : linux_ 03:59:06 INFO - Initialising browser for kraken test... 03:59:06 INFO - TEST-INFO | started process 13220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFNjxq/profile http://localhost:34129/getInfo.html) 03:59:10 INFO - PROCESS | 13220 | __metrics Screen width/height:1600/1200 03:59:10 INFO - PROCESS | 13220 | colorDepth:24 03:59:10 INFO - PROCESS | 13220 | Browser inner width/height: 1024/697 03:59:10 INFO - PROCESS | 13220 | __metrics 03:59:11 ERROR - PROCESS | 13220 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:59:12 INFO - TEST-INFO | 13220: exit 0 03:59:12 INFO - Browser initialized. 03:59:12 INFO - Running cycle 1/1 for kraken test... 03:59:12 INFO - TEST-INFO | started process 13346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFNjxq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:24 INFO - PROCESS | 13346 | RSS: Main: 152498176 03:59:24 INFO - PROCESS | 13346 | 03:59:26 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34129/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:27 INFO - PROCESS | 13346 | RSS: Main: 158298112 03:59:27 INFO - PROCESS | 13346 | 03:59:30 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34129/tests/kraken/driver.html?testName=audio-dft) 03:59:30 INFO - PROCESS | 13346 | RSS: Main: 156774400 03:59:30 INFO - PROCESS | 13346 | 03:59:33 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34129/tests/kraken/driver.html?testName=audio-fft) 03:59:34 INFO - PROCESS | 13346 | RSS: Main: 157179904 03:59:34 INFO - PROCESS | 13346 | 03:59:36 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34129/tests/kraken/driver.html?testName=audio-oscillator) 03:59:37 INFO - PROCESS | 13346 | RSS: Main: 156884992 03:59:37 INFO - PROCESS | 13346 | 03:59:39 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:39 INFO - PROCESS | 13346 | RSS: Main: 156893184 03:59:39 INFO - PROCESS | 13346 | 03:59:42 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34129/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:43 INFO - PROCESS | 13346 | RSS: Main: 156356608 03:59:43 INFO - PROCESS | 13346 | 03:59:46 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34129/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:47 INFO - PROCESS | 13346 | RSS: Main: 155201536 03:59:47 INFO - PROCESS | 13346 | 03:59:50 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34129/tests/kraken/driver.html?testName=json-parse-financial) 03:59:51 INFO - PROCESS | 13346 | RSS: Main: 156692480 03:59:51 INFO - PROCESS | 13346 | 03:59:52 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:53 INFO - PROCESS | 13346 | RSS: Main: 156536832 03:59:53 INFO - PROCESS | 13346 | 03:59:54 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:55 INFO - PROCESS | 13346 | RSS: Main: 156786688 03:59:55 INFO - PROCESS | 13346 | 03:59:57 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:58 INFO - PROCESS | 13346 | RSS: Main: 157048832 03:59:58 INFO - PROCESS | 13346 | 04:00:00 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:01 INFO - PROCESS | 13346 | RSS: Main: 158105600 04:00:01 INFO - PROCESS | 13346 | 04:00:04 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:04 INFO - PROCESS | 13346 | RSS: Main: 157200384 04:00:04 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | Cycle 1(1): loaded http://localhost:34129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34129/tests/kraken/driver.html?testName=ai-astar) 04:00:06 INFO - PROCESS | 13346 | RSS: Main: 158371840 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | __start_tp_report 04:00:06 INFO - PROCESS | 13346 | _x_x_mozilla_page_load 04:00:06 INFO - PROCESS | 13346 | _x_x_mozilla_page_load_details 04:00:06 INFO - PROCESS | 13346 | |i|pagename|runs| 04:00:06 INFO - PROCESS | 13346 | |0;ai-astar;102;110;103;111;111;112;111;110;109;109 04:00:06 INFO - PROCESS | 13346 | |1;audio-beat-detection;150;116;141;171;116;145;145;118;164;117 04:00:06 INFO - PROCESS | 13346 | |2;audio-dft;162;161;160;163;163;161;163;162;160;161 04:00:06 INFO - PROCESS | 13346 | |3;audio-fft;74;76;76;172;77;75;74;76;180;75 04:00:06 INFO - PROCESS | 13346 | |4;audio-oscillator;84;83;156;84;84;84;151;84;83;138 04:00:06 INFO - PROCESS | 13346 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;117 04:00:06 INFO - PROCESS | 13346 | |6;imaging-darkroom;147;148;147;147;147;147;147;148;147;147 04:00:06 INFO - PROCESS | 13346 | |7;imaging-desaturate;95;95;96;95;95;95;95;97;96;95 04:00:06 INFO - PROCESS | 13346 | |8;json-parse-financial;52;51;52;54;52;52;52;52;51;52 04:00:06 INFO - PROCESS | 13346 | |9;json-stringify-tinderbox;61;59;59;60;59;58;58;59;59;59 04:00:06 INFO - PROCESS | 13346 | |10;stanford-crypto-aes;73;73;73;73;81;72;75;72;74;73 04:00:06 INFO - PROCESS | 13346 | |11;stanford-crypto-ccm;128;119;137;129;118;127;118;121;144;127 04:00:06 INFO - PROCESS | 13346 | |12;stanford-crypto-pbkdf2;158;153;151;151;150;148;150;148;149;149 04:00:06 INFO - PROCESS | 13346 | |13;stanford-crypto-sha256-iterative;63;65;62;64;62;62;63;65;60;60 04:00:06 INFO - PROCESS | 13346 | __end_tp_report 04:00:06 INFO - PROCESS | 13346 | __start_cc_report 04:00:06 INFO - PROCESS | 13346 | _x_x_mozilla_cycle_collect,858 04:00:06 INFO - PROCESS | 13346 | __end_cc_report 04:00:06 INFO - PROCESS | 13346 | __startTimestamp1471604406531__endTimestamp 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | ------- Summary: start ------- 04:00:06 INFO - PROCESS | 13346 | Number of tests: 14 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.46 (3.1%) stddev-sans-first:2.65 04:00:06 INFO - PROCESS | 13346 | Values: 102.0 110.0 103.0 111.0 111.0 112.0 111.0 110.0 109.0 109.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.00 stddev:20.61 (14.2%) stddev-sans-first:21.42 04:00:06 INFO - PROCESS | 13346 | Values: 150.0 116.0 141.0 171.0 116.0 145.0 145.0 118.0 164.0 117.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 04:00:06 INFO - PROCESS | 13346 | Values: 162.0 161.0 160.0 163.0 163.0 161.0 163.0 162.0 160.0 161.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:42.48 (56.3%) stddev-sans-first:44.34 04:00:06 INFO - PROCESS | 13346 | Values: 74.0 76.0 76.0 172.0 77.0 75.0 74.0 76.0 180.0 75.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:31.52 (37.5%) stddev-sans-first:32.67 04:00:06 INFO - PROCESS | 13346 | Values: 84.0 83.0 156.0 84.0 84.0 84.0 151.0 84.0 83.0 138.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:00:06 INFO - PROCESS | 13346 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:00:06 INFO - PROCESS | 13346 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:00:06 INFO - PROCESS | 13346 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 04:00:06 INFO - PROCESS | 13346 | Values: 52.0 51.0 52.0 54.0 52.0 52.0 52.0 52.0 51.0 52.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.60 04:00:06 INFO - PROCESS | 13346 | Values: 61.0 59.0 59.0 60.0 59.0 58.0 58.0 59.0 59.0 59.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:2.64 (3.6%) stddev-sans-first:2.78 04:00:06 INFO - PROCESS | 13346 | Values: 73.0 73.0 73.0 73.0 81.0 72.0 75.0 72.0 74.0 73.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.50 stddev:8.53 (6.7%) stddev-sans-first:9.04 04:00:06 INFO - PROCESS | 13346 | Values: 128.0 119.0 137.0 129.0 118.0 127.0 118.0 121.0 144.0 127.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:150.50 stddev:2.98 (2.0%) stddev-sans-first:1.62 04:00:06 INFO - PROCESS | 13346 | Values: 158.0 153.0 151.0 151.0 150.0 148.0 150.0 148.0 149.0 149.0 04:00:06 INFO - PROCESS | 13346 | 04:00:06 INFO - PROCESS | 13346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.88 04:00:06 INFO - PROCESS | 13346 | Values: 63.0 65.0 62.0 64.0 62.0 62.0 63.0 65.0 60.0 60.0 04:00:06 INFO - PROCESS | 13346 | -------- Summary: end -------- 04:00:06 INFO - PROCESS | 13346 | 04:00:07 INFO - TEST-INFO | 13346: exit 0 04:00:07 INFO - TEST-OK | kraken | took 61220ms 04:00:07 INFO - SUITE-END | took 1172s 04:00:07 INFO - Completed test suite (00:19:32) 04:00:07 INFO - javascript benchmark 04:00:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7704.076964334099, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.4071867063926, 3311.2417406243912, 3316.5688460500132, 3335.2328964338185, 3349.0790032740993, 5704.600677952545, 5744.4829965303115, 5769.076947688371, 5782.306123265214, 5796.971015144918, 5644.238027866237, 5704.515116215127, 5711.114777209529, 5743.856403589913, 5744.937186620478, 5167.844964651057, 5217.243499692542, 5248.0553500369915, 5271.604629652772, 5276.472352764731, 5141.357330333708, 5155.871103222412, 5196.92204616931, 5216.035033518811, 5248.895022099556, 5276.15581506959, 5279.313689220396, 5283.735813209343, 5336.839894803162, 5350.170723537838, 5327.307450031491, 5331.600129990247, 5334.03987282289, 5341.0653135701095, 5344.465553444663, 4987.576056035241, 5115.641905066647, 5228.738563071869, 5240.475952404767, 5312.60155488336, 5690.829275121753, 5750.0, 5764.250647415851, 5770.826875193751, 5787.623804452697, 6150.077488376734, 6173.567850250484, 6195.349488303754, 6209.0, 6209.627422354628, 5919.1417244499735, 6095.9695201524155, 6185.536084793614, 6262.154609127755, 6279.49764018882, 5692.544596432317, 5782.884342313214, 5782.942170578324, 5795.1017592273265, 5805.216295800055, 6300.779472718433, 6324.9051264231075, 6327.525435592349, 6345.428911397904, 6360.650164241011, 5796.362400135981, 5918.822435326947, 5985.072313791369, 6070.757169713251, 6097.115918191837, 6013.819585412444, 6116.204893363834, 6116.602420842631, 6137.263528376623, 6140.600860944024, 6073.1497590337385, 6116.021436570128, 6126.23422072241, 6130.264368275835, 6154.261488621394, 5901.409859014064, 6099.725512351954, 6119.969400152971, 6136.048912418582, 6144.754209831646, 4687.156311863897, 4748.240281554935, 4767.4517430495935, 4776.522347765265, 4778.0, 4212.304969679968, 4226.070264541796, 4231.661467082626, 4250.362445633118, 4262.4458820353775, 5750.051241545182, 5849.590528662953, 5992.34084250732, 5994.580379373489, 6018.127371531104, 6143.354947730513, 6179.104029915727, 6206.875862482725, 6208.0998255253635, 6242.938700420848, 5949.762009519571, 5949.940500595025, 5957.493613042853, 5967.134765459071, 5986.910196347058, 5193.662411943287, 5261.657992230493, 5354.651947623392, 5357.571394288448, 5372.677639341652, 6292.339304373067, 6436.485081193493, 6443.6455994920725, 6447.838804029843, 6453.838654033687, 6182.752689892533, 6193.411625895533, 6211.81364559064, 6217.409346112112, 6218.875622487615, 6197.597156184834, 6302.558820882494, 6395.20059992501, 6431.228252609717, 6461.709223085067, 5975.731092100953, 6123.984276525883, 6124.411449640054, 6128.720082208532, 6144.631322120687, 6196.597221180609, 6213.254409470893, 6218.347073557211, 6220.222472190976, 6229.408206220402, 5820.970895145667, 5930.258717660293, 6042.90935635957, 6063.787767428119, 6070.271567411763, 5963.612365196248, 6021.879562408815, 6024.3975602439405, 6034.849128771816, 6063.72713227897, 5931.436513531207, 5953.672548009901, 5963.761449542143, 5972.880542389041, 5976.61152025117, 5793.131030345482, 5993.041113421831, 6022.096685497036, 6054.0, 6077.058056001327, 5766.625169363978, 5928.8814223716145, 5964.343922168645, 5971.193888825127, 5992.98119319708], "value": 5685.31200833856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.1473078766578, 636.4590098416347, 664.1432552007908, 674.086612639873, 687.5633972427507, 41030.79484602577, 46103.53896461034, 46136.3079553807, 46322.536774632244, 46355.30467042993, 45685.086298274095, 46305.305420418634, 46468.0, 46579.30131048037, 46587.06825863489, 9049.592768325425, 9154.588043538057, 9223.677171299007, 9246.491442970633, 9259.814803703955, 9171.312151588625, 9197.0, 9264.073592640749, 9272.0, 9279.628814847398, 9235.353525253202, 9333.673321433751, 9349.392289501195, 9352.111549402796, 9355.391899526508, 9194.999999999967, 9224.538773061353, 9252.0, 9267.119623635745, 9278.814423711556, 9181.081891810833, 9245.583948722324, 9257.768555786091, 9266.397684150576, 9271.258299336105, 44014.55985440168, 44239.115217695464, 44350.11299773987, 44373.77813110946, 44401.333979990326, 3643.85424583019, 3859.112404147062, 3873.6320049595242, 3999.14018486024, 4572.108438854425, 34282.48576271358, 34757.47863782045, 34779.6522034779, 35087.4736878947, 35927.64072359269, 4755.429348478205, 4761.833335833229, 4813.08551375241, 4826.712929727974, 4839.959408727105, 249566.0, 251300.0, 251851.0, 252735.0, 253076.99999999817, 61062.389376106556, 61890.69054654698, 62041.68979155075, 62061.069083963775, 62081.689591552655, 39885.80057099754, 40883.59116408798, 40898.591014090074, 67232.6638366805, 67299.0, 15866.761998570031, 15969.281382337822, 16001.439949601709, 16009.679806403807, 16066.357345706274, 13202.867971320164, 13254.73490530184, 13258.27079510617, 13260.53588124411, 13267.004974626941, 20518.58962820735, 20788.792112078685, 20961.68557471639, 21185.258515951868, 21233.93830308509, 7696.26833962354, 7746.302832744967, 7815.80460488481, 7850.921490785133, 7882.290593846466, 1056.3767377247461, 1061.6125114333213, 1082.5074591061048, 1131.1685910855515, 1263.2483672215017, 33459.66540334614, 33603.495947560805, 33616.0, 34172.658273417444, 34291.0, 1142.954281828734, 1149.9942500287445, 1152.193464574801, 1155.8439610652622, 1258.584667059868, 17367.739483907753, 17546.210420531108, 17987.820121798613, 18185.45443636693, 18246.63506729858, 661886.0, 662786.0, 665360.0, 665514.0, 669153.0, 64871.67564162243, 65334.67332663306, 65404.0, 65542.34457655363, 65621.0, 1433.5922589983913, 1462.1008080030704, 1471.1834931613057, 1473.3959076778683, 1482.058503360601, 32626.51060234146, 32940.1764955878, 33287.066748255595, 33365.833170834965, 33586.49620255747, 57765.71117144555, 58132.0, 58173.0, 58234.0, 58583.414165857794, 498050.0, 501390.0, 502066.0, 502482.0, 502639.0, 31022.689773102884, 31318.373632527677, 31972.0, 32120.0, 33286.66713332836, 52534.73732631312, 53052.20421693601, 53075.469245308595, 53624.46375536195, 54732.45267547433, 44877.77561112304, 45743.54256457526, 45919.54080459286, 46528.767356163, 46798.298025528966, 43377.3493397593, 45060.0, 45334.319985200906, 46203.07593848037, 46530.767346163055, 44010.33984490299, 44040.0, 44957.0, 45135.0, 45419.54580454285, 37018.25963480769, 39116.0, 39183.0, 39932.600673992885, 40089.19598618011, 29459.0, 29630.703692963656, 29911.0, 29931.55102673505, 29988.962527531843], "value": 21316.337641154223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.34096105270515, 409.6251929484522, 411.4198979438992, 415.6882338246314, 432.14004131777773, 19784.40646780595, 20102.73219675013, 20471.795282047176, 21123.0, 21317.040733167025, 17418.216180271887, 17813.37653182139, 18769.06154692267, 18924.71612925807, 19041.143148558313, 5826.650400975934, 5867.7066146692705, 6037.63774173551, 6051.788187413419, 6075.119107729377, 5378.8924221515545, 5903.822885313448, 5940.613860099102, 5971.701414929258, 5976.970115149418, 5498.505134537891, 5586.720663966806, 5623.943760562403, 5636.633618814784, 5650.350209725893, 5631.943680563183, 6567.179102612174, 6679.398854103129, 6692.83267918306, 6698.129243198402, 5962.25471816023, 5971.313298970587, 5991.64050156992, 5996.890575243594, 6010.699465026775, 22720.886395568083, 23234.0, 23751.287461376185, 24116.51766964651, 24323.756762432327, 2512.7110382305905, 2904.8983285585114, 3069.8311592862383, 3071.17078388836, 3131.984340078285, 14418.13491190532, 14734.115953042852, 14955.40178392863, 15055.247237638074, 15528.145951972638, 1915.6839121544929, 2003.5692326149801, 2047.7133201351824, 2054.342610364684, 2075.3670130610158, 80865.59567202185, 84555.0, 84894.5755271226, 85454.57272713659, 85642.0, 11118.166137539554, 11448.141389395829, 11479.13906457019, 11494.94252528732, 11614.941925290488, 16226.432074877323, 16277.593060173354, 16331.510054698378, 16363.427280045142, 16396.590085247964, 7465.664045117983, 7644.617769111522, 7723.459357845009, 7845.097813751491, 7851.097123830718, 6993.930060699429, 7065.894011589728, 7068.681909314093, 7228.38558722504, 7386.409087273005, 4575.3365761965, 4609.308603709471, 4941.407031156285, 4978.402591688948, 5000.74996250186, 1846.7322238275374, 1899.2308115213084, 1994.9002549872448, 2114.904829282686, 2125.8724476531456, 914.1498406481903, 971.8396464583406, 986.5757724178528, 1036.1400037968467, 1073.9314382189616, 19263.711044334344, 19566.413007609794, 20279.594408111756, 20348.79651203469, 20533.794662053486, 1039.719275795531, 1039.8648175737258, 1083.3229231730168, 1103.768208676187, 1111.8165502692127, 10199.949000254952, 10992.780144397067, 11113.333200008025, 11137.777244455065, 11184.38485883268, 400049.0, 405018.0, 405649.0, 576513.0, 579950.0, 91367.54316228376, 94634.52682736542, 102252.0, 104953.47523262334, 106534.46732766286, 1065.2064212161988, 1072.0137473524533, 1091.9344839309667, 1091.9454027298762, 1095.6165342130191, 17322.566935826704, 17776.200070996576, 17966.820331797036, 18125.456236312933, 18399.35602253915, 34622.13444663904, 43237.3514397278, 44097.338539922566, 44692.32961505515, 45029.54970450253, 60744.0, 63929.0, 65984.67007664932, 66509.66745166437, 67307.66346168237, 8288.958555207186, 8378.120297368689, 8422.705205317785, 8453.365997550085, 8659.610317535851, 11831.70420739454, 13507.864921351054, 13658.590242292747, 13863.376148073563, 13971.930140349234, 11268.887311127111, 11858.703532411759, 12120.757584848077, 12190.939045305071, 12485.500579976699, 11378.886211137782, 11855.52577896909, 12065.457054432747, 12093.213941093802, 12319.44562494672, 11299.152563557602, 11703.648890533297, 11897.583584574499, 12193.146479746332, 12490.562830300896, 7455.366293865082, 7783.610819459118, 7808.141104478616, 7978.880316795369, 8910.0, 10686.89313106859, 11251.268667536584, 11255.155863310121, 11367.772644546898, 11458.312501249951], "value": 9577.84730313773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.0905075056469, 1571.536396762955, 1772.122799214389, 1821.297087223447, 1869.8691091623575, 8533.829323413527, 9328.48693321867, 9338.0, 10011.799764004725, 10012.249081318903, 9613.519324033789, 9674.274429417786, 9683.225341972642, 9690.176335011533, 9694.32139750216, 2482.404222986488, 2515.811314151437, 2521.0924067335836, 2535.6450096986346, 2539.492101579682, 2409.734929157791, 2531.5696331623576, 2533.100749234023, 2534.6704928359286, 2536.7970562354967, 2500.737422570631, 2501.7498250175017, 2537.5432422164004, 2555.8722063896826, 2561.5389229938605, 2458.4345600511892, 2482.0, 2487.5273697997413, 2493.1024831060895, 2494.2641920633273, 2432.744561821001, 2441.963370549443, 2445.0, 2447.1312683997103, 2452.3746444656676, 9694.418334899858, 9800.166985806214, 9859.605615775432, 9861.950690246504, 9932.304738668296, 5537.473939975736, 5684.062129748587, 5690.459406356389, 5693.77224911003, 5694.174344720034, 3393.86424543018, 3432.4508078707536, 3483.425234836249, 3487.6861082502696, 3596.8021758803256, 1215.4955693387233, 1227.0551675210038, 1230.6278499473024, 1257.9685507862284, 1275.66692806017, 13375.0, 13479.19124852512, 13522.256275904821, 13523.256220907846, 13582.25297608631, 4915.066137433876, 5008.84973450797, 5066.847994560169, 5189.922151167735, 5264.394594621591, 10684.786304273872, 10726.088282496075, 10733.946330268454, 10758.0, 10783.299085559414, 5751.654900705971, 5755.769769209185, 5761.107028410603, 5761.654300741885, 5776.537876969833, 4524.886877828015, 5067.5185857343495, 5238.659487133325, 5250.763715632729, 5386.434424385461, 4116.9003808058105, 4204.642605378516, 4267.871963841089, 4270.359446083113, 4289.755970768442, 1177.4054102678265, 1180.3213152437384, 1199.2205066706535, 1199.2384835629439, 1231.5812623707982, 920.3097676742443, 923.3490389275679, 1054.9419781911915, 1060.8302671572512, 1064.5582083435288, 6420.903686444707, 6666.400023997767, 6682.797096522672, 6730.293319201512, 6911.5853048817235, 452.7690877652421, 457.28663285275076, 459.76092431935206, 472.1996216413215, 474.7127987567541, 4312.417823593837, 4447.288433850633, 4539.818407263739, 4575.2450845610765, 4657.60410365116, 12197.69505762363, 12400.689982750322, 12437.067219958539, 12523.56167534132, 12571.559995400117, 11311.151663625262, 11872.881271187178, 12301.75396492083, 12407.813882791765, 12463.189892656948, 8607.096254893146, 8816.735497935073, 8818.338624603051, 8818.470891746516, 8820.470771753715, 6591.274959754327, 6783.830404239933, 6799.490038247251, 6845.315468453115, 6913.827154321182, 10862.34825910448, 11035.39305338214, 11052.171087168334, 11123.221374503708, 11309.377984210618, 11250.93116153964, 11391.202615817145, 11464.369459679465, 11487.48306326234, 11571.074314055024, 7780.066392032993, 8523.445976011539, 8616.224539791448, 8641.438306510057, 8918.420302680304, 9615.759606009906, 9719.9028009719, 9727.221822254061, 9732.854007189757, 9735.9026409735, 8300.54347010896, 8544.2310192083, 8654.394192406471, 8696.0, 8698.652053917773, 8372.497650141011, 8421.24208821209, 8437.451565648213, 8531.616077276662, 8722.084181160886, 8157.30662893637, 8179.67281308741, 8205.71280005197, 8232.094469608219, 8240.83518329618, 5775.133729940542, 5907.232059832194, 5923.851903702442, 6001.879962400815, 6005.39946005396, 5629.605927585029, 5893.882122357614, 5897.64614123154, 5997.940020599738, 6008.128821320972], "value": 4961.2805087153765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.92187145894906, 336.9932601347973, 347.22915128414917, 349.26305495404705, 351.906744712651, 5726.7422965966525, 5746.827595172141, 5918.585699001066, 5993.351828247234, 6011.038233882574, 5694.2312787773635, 5711.7715291388295, 5747.080467125261, 5775.10485874689, 5790.565707571928, 4512.12013657337, 4514.593686568208, 4541.591256786888, 4560.726356418609, 4577.656675749332, 4412.294032954728, 4454.220511410506, 4460.8884777880485, 4511.849478383024, 4566.835456958471, 4438.822447102112, 4440.200763862504, 4444.311131774564, 4449.755263460508, 4517.570830771088, 4517.006258623098, 4520.977395113036, 4524.45706515217, 4525.570070843298, 4526.796294166754, 3837.2901013312626, 3889.144388234584, 3911.9217615647526, 3923.9607603923882, 3970.7419017763755, 5607.158926161109, 5607.43925607436, 5615.719214039323, 5629.296337957755, 5641.633293835928, 5068.138416469173, 5114.232865070232, 5137.255098010804, 5158.97420512895, 5172.870678233036, 5957.0, 5962.97018514909, 5999.160117583542, 6015.157877897098, 6026.276846778371, 4317.805698743564, 4322.697411181219, 4324.091940692459, 4330.761808100553, 4336.8265269389185, 6156.815295541141, 6304.0, 6315.273743519462, 6320.241571011508, 6324.241091069055, 4405.889852753707, 4416.779161041935, 4426.336049592587, 4429.962217380042, 4443.800028998703, 4512.405366914038, 4517.6837621366185, 4520.638348932078, 4523.751193684313, 4529.162105010583, 5098.0, 5151.5106064923775, 5185.974070129625, 5206.167013277857, 5207.583393328525, 5929.940700593025, 6037.54718396122, 6044.546659000593, 6058.0, 6072.574919755575, 1514.1451721640901, 1527.106642614061, 1533.2027345780132, 1533.2487081330069, 1535.2093671759053, 926.7775733823834, 954.8185844689486, 961.8749562556962, 976.3702411944256, 980.0885176785658, 5141.511556402136, 5146.922796158061, 5209.71346575942, 5268.394134674561, 5292.391374991926, 5424.864378390493, 5492.64948381487, 5508.81560464502, 5537.252470916455, 5561.555075594024, 5065.620078494054, 5224.294720212799, 5231.529162375405, 5252.947470525246, 5258.71077090756, 2943.6026136471733, 2948.007772111309, 2949.837758923237, 2955.3350496138196, 2960.2303401115864, 5737.823746132033, 5773.278340207474, 5783.595148339576, 5787.07406814916, 5799.739011744482, 5192.792288308501, 5474.315710536183, 5532.948739739437, 5575.972120139454, 5608.383077861514, 5723.051094744613, 5726.942730572641, 5767.36558978512, 5787.623804452697, 5810.389909059488, 5558.749856256559, 5566.192902029264, 5586.301712285965, 5772.624779389326, 6172.567920245539, 6191.823553524816, 6195.96902015487, 6232.563720539519, 6247.750089996531, 6250.749970001149, 6368.745250189941, 6510.218773746991, 6572.441342485942, 6589.110470086477, 6601.867962640624, 4367.8861890217795, 4386.605205531389, 4390.692651514363, 4394.560543945579, 4402.723210268986, 6036.456718895321, 6089.756409743561, 6279.497640188865, 6286.748530058747, 6357.427831495188, 6097.512199024156, 6107.328193898757, 6117.879881260678, 6125.418085281891, 6130.754769809158, 6112.755489780537, 6123.908141377794, 6154.8610208794735, 6187.412195841388, 6205.348438414082, 5839.854003649943, 6063.878722425438, 6094.603850749687, 6113.816585502442, 6115.541334400027, 6192.81421557354, 6197.783077592263, 6251.312355640966, 6253.0, 6265.780697675742, 5924.496417804535, 6002.0, 6018.458338749533, 6022.909656355246, 6051.1830902829315], "value": 4507.174742109818, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.7319621123136, 825.2242891681818, 825.9876101858476, 854.7179430787841, 953.070756012888, 15518.0, 16290.42983495578, 16528.256228469716, 16633.334666613337, 16764.161791910417, 15540.378384864593, 15643.374265029413, 15661.608459788511, 15666.451674191405, 15724.37102515898, 882.9249513791335, 886.2511178054533, 909.168111178271, 913.3789023464042, 918.4718786697642, 917.0279503726039, 919.6827094652334, 919.9816003679922, 920.5995392004467, 922.2207234886544, 959.6689142245914, 964.9179819715332, 965.1506674126758, 965.652365148546, 966.6085235479642, 959.4770849886794, 960.7694153403168, 962.9181519570844, 963.5375019990408, 963.5760265483235, 702.6943279673308, 708.4934271995496, 709.170270783185, 709.8118998465411, 711.6512908674712, 16099.517014489584, 16186.0, 16194.271257793427, 16227.350905963747, 16277.837221627751, 15999.200039997953, 16487.83512164875, 16505.927114737624, 16878.49364519054, 17038.488845334537, 12756.790259214436, 12810.42353094113, 12953.611391658265, 13046.347682615926, 13281.070325077248, 4133.669306455507, 4220.577942205786, 4225.894352641178, 4235.131797981407, 4302.311630139194, 88581.55709221477, 88783.55608221982, 90611.54694226553, 90649.09350906407, 92744.0, 11161.107111431229, 11666.416679166008, 11666.88333116675, 11793.469293881795, 11937.46281417321, 22494.550108998057, 22496.775032249796, 22819.201327953775, 22846.0, 23170.073197071928, 8423.452475589067, 8526.87209691855, 8541.359398045048, 8647.8026359453, 8886.60010299538, 4973.47778483254, 4981.701097934063, 4988.351514303117, 4990.251462280687, 5008.6243531734535, 3864.613538646113, 3990.4612877261197, 4039.111395492987, 4040.5555388907196, 4042.919141617151, 644.2397970394885, 652.7519542573791, 655.2562841175205, 658.9901151482732, 665.8468552233013, 623.4482483002575, 692.3007762160154, 709.5884387055495, 717.6411794102949, 722.3823630795699, 9062.04848490899, 10417.374957502574, 10649.201309901788, 10696.62561810333, 11440.256383335056, 662.7150325360142, 725.677073702208, 736.2858027713216, 762.4738930138298, 785.1834092543804, 4900.166971614834, 5221.477852214824, 5274.129768588216, 5308.495692909168, 5314.1497360422145, 116683.833161669, 116716.0, 117038.0, 118950.0, 121028.0, 60796.0, 62731.686341568, 70264.2973570268, 82682.0, 101809.0, 64671.67664161743, 66023.0, 84947.5752621233, 85685.0, 94776.0, 9476.857847132436, 9494.715158545254, 9611.855822162534, 9749.56126974302, 9773.169280610944, 51177.232341514165, 51203.4398280092, 51234.23148652699, 52611.73694131505, 53680.73159634177, 76443.23556764361, 80693.0, 83008.58495707483, 83400.0, 84393.0, 12490.75018499643, 12515.624531264077, 12770.872291276968, 12960.027997900384, 13029.934850326066, 14409.567712968628, 15427.842911781438, 16134.919325403298, 16708.49874503767, 17405.21676524585, 14001.229932353412, 14208.502702405367, 14804.333804979016, 15189.240537973279, 15621.453249136226, 14839.703205935604, 15066.0, 15193.92403038022, 15209.31558079867, 15864.44474443389, 14060.78908816389, 14266.500672476413, 14818.851811481747, 15224.391024358902, 15607.063576185465, 11915.880841191478, 12495.625131246077, 12602.621921342374, 12623.0, 12992.675183120498, 12093.837674354003, 12635.810462842881, 12984.740305193654, 13015.544455943997, 13077.738445231233], "value": 8054.693518479892, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 103.0, 111.0, 111.0, 112.0, 111.0, 110.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 141.0, 171.0, 116.0, 145.0, 145.0, 118.0, 164.0, 117.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 163.0, 163.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 172.0, 77.0, 75.0, 74.0, 76.0, 180.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 156.0, 84.0, 84.0, 84.0, 151.0, 84.0, 83.0, 138.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 54.0, 52.0, 52.0, 52.0, 52.0, 51.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 60.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 81.0, 72.0, 75.0, 72.0, 74.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 137.0, 129.0, 118.0, 127.0, 118.0, 121.0, 144.0, 127.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 151.0, 151.0, 150.0, 148.0, 150.0, 148.0, 149.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 64.0, 62.0, 62.0, 63.0, 65.0, 60.0, 60.0], "value": 62.6, "unit": "score"}]}]} 04:00:07 INFO - Return code: 0 04:00:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:07 ERROR - # TBPL SUCCESS # 04:00:07 INFO - Running post-action listener: _resource_record_post_action 04:00:07 INFO - [mozharness: 2016-08-19 11:00:07.852906Z] Finished run-tests step (success) 04:00:07 INFO - Running post-run listener: _resource_record_post_run 04:00:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326557696; Read time: 264; Write time: 371676 04:00:07 INFO - TinderboxPrint: CPU usage
13.3% 04:00:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 264 04:00:07 INFO - TinderboxPrint: I/O write bytes / time
326,557,696 / 371,676 04:00:07 INFO - TinderboxPrint: CPU idle
8,225.7 (86.7%) 04:00:07 INFO - TinderboxPrint: CPU user
1,200.3 (12.7%) 04:00:07 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 78233600; Read time: 256; Write time: 116512 04:00:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 247033856; Read time: 0; Write time: 255120 04:00:08 INFO - Running post-run listener: _upload_blobber_files 04:00:08 INFO - Blob upload gear active. 04:00:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:00:08 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'] 04:00:08 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 04:00:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:10 INFO - (blobuploader) - INFO - Done attempting. 04:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:11 INFO - (blobuploader) - INFO - Done attempting. 04:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:19 INFO - (blobuploader) - INFO - Done attempting. 04:00:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:19 INFO - Return code: 0 04:00:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd51c16b829f485f1559ec05083f33616dbdbfdd2534516b2676a93bc948c5c09ce51e05002cdeda60e9d7df9494c89d3952647bdabd5f17518d8c656f55476a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b9afc66b5907eeb8f5e21dc856ebcaeb263d0c2c2d75d4aed9dad6c782ad1f75cfe740b411bb5a752993c0646e635865dc31c922a6626379597bf575a7e8f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02582b293bc399b961a9a93c1c90f9e5e50514393d87000189b05a206d7753394902903e2db3aacc44b9dedd3e8c62c9693a0348c517d647f0aa9648acb54f8f"} 04:00:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:19 INFO - Contents: 04:00:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd51c16b829f485f1559ec05083f33616dbdbfdd2534516b2676a93bc948c5c09ce51e05002cdeda60e9d7df9494c89d3952647bdabd5f17518d8c656f55476a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b9afc66b5907eeb8f5e21dc856ebcaeb263d0c2c2d75d4aed9dad6c782ad1f75cfe740b411bb5a752993c0646e635865dc31c922a6626379597bf575a7e8f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02582b293bc399b961a9a93c1c90f9e5e50514393d87000189b05a206d7753394902903e2db3aacc44b9dedd3e8c62c9693a0348c517d647f0aa9648acb54f8f"} 04:00:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:19 INFO - Copying logs to upload dir... 04:00:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1683.122726 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2016-08-19 04:00:19.264031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 04:00:19.267042) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 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/dd51c16b829f485f1559ec05083f33616dbdbfdd2534516b2676a93bc948c5c09ce51e05002cdeda60e9d7df9494c89d3952647bdabd5f17518d8c656f55476a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b9afc66b5907eeb8f5e21dc856ebcaeb263d0c2c2d75d4aed9dad6c782ad1f75cfe740b411bb5a752993c0646e635865dc31c922a6626379597bf575a7e8f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02582b293bc399b961a9a93c1c90f9e5e50514393d87000189b05a206d7753394902903e2db3aacc44b9dedd3e8c62c9693a0348c517d647f0aa9648acb54f8f"} build_url:https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/bf-8i5L8SEKcBddaSxwSuw/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/dd51c16b829f485f1559ec05083f33616dbdbfdd2534516b2676a93bc948c5c09ce51e05002cdeda60e9d7df9494c89d3952647bdabd5f17518d8c656f55476a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b9afc66b5907eeb8f5e21dc856ebcaeb263d0c2c2d75d4aed9dad6c782ad1f75cfe740b411bb5a752993c0646e635865dc31c922a6626379597bf575a7e8f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02582b293bc399b961a9a93c1c90f9e5e50514393d87000189b05a206d7753394902903e2db3aacc44b9dedd3e8c62c9693a0348c517d647f0aa9648acb54f8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 04:00:19.294997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:00:19.295351) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1471598901.613451-594758534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:00:19.345497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 04:00:19.348914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 04:00:19.349311) ========= ========= Total master_lag: 0.33 =========