builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1470824690.91 results: success (0) buildid: 20160810004000 builduid: 07fae4d321c94ce18d7909de04a301ee revision: e74314c1717e9406417014786f00d06f7c0e8b00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:50.913223) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:50.913596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:50.914456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:50.985656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:50.985907) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 03:24:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-08-10 03:24:51 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.089833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.090111) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019785 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.140082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.140401) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e74314c1717e9406417014786f00d06f7c0e8b00 --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 e74314c1717e9406417014786f00d06f7c0e8b00 --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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 03:24:51,477 truncating revision to first 12 chars 2016-08-10 03:24:51,477 Setting DEBUG logging. 2016-08-10 03:24:51,477 attempt 1/10 2016-08-10 03:24:51,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e74314c1717e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 03:24:51,945 unpacking tar archive at: mozilla-aurora-e74314c1717e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.988912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.989208) ========= script_repo_revision: e74314c1717e9406417014786f00d06f7c0e8b00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.989665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:51.989939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 03:24:52.000756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-10 03:24:52.001024) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:52 INFO - MultiFileLogger online at 20160810 03:24:52 in /builds/slave/test 03:24:52 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:24:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:52 INFO - {'append_to_log': False, 03:24:52 INFO - 'base_work_dir': '/builds/slave/test', 03:24:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:52 INFO - 'branch': 'Mozilla-Aurora', 03:24:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:52 INFO - 'config_files': ('talos/linux_config.py',), 03:24:52 INFO - 'default_actions': ('clobber', 03:24:52 INFO - 'read-buildbot-config', 03:24:52 INFO - 'download-and-extract', 03:24:52 INFO - 'populate-webroot', 03:24:52 INFO - 'create-virtualenv', 03:24:52 INFO - 'install', 03:24:52 INFO - 'run-tests'), 03:24:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:52 INFO - 'download_minidump_stackwalk': True, 03:24:52 INFO - 'download_symbols': 'ondemand', 03:24:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:52 INFO - 'installer_path': 'installer.exe', 03:24:52 INFO - 'log_level': 'info', 03:24:52 INFO - 'log_name': 'talos', 03:24:52 INFO - 'log_to_console': True, 03:24:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:52 INFO - 'opt_config_files': (), 03:24:52 INFO - 'pip_index': False, 03:24:52 INFO - 'sps_profile': False, 03:24:52 INFO - 'sps_profile_interval': 0, 03:24:52 INFO - 'suite': 'dromaeojs-e10s', 03:24:52 INFO - 'system_bits': '32', 03:24:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:52 INFO - 'title': 'talos-linux64-ix-034', 03:24:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:52 INFO - 'use_talos_json': True, 03:24:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:52 INFO - 'work_dir': 'build'} 03:24:52 INFO - [mozharness: 2016-08-10 10:24:52.425754Z] Running clobber step. 03:24:52 INFO - Running pre-action listener: _resource_record_pre_action 03:24:52 INFO - Running main action method: clobber 03:24:52 INFO - rmtree: /builds/slave/test/build 03:24:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:52 INFO - Running post-action listener: _resource_record_post_action 03:24:52 INFO - [mozharness: 2016-08-10 10:24:52.892713Z] Finished clobber step (success) 03:24:52 INFO - [mozharness: 2016-08-10 10:24:52.892814Z] Running read-buildbot-config step. 03:24:52 INFO - Running pre-action listener: _resource_record_pre_action 03:24:52 INFO - Running main action method: read_buildbot_config 03:24:52 INFO - Using buildbot properties: 03:24:52 INFO - { 03:24:52 INFO - "project": "", 03:24:52 INFO - "product": "firefox", 03:24:52 INFO - "script_repo_revision": "production", 03:24:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:24:52 INFO - "repository": "", 03:24:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:24:52 INFO - "buildid": "20160810004000", 03:24:52 INFO - "stage_platform": "linux64-pgo", 03:24:52 INFO - "basedir": "/builds/slave/test", 03:24:52 INFO - "nightly_build": "True", 03:24:52 INFO - "buildnumber": 450, 03:24:52 INFO - "slavename": "talos-linux64-ix-034", 03:24:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:24:52 INFO - "platform": "ubuntu64_hw", 03:24:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:24:52 INFO - "branch": "mozilla-aurora", 03:24:52 INFO - "repo_path": "releases/mozilla-aurora", 03:24:52 INFO - "revision": "e74314c1717e9406417014786f00d06f7c0e8b00", 03:24:52 INFO - "pgo_build": "True", 03:24:52 INFO - "builduid": "07fae4d321c94ce18d7909de04a301ee", 03:24:52 INFO - "slavebuilddir": "test" 03:24:52 INFO - } 03:24:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:24:52 INFO - Running post-action listener: _resource_record_post_action 03:24:52 INFO - [mozharness: 2016-08-10 10:24:52.895356Z] Finished read-buildbot-config step (success) 03:24:52 INFO - [mozharness: 2016-08-10 10:24:52.895445Z] Running download-and-extract step. 03:24:52 INFO - Running pre-action listener: _resource_record_pre_action 03:24:52 INFO - Running main action method: download_and_extract 03:24:52 INFO - mkdir: /builds/slave/test/build/tests 03:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:52 INFO - https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:24:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:24:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:24:52 INFO - retry: Failed, sleeping 30 seconds before retrying 03:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:25:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:25:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:25:22 INFO - retry: Failed, sleeping 60 seconds before retrying 03:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:26:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 INFO - Caught exception: HTTP Error 404: Not Found 03:26:23 INFO - Caught exception: HTTP Error 404: Not Found 03:26:23 INFO - Caught exception: HTTP Error 404: Not Found 03:26:23 INFO - trying https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 INFO - Downloaded 1361 bytes. 03:26:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:26:23 INFO - Using the following test package requirements: 03:26:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'jsshell-linux-x86_64.zip'], 03:26:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:26:23 INFO - retry: Failed, sleeping 30 seconds before retrying 03:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:26:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:26:53 INFO - retry: Failed, sleeping 60 seconds before retrying 03:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - Caught exception: HTTP Error 404: Not Found 03:27:53 INFO - trying https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:54 INFO - Downloaded 21766060 bytes. 03:27:54 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:27:54 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:27:55 INFO - Return code: 0 03:27:55 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:27:55 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:27:55 INFO - https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:27:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:27:55 INFO - retry: Failed, sleeping 30 seconds before retrying 03:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:28:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:28:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:28:25 INFO - retry: Failed, sleeping 60 seconds before retrying 03:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:29:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:25 INFO - Caught exception: HTTP Error 404: Not Found 03:29:25 INFO - Caught exception: HTTP Error 404: Not Found 03:29:25 INFO - Caught exception: HTTP Error 404: Not Found 03:29:25 INFO - trying https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:29:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:26 INFO - Downloaded 21766060 bytes. 03:29:26 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:29:26 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:29:27 INFO - Return code: 0 03:29:27 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:29:27 INFO - https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:29:27 INFO - retry: Failed, sleeping 30 seconds before retrying 03:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:29:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:29:57 INFO - retry: Failed, sleeping 60 seconds before retrying 03:30:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:30:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:58 INFO - Caught exception: HTTP Error 404: Not Found 03:30:58 INFO - Caught exception: HTTP Error 404: Not Found 03:30:58 INFO - Caught exception: HTTP Error 404: Not Found 03:30:58 INFO - trying https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:59 INFO - Downloaded 14413723 bytes. 03:30:59 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:30:59 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:30:59 INFO - Return code: 0 03:30: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:30:59 INFO - https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:30:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:30:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:30:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:30:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:30:59 INFO - retry: Failed, sleeping 30 seconds before retrying 03:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:31:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:31:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:31:29 INFO - retry: Failed, sleeping 60 seconds before retrying 03:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:32:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:32:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:32:29 INFO - Caught exception: HTTP Error 404: Not Found 03:32:29 INFO - Caught exception: HTTP Error 404: Not Found 03:32:29 INFO - Caught exception: HTTP Error 404: Not Found 03:32:29 INFO - trying https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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:32:31 INFO - Downloaded 63749039 bytes. 03:32:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:31 INFO - mkdir: /builds/slave/test/properties 03:32:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:31 INFO - Contents: 03:32:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:32 INFO - Running post-action listener: _resource_record_post_action 03:32:32 INFO - Running post-action listener: set_extra_try_arguments 03:32:32 INFO - [mozharness: 2016-08-10 10:32:32.281345Z] Finished download-and-extract step (success) 03:32:32 INFO - [mozharness: 2016-08-10 10:32:32.281580Z] Running populate-webroot step. 03:32:32 INFO - Running pre-action listener: _resource_record_pre_action 03:32:32 INFO - Running main action method: populate_webroot 03:32:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:32 INFO - '--tppagecycles', 03:32:32 INFO - '7'], 03:32:32 INFO - 'tests': ['tsvgm']}}, 03:32:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['damp', 'tps']}, 03:32:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'tests': ['damp', 'tps']}, 03:32:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['dromaeo_dom']}, 03:32:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['basic_compositor_video']}, 03:32:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:32:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['a11yr', 03:32:32 INFO - 'ts_paint', 03:32:32 INFO - 'tpaint', 03:32:32 INFO - 'sessionrestore', 03:32:32 INFO - 'sessionrestore_no_auto_restore', 03:32:32 INFO - 'tabpaint']}, 03:32:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['tsvgx', 03:32:32 INFO - 'tsvgr_opacity', 03:32:32 INFO - 'tart', 03:32:32 INFO - 'tscrollx', 03:32:32 INFO - 'cart']}, 03:32:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:32 INFO - 'tsvgr_opacity', 03:32:32 INFO - 'tart', 03:32:32 INFO - 'tscrollx', 03:32:32 INFO - 'cart']}, 03:32:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'talos_options': ['--disable-e10s'], 03:32:32 INFO - 'tests': ['tp5o']}, 03:32:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'tests': ['tp5o']}, 03:32:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'talos_options': ['--disable-e10s', 03:32:32 INFO - '--xperf_path', 03:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:32 INFO - 'tests': ['tp5n']}, 03:32:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:32 INFO - 'talos_options': ['--xperf_path', 03:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:32 INFO - 'tests': ['tp5n']}}, 03:32:32 INFO - 'talos.zip': {'path': '', 03:32:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:32 INFO - Running post-action listener: _resource_record_post_action 03:32:32 INFO - [mozharness: 2016-08-10 10:32:32.297297Z] Finished populate-webroot step (success) 03:32:32 INFO - [mozharness: 2016-08-10 10:32:32.297397Z] Running create-virtualenv step. 03:32:32 INFO - Running pre-action listener: _resource_record_pre_action 03:32:32 INFO - Running main action method: create_virtualenv 03:32:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:32:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:32 INFO - Using real prefix '/usr' 03:32:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:34 INFO - Installing pip.................done. 03:32:34 INFO - Return code: 0 03:32:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32: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:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:34 INFO - Using env: {'DISPLAY': ':0', 03:32:34 INFO - 'HOME': '/home/cltbld', 03:32:34 INFO - 'LANG': 'en_US.UTF-8', 03:32:34 INFO - 'LANGUAGE': 'en_US:en', 03:32:34 INFO - 'LOGNAME': 'cltbld', 03:32:34 INFO - 'MAIL': '/var/mail/cltbld', 03:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:34 INFO - 'MOZ_NO_REMOTE': '1', 03:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:34 INFO - 'NO_EM_RESTART': '1', 03:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:34 INFO - 'PWD': '/builds/slave/test', 03:32:34 INFO - 'SHELL': '/bin/bash', 03:32:34 INFO - 'SHLVL': '1', 03:32:34 INFO - 'TERM': 'linux', 03:32:34 INFO - 'TMOUT': '86400', 03:32:34 INFO - 'USER': 'cltbld', 03:32:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:34 INFO - '_': '/tools/buildbot/bin/python'} 03:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:32:35 INFO - Cleaning up... 03:32:35 INFO - Return code: 0 03:32:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:32:35 INFO - Using env: {'DISPLAY': ':0', 03:32:35 INFO - 'HOME': '/home/cltbld', 03:32:35 INFO - 'LANG': 'en_US.UTF-8', 03:32:35 INFO - 'LANGUAGE': 'en_US:en', 03:32:35 INFO - 'LOGNAME': 'cltbld', 03:32:35 INFO - 'MAIL': '/var/mail/cltbld', 03:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:35 INFO - 'MOZ_NO_REMOTE': '1', 03:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:35 INFO - 'NO_EM_RESTART': '1', 03:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:35 INFO - 'PWD': '/builds/slave/test', 03:32:35 INFO - 'SHELL': '/bin/bash', 03:32:35 INFO - 'SHLVL': '1', 03:32:35 INFO - 'TERM': 'linux', 03:32:35 INFO - 'TMOUT': '86400', 03:32:35 INFO - 'USER': 'cltbld', 03:32:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:35 INFO - '_': '/tools/buildbot/bin/python'} 03:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:35 INFO - Downloading/unpacking psutil>=3.1.1 03:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:37 INFO - Installing collected packages: psutil 03:32:37 INFO - Running setup.py install for psutil 03:32:37 INFO - building 'psutil._psutil_linux' extension 03:32:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:32:37 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:32:37 INFO - building 'psutil._psutil_posix' extension 03:32:37 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:32:37 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:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:37 INFO - Successfully installed psutil 03:32:37 INFO - Cleaning up... 03:32:37 INFO - Return code: 0 03:32:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:37 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:37 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:32:37 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:32:37 INFO - Using env: {'DISPLAY': ':0', 03:32:37 INFO - 'HOME': '/home/cltbld', 03:32:37 INFO - 'LANG': 'en_US.UTF-8', 03:32:37 INFO - 'LANGUAGE': 'en_US:en', 03:32:37 INFO - 'LOGNAME': 'cltbld', 03:32:37 INFO - 'MAIL': '/var/mail/cltbld', 03:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:37 INFO - 'MOZ_NO_REMOTE': '1', 03:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:37 INFO - 'NO_EM_RESTART': '1', 03:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:37 INFO - 'PWD': '/builds/slave/test', 03:32:37 INFO - 'SHELL': '/bin/bash', 03:32:37 INFO - 'SHLVL': '1', 03:32:37 INFO - 'TERM': 'linux', 03:32:37 INFO - 'TMOUT': '86400', 03:32:37 INFO - 'USER': 'cltbld', 03:32:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:37 INFO - '_': '/tools/buildbot/bin/python'} 03:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:39 INFO - Installing collected packages: mozsystemmonitor 03:32:39 INFO - Running setup.py install for mozsystemmonitor 03:32:40 INFO - Successfully installed mozsystemmonitor 03:32:40 INFO - Cleaning up... 03:32:40 INFO - Return code: 0 03:32:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:32:40 INFO - Using env: {'DISPLAY': ':0', 03:32:40 INFO - 'HOME': '/home/cltbld', 03:32:40 INFO - 'LANG': 'en_US.UTF-8', 03:32:40 INFO - 'LANGUAGE': 'en_US:en', 03:32:40 INFO - 'LOGNAME': 'cltbld', 03:32:40 INFO - 'MAIL': '/var/mail/cltbld', 03:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:40 INFO - 'MOZ_NO_REMOTE': '1', 03:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:40 INFO - 'NO_EM_RESTART': '1', 03:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:40 INFO - 'PWD': '/builds/slave/test', 03:32:40 INFO - 'SHELL': '/bin/bash', 03:32:40 INFO - 'SHLVL': '1', 03:32:40 INFO - 'TERM': 'linux', 03:32:40 INFO - 'TMOUT': '86400', 03:32:40 INFO - 'USER': 'cltbld', 03:32:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:40 INFO - '_': '/tools/buildbot/bin/python'} 03:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:42 INFO - warning: no files found matching '*.txt' 03:32:42 INFO - no previously-included directories found matching 'build' 03:32:42 INFO - no previously-included directories found matching 'dist' 03:32:42 INFO - no previously-included directories found matching '.git*' 03:32:42 INFO - Installing collected packages: jsonschema, functools32 03:32:42 INFO - Running setup.py install for functools32 03:32:42 INFO - warning: no files found matching '*.txt' 03:32:42 INFO - no previously-included directories found matching 'build' 03:32:42 INFO - no previously-included directories found matching 'dist' 03:32:42 INFO - no previously-included directories found matching '.git*' 03:32:42 INFO - Successfully installed jsonschema functools32 03:32:42 INFO - Cleaning up... 03:32:42 INFO - Return code: 0 03:32:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:32:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:42 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:32:42 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:32:42 INFO - Using env: {'DISPLAY': ':0', 03:32:42 INFO - 'HOME': '/home/cltbld', 03:32:42 INFO - 'LANG': 'en_US.UTF-8', 03:32:42 INFO - 'LANGUAGE': 'en_US:en', 03:32:42 INFO - 'LOGNAME': 'cltbld', 03:32:42 INFO - 'MAIL': '/var/mail/cltbld', 03:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:42 INFO - 'MOZ_NO_REMOTE': '1', 03:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:42 INFO - 'NO_EM_RESTART': '1', 03:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:42 INFO - 'PWD': '/builds/slave/test', 03:32:42 INFO - 'SHELL': '/bin/bash', 03:32:42 INFO - 'SHLVL': '1', 03:32:42 INFO - 'TERM': 'linux', 03:32:42 INFO - 'TMOUT': '86400', 03:32:42 INFO - 'USER': 'cltbld', 03:32:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:42 INFO - '_': '/tools/buildbot/bin/python'} 03:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:32:42 INFO - Cleaning up... 03:32:42 INFO - Return code: 0 03:32:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:42 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:32:42 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:32:42 INFO - Using env: {'DISPLAY': ':0', 03:32:42 INFO - 'HOME': '/home/cltbld', 03:32:42 INFO - 'LANG': 'en_US.UTF-8', 03:32:42 INFO - 'LANGUAGE': 'en_US:en', 03:32:42 INFO - 'LOGNAME': 'cltbld', 03:32:42 INFO - 'MAIL': '/var/mail/cltbld', 03:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:42 INFO - 'MOZ_NO_REMOTE': '1', 03:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:42 INFO - 'NO_EM_RESTART': '1', 03:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:42 INFO - 'PWD': '/builds/slave/test', 03:32:42 INFO - 'SHELL': '/bin/bash', 03:32:42 INFO - 'SHLVL': '1', 03:32:42 INFO - 'TERM': 'linux', 03:32:42 INFO - 'TMOUT': '86400', 03:32:42 INFO - 'USER': 'cltbld', 03:32:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:42 INFO - '_': '/tools/buildbot/bin/python'} 03:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:45 INFO - Downloading docopt-0.6.1.tar.gz 03:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:45 INFO - Running setup.py install for blobuploader 03:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:45 INFO - Running setup.py install for requests 03:32:46 INFO - Running setup.py install for docopt 03:32:46 INFO - Successfully installed blobuploader requests docopt 03:32:46 INFO - Cleaning up... 03:32:46 INFO - Return code: 0 03:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:46 INFO - Running setup.py (path:/tmp/pip-Qmm3sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:46 INFO - Running setup.py (path:/tmp/pip-Euv5ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:46 INFO - Running setup.py (path:/tmp/pip-kBXdWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:46 INFO - Running setup.py (path:/tmp/pip-SIhfpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:46 INFO - Running setup.py (path:/tmp/pip-fZlkVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:46 INFO - Running setup.py (path:/tmp/pip-agG5qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:46 INFO - Running setup.py (path:/tmp/pip-_kcfZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:46 INFO - Running setup.py (path:/tmp/pip-VsNx_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:47 INFO - Running setup.py (path:/tmp/pip-KkjPAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:47 INFO - Running setup.py (path:/tmp/pip-PJPZik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:47 INFO - Running setup.py (path:/tmp/pip-9HASIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:47 INFO - Running setup.py (path:/tmp/pip-WeYjDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:47 INFO - Running setup.py (path:/tmp/pip-EV5Up7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:47 INFO - Running setup.py (path:/tmp/pip-7HGuHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:47 INFO - Running setup.py (path:/tmp/pip-MiQB9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:47 INFO - Running setup.py (path:/tmp/pip-K4pE7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:47 INFO - Running setup.py (path:/tmp/pip-qojvWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:47 INFO - Running setup.py install for manifestparser 03:32:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for mozcrash 03:32:47 INFO - Running setup.py install for mozdebug 03:32:48 INFO - Running setup.py install for mozdevice 03:32:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for mozfile 03:32:48 INFO - Running setup.py install for mozhttpd 03:32:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for mozinfo 03:32:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for mozInstall 03:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for mozleak 03:32:48 INFO - Running setup.py install for mozlog 03:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for moznetwork 03:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Running setup.py install for mozprocess 03:32:48 INFO - Running setup.py install for mozprofile 03:32:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Running setup.py install for mozrunner 03:32:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Running setup.py install for mozscreenshot 03:32:49 INFO - Running setup.py install for moztest 03:32:49 INFO - Running setup.py install for mozversion 03:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:49 INFO - Cleaning up... 03:32:49 INFO - Return code: 0 03:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:49 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:49 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:32:49 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:32:49 INFO - Using env: {'DISPLAY': ':0', 03:32:49 INFO - 'HOME': '/home/cltbld', 03:32:49 INFO - 'LANG': 'en_US.UTF-8', 03:32:49 INFO - 'LANGUAGE': 'en_US:en', 03:32:49 INFO - 'LOGNAME': 'cltbld', 03:32:49 INFO - 'MAIL': '/var/mail/cltbld', 03:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:49 INFO - 'MOZ_NO_REMOTE': '1', 03:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:49 INFO - 'NO_EM_RESTART': '1', 03:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:49 INFO - 'PWD': '/builds/slave/test', 03:32:49 INFO - 'SHELL': '/bin/bash', 03:32:49 INFO - 'SHLVL': '1', 03:32:49 INFO - 'TERM': 'linux', 03:32:49 INFO - 'TMOUT': '86400', 03:32:49 INFO - 'USER': 'cltbld', 03:32:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:49 INFO - '_': '/tools/buildbot/bin/python'} 03:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:49 INFO - Running setup.py (path:/tmp/pip-NtK9_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:49 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:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:49 INFO - Running setup.py (path:/tmp/pip-TMt7k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:49 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:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:49 INFO - Running setup.py (path:/tmp/pip-ROposQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:49 INFO - Running setup.py (path:/tmp/pip-a5TkmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:50 INFO - Running setup.py (path:/tmp/pip-ZDZApk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:50 INFO - Running setup.py (path:/tmp/pip-WP5XWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:50 INFO - Running setup.py (path:/tmp/pip-67mYfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:50 INFO - Running setup.py (path:/tmp/pip-f9dGOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:50 INFO - Running setup.py (path:/tmp/pip-Jbm6nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:50 INFO - Running setup.py (path:/tmp/pip-GLs3Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:50 INFO - Running setup.py (path:/tmp/pip-zOCUWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:50 INFO - Running setup.py (path:/tmp/pip-4CbZBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:50 INFO - Running setup.py (path:/tmp/pip-S6UOq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:50 INFO - Running setup.py (path:/tmp/pip-x1So4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:50 INFO - Running setup.py (path:/tmp/pip-6qZCik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:50 INFO - Running setup.py (path:/tmp/pip-cwMWb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:50 INFO - Running setup.py (path:/tmp/pip-DJ0V29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:52 INFO - Downloading blessings-1.6.tar.gz 03:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:52 INFO - Installing collected packages: blessings 03:32:52 INFO - Running setup.py install for blessings 03:32:53 INFO - Successfully installed blessings 03:32:53 INFO - Cleaning up... 03:32:53 INFO - Return code: 0 03:32:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:53 INFO - Reading from file tmpfile_stdout 03:32:53 INFO - Current package versions: 03:32:53 INFO - argparse == 1.2.1 03:32:53 INFO - blessings == 1.6 03:32:53 INFO - blobuploader == 1.2.4 03:32:53 INFO - docopt == 0.6.1 03:32:53 INFO - functools32 == 3.2.3-2 03:32:53 INFO - jsonschema == 2.5.1 03:32:53 INFO - manifestparser == 1.1 03:32:53 INFO - mozInstall == 1.12 03:32:53 INFO - mozcrash == 0.17 03:32:53 INFO - mozdebug == 0.1 03:32:53 INFO - mozdevice == 0.48 03:32:53 INFO - mozfile == 1.2 03:32:53 INFO - mozhttpd == 0.7 03:32:53 INFO - mozinfo == 0.9 03:32:53 INFO - mozleak == 0.1 03:32:53 INFO - mozlog == 3.3 03:32:53 INFO - moznetwork == 0.27 03:32:53 INFO - mozprocess == 0.23 03:32:53 INFO - mozprofile == 0.28 03:32:53 INFO - mozrunner == 6.12 03:32:53 INFO - mozscreenshot == 0.1 03:32:53 INFO - mozsystemmonitor == 0.3 03:32:53 INFO - moztest == 0.7 03:32:53 INFO - mozversion == 1.4 03:32:53 INFO - psutil == 3.1.1 03:32:53 INFO - requests == 1.2.3 03:32:53 INFO - wsgiref == 0.1.2 03:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:53 INFO - Using env: {'DISPLAY': ':0', 03:32:53 INFO - 'HOME': '/home/cltbld', 03:32:53 INFO - 'LANG': 'en_US.UTF-8', 03:32:53 INFO - 'LANGUAGE': 'en_US:en', 03:32:53 INFO - 'LOGNAME': 'cltbld', 03:32:53 INFO - 'MAIL': '/var/mail/cltbld', 03:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:53 INFO - 'MOZ_NO_REMOTE': '1', 03:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:53 INFO - 'NO_EM_RESTART': '1', 03:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:53 INFO - 'PWD': '/builds/slave/test', 03:32:53 INFO - 'SHELL': '/bin/bash', 03:32:53 INFO - 'SHLVL': '1', 03:32:53 INFO - 'TERM': 'linux', 03:32:53 INFO - 'TMOUT': '86400', 03:32:53 INFO - 'USER': 'cltbld', 03:32:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:53 INFO - '_': '/tools/buildbot/bin/python'} 03:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 INFO - Cleaning up... 03:32:53 INFO - Return code: 0 03:32:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32: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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:53 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 0x2a9e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ccd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', '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:32:53 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:32:53 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:32:53 INFO - Using env: {'DISPLAY': ':0', 03:32:53 INFO - 'HOME': '/home/cltbld', 03:32:53 INFO - 'LANG': 'en_US.UTF-8', 03:32:53 INFO - 'LANGUAGE': 'en_US:en', 03:32:53 INFO - 'LOGNAME': 'cltbld', 03:32:53 INFO - 'MAIL': '/var/mail/cltbld', 03:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:53 INFO - 'MOZ_NO_REMOTE': '1', 03:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:53 INFO - 'NO_EM_RESTART': '1', 03:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:53 INFO - 'PWD': '/builds/slave/test', 03:32:53 INFO - 'SHELL': '/bin/bash', 03:32:53 INFO - 'SHLVL': '1', 03:32:53 INFO - 'TERM': 'linux', 03:32:53 INFO - 'TMOUT': '86400', 03:32:53 INFO - 'USER': 'cltbld', 03:32:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:53 INFO - '_': '/tools/buildbot/bin/python'} 03:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:53 INFO - Cleaning up... 03:32:53 INFO - Return code: 0 03:32:53 INFO - Running post-action listener: _resource_record_post_action 03:32:53 INFO - Running post-action listener: _start_resource_monitoring 03:32:53 INFO - Starting resource monitoring. 03:32:53 INFO - [mozharness: 2016-08-10 10:32:53.754962Z] Finished create-virtualenv step (success) 03:32:53 INFO - [mozharness: 2016-08-10 10:32:53.755397Z] Running install step. 03:32:53 INFO - Running pre-action listener: _resource_record_pre_action 03:32:53 INFO - Running main action method: install 03:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:53 INFO - Reading from file tmpfile_stdout 03:32:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:54 INFO - Reading from file tmpfile_stdout 03:32:54 INFO - Output received: 03:32:54 INFO - Usage: mozinstall [options] installer 03:32:54 INFO - Options: 03:32:54 INFO - -h, --help show this help message and exit 03:32:54 INFO - -d DEST, --destination=DEST 03:32:54 INFO - Directory to install application into. [default: 03:32:54 INFO - "/builds/slave/test"] 03:32:54 INFO - --app=APP Application being installed. [default: firefox] 03:32:54 INFO - mkdir: /builds/slave/test/build/application 03:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:10 INFO - Reading from file tmpfile_stdout 03:33:10 INFO - Output received: 03:33:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:10 INFO - Running post-action listener: _resource_record_post_action 03:33:10 INFO - [mozharness: 2016-08-10 10:33:10.030537Z] Finished install step (success) 03:33:10 INFO - [mozharness: 2016-08-10 10:33:10.030810Z] Running run-tests step. 03:33:10 INFO - Running pre-action listener: _resource_record_pre_action 03:33:10 INFO - Running main action method: run_tests 03:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:10 INFO - Python 2.7.3 03:33:10 INFO - Return code: 0 03:33:10 INFO - grabbing minidump binary from tooltool 03:33: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:33:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5c570>, '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 0x2d5d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:33:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:33:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:10 INFO - Return code: 0 03:33:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:33:10 INFO - Using env: {'DISPLAY': ':0', 03:33:10 INFO - 'HOME': '/home/cltbld', 03:33:10 INFO - 'LANG': 'en_US.UTF-8', 03:33:10 INFO - 'LANGUAGE': 'en_US:en', 03:33:10 INFO - 'LOGNAME': 'cltbld', 03:33:10 INFO - 'MAIL': '/var/mail/cltbld', 03:33:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:10 INFO - 'MOZ_NO_REMOTE': '1', 03:33:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:10 INFO - 'NO_EM_RESTART': '1', 03:33:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:10 INFO - 'PWD': '/builds/slave/test', 03:33:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:10 INFO - 'SHELL': '/bin/bash', 03:33:10 INFO - 'SHLVL': '1', 03:33:10 INFO - 'TERM': 'linux', 03:33:10 INFO - 'TMOUT': '86400', 03:33:10 INFO - 'USER': 'cltbld', 03:33:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437', 03:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:10 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:33:10 INFO - mozversion application_buildid: 20160810004000 03:33:10 INFO - mozversion application_changeset: e74314c1717e9406417014786f00d06f7c0e8b00 03:33:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:10 INFO - mozversion application_name: Firefox 03:33:10 INFO - mozversion application_remotingname: firefox-dev 03:33:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:10 INFO - mozversion application_vendor: Mozilla 03:33:10 INFO - mozversion application_version: 50.0a2 03:33:10 INFO - mozversion platform_buildid: 20160810004000 03:33:10 INFO - mozversion platform_changeset: e74314c1717e9406417014786f00d06f7c0e8b00 03:33:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:10 INFO - mozversion platform_version: 50.0a2 03:33:10 INFO - using testdate: 1470825190 03:33:10 INFO - actual date: 1470825190 03:33:10 INFO - starting webserver on 'localhost:51434' 03:33:10 INFO - SUITE-START | Running 2 tests 03:33:10 INFO - TEST-START | dromaeo_css 03:33:10 INFO - operating with platform_type : linux_ 03:33:10 INFO - Initialising browser for dromaeo_css test... 03:33:10 INFO - TEST-INFO | started process 19977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKH3DVi/profile http://localhost:51434/getInfo.html) 03:33:14 INFO - PROCESS | 19977 | __metrics Screen width/height:1600/1200 03:33:14 INFO - PROCESS | 19977 | colorDepth:24 03:33:14 INFO - PROCESS | 19977 | Browser inner width/height: 1024/697 03:33:14 INFO - PROCESS | 19977 | __metrics 03:33:15 ERROR - PROCESS | 19977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:33:16 INFO - TEST-INFO | 19977: exit 0 03:33:16 INFO - Browser initialized. 03:33:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:16 INFO - TEST-INFO | started process 20105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKH3DVi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:28 INFO - PROCESS | 20105 | RSS: Main: 151879680 03:33:28 INFO - PROCESS | 20105 | 03:34:17 INFO - PROCESS | 20105 | 1470825257909 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:36:26 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51434/tests/dromaeo/cssquery-ext.html) 03:36:27 INFO - PROCESS | 20105 | RSS: Main: 157409280 03:36:27 INFO - PROCESS | 20105 | 03:39:29 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-ext.html (next: http://localhost:51434/tests/dromaeo/cssquery-jquery.html) 03:39:30 INFO - PROCESS | 20105 | RSS: Main: 154275840 03:39:30 INFO - PROCESS | 20105 | 03:42:31 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51434/tests/dromaeo/cssquery-mootools.html) 03:42:32 INFO - PROCESS | 20105 | RSS: Main: 154517504 03:42:32 INFO - PROCESS | 20105 | 03:45:34 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51434/tests/dromaeo/cssquery-prototype.html) 03:45:34 INFO - PROCESS | 20105 | RSS: Main: 153145344 03:45:34 INFO - PROCESS | 20105 | 03:48:37 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51434/tests/dromaeo/cssquery-yui.html) 03:48:37 INFO - PROCESS | 20105 | RSS: Main: 155205632 03:48:37 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-yui.html (next: http://localhost:51434/tests/dromaeo/cssquery-dojo.html) 03:51:40 INFO - PROCESS | 20105 | RSS: Main: 155549696 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | __start_tp_report 03:51:40 INFO - PROCESS | 20105 | _x_x_mozilla_page_load 03:51:40 INFO - PROCESS | 20105 | _x_x_mozilla_page_load_details 03:51:40 INFO - PROCESS | 20105 | |i|pagename|runs| 03:51:40 INFO - PROCESS | 20105 | |0;dojo.html;3283.638799732029;3300.587426571677;3316.3864685033273;3329.450640644294;3332.083676988828;5749.971250143749;5751.051076572371;5754.539636829054;5803.709814509273;5844.853878653025;5735.512481439072;5771.989901767184;5776.335721392041;5788;5806;5258.526732594075;5275.393329767068;5300.09898317285;5331.973340133294;5365.168398898177;5162.045021671003;5169.612279079065;5209.244659524366;5215.869603259911;5232.92150617741;5238.13570760824;5267.051930652481;5274.604404669646;5344.839654810343;5420;5314.043472175026;5316.468353164652;5316.9202461963105;5325.840224793243;5347.812826551091;5084.3644544431945;5126.282320475137;5161.845144645667;5226.085435048852;5288.68267903927;5465.9180112298345;5708.343540492855;5714.228579141804;5728.68492232927;5739.368669446358;6102.298235702907;6109.7861574844665;6152.600080994721;6153.846153846145;6156.507479401637;6072.210612620375;6079.726412311456;6207.068939659042;6220.720067596969;6245.875082498324;5704.885902281972;5778.27771528559;5784;5804.738786754564;5828.388019258002;6325.861344957952;6337.936620633827;6339.334369891095;6348.523860710465;6354.4281014708895;5936.347001829881;6019.729112189962;6032.698365081728;6074.119252708332;6078.787242446581;6131.621347939075;6144.617461071312;6145.801568694062;6146.692665366714;6152.78465253714;6067.059605761114;6082.422169893853;6095.603785753912;6098.878022439526;6107.389261073946;5943.5839491236065;6060.939390606038;6087.96956015226;6098;6122.7244773984385;4698.624110071186;4726.787294571753;4733.857984260478;4765.213739732905;4768.785404656799;4171.270027745132;4181.142865712522;4203.579642035772;4227.070044590185;4232.513260975027;5721.914171287434;5749.1663708762;5928.703564821742;5945.316288626776;5954.702264886739;6089.969550152309;6180.258368995659;6208.410201030895;6211.689415529206;6235.563510554218;5859.589828711949;5891.499222566044;5923.555733320019;5930.258717660293;5953.404659534099;5183.222516622537;5217.739113044333;5327.840164795062;5332.466753324637;5345.198220266913;6217.440430361289;6356.269029061717;6357.205349331333;6370.58591191571;6387.137736405526;6163.19878415803;6164.568480206342;6166.383361663888;6178.907316390348;6182.350853160354;6143.849652621725;6246.718897649525;6366.681665916593;6371.267304260069;6389.233292004989;6018.247719035121;6122.173506576733;6131.595232866953;6132.386102851662;6132.477886260874;6175.2589689237575;6210.844728881633;6224.2842073160355;6234.688265586793;6235.033569796688;5935.258092738408;5970.134330522137;6068.089786531879;6072.332043475126;6091.147239386578;5955;5992.280926288873;6060.272767267956;6084.543659225487;6108.08378743192;5955.67243801595;5995.100734889801;5995.700214989146;6002.039673652194;6003.099535069775;5946.048632218997;5951.49412299942;6018.699065046818;6042.697865106815;6049.334573197033;5842.649441033552;5946.137810017437;5960.165576819162;5969.403059693996;5985.162077309094 03:51:40 INFO - PROCESS | 20105 | |1;ext.html;583.5710752596841;647.9902801457978;667.3026687111967;672.5897202706349;711.8967749676294;41032.589674103285;46269.537304626945;46336;46338;46449.53550464494;46116;46653.53346466534;46676.533234667644;46698;46901.765491172584;9067.183953444188;9210.032946540618;9241;9255.537223138816;9259.953700231523;9236.67671631493;9251.676191333305;9284.442933424016;9285.814283714322;9312.115349041831;9332.39339442934;9349.719508414759;9358.532073396304;9361.48511831849;9380.108889655507;9193.494357810318;9252.444853308823;9253.213476854475;9260.212881905047;9287.442753434816;9176.8623470648;9249.213816825579;9263.583138758771;9265.258779297708;9267.582958766872;44011.47908167339;44068.3389749154;44102.117957640665;44457.11085778266;44478.55521444776;3657.140571965586;3743.7005039596766;3853.865114720971;4362.520122786491;4435.334699795024;34867.476987845206;35335.293294133975;35572.822135889415;35613.109672258404;36777.448338274946;4087.264292427362;4146.896327591804;4183.4979802423595;4214.557471465513;4229.407882896397;369225;369899;370148;370693;371116.1444192789;38342.80828595839;39712.60287397089;64013.67993160005;64057.359426406074;64446;38849.611503885164;39039.414408783894;39112.413313800316;39114.413283800764;39229.80385098056;15938.760918586231;15959.521214363587;16070.919645401931;16117.355305787873;16121;13354.265515396746;13463.124896881867;13542.864571354357;13557.796633050511;13576.456941722221;8960.283177345797;8969.058248883905;9094.818103638023;9133.588988495534;9163.633454661873;3387.9502900744696;3474.5483087198504;3499.650034996531;3526.506289119474;3544;1052.7578656908954;1054.9683509494728;1125.3697929159532;1134.9489272982735;1156.8264760286024;31488.473370890115;32821.835890820395;32963.50554741681;33073.32293291753;33141.50287745686;1157.0685598093448;1172.191188080239;1175.4122938530734;1194.6774370919802;1194.6893807610084;17671.73492397615;17715.468535943943;17888.28446862111;17892;17947.282108715764;614082;615371;625322;626708;628954;64663;65409.67295163589;65443.67278163579;65650;66036;1420.4034305591676;1449.5361484324915;1450.260367212729;1451.4194322271176;1474.786156007373;32187;32941.67058329482;33934.66065339414;34083.65916340805;34371.828140859136;55296.72351638216;55572;56136.43863561312;56177.43822561722;56202.43797562135;421884;423543;423832;426094;426451;30992.535111972888;31079;31438;31614.893478728132;31675.841620791747;51081.74459127681;51471;51488.742556286976;52656.736716316176;52775;42885.356719648604;48262.75868620635;48328.275075873185;49026.509734902196;49325.2601210975;45598.54401455943;46040.7697961508;46432;46651.18291548708;46728.532714672416;45150;45261.77369113265;45314;45384.77307613441;45455.54544454513;37798;39809;40133.397999029454;40367.59632403756;40613.79693101515;30138.54792178163;30775.2306192347;30828.691713082582;30994.845025774728;31111.53332699966 03:51:40 INFO - PROCESS | 20105 | |2;jquery.html;418.7906046976512;421.2320078885266;426.086045432547;430.1847998043707;439.2269605494329;19055;20686.27598034069;20960.790392096093;20967.790322096775;21561.568768624657;20427.897860510715;20440.72041984733;20986.265480708178;21203;21332.89333553334;5729.656220626765;5870.530357571384;5918.082697181922;5943.108533719934;5948.167256584082;5594;5819.534437245032;5849.64902105875;5861.677607731573;5929.169916211734;5724.055530837428;5797.768089276424;5875.794347197849;5884.293884733816;5891.734871930774;5762.423757624225;5852.297724273072;5959.344472108086;6107;6107.083937409379;5691.146328050825;6042.697865106771;6109.5723299369065;6113.480354169901;6131.080337949299;14950.177740224284;15231.162286074261;18987.810121898743;24732.876335618388;24961.251162465156;2430.7812296893367;2444.6944131983323;2598.038725671495;2663.533881570737;2902.2889392099073;10579.576816927314;10610.204234682353;10813.945930270298;10991.120710343153;11177.552897884076;1892.8391086757642;1938.8545859060628;1967.45894878908;1982.1575830272077;1989.1446677928484;76519.61740191319;83620.99999999939;84994.15005849986;86579;87794.56102719446;9618;10234.897651023542;10401.063904248502;10413.791724165474;10670.786584268426;14418.13491190532;14447.349869255908;14463.27683615815;14508.927455362656;14524;8297.58512074394;8413.52763266426;8421.621027053798;8481.533515656698;8557.914420855712;8460.703875364332;8511.446755960842;8573.31413486932;8580.227779499875;8703.347248956354;4378.540253273361;4394.318880573516;4426.933595996063;4472.306792447176;4513.119941611354;1982.2764690887723;2035.2571311471206;2056.4961584411617;2142.1752625239396;2182.7598964113936;1010.4240582867842;1017.8931212222758;1037.4242295525905;1044.738815296176;1112.8887111288807;20470.38588842337;20533.794662053486;20908;21104.89447552783;21580;1033.6330602635956;1047.314009323894;1054.177741361739;1063.547992103353;1095.085603521053;11015.394153321484;11385.487653055632;11495.827562586568;11667.59163429276;11872.76254474923;517954;520013;522430;526914;530374;92049.53975230081;94629;100289.49855250678;100458;101597;986.5018165826211;999.820032394176;1015.4973288222377;1018.6994836523244;1029.5572903651353;17971.820281797016;18235.66596815406;18425.63148736991;18482.445526634223;18601;35943.281134376644;41669.79165104155;42566.574334256264;43393;43482.34776478419;59819;60708.392916070276;61382;61656.383436166856;62791.372086278556;8035.357171426389;8100.71647492335;8195.770634404887;8503.362247831561;8939.59771810257;12185.451654675384;12792.936035319764;12897.290649014394;12948.8057679133;13084.476620935437;11135.777284454427;11201.719957000814;11564.306141631529;11628.302301861915;11668.241564298294;11075.944620277169;11357.829632555353;11384.601538946097;11764.352960586908;11834.171607987702;11133.276337038067;11246.943765281121;11309.830352544554;11436.1422893285;11554.017908477874;7861.8034549134445;7992.40056995716;7996.046898162511;8077.474964127313;8224;10891.128709703364;11020.779584408427;11155.44222788841;11171.273867198606;11420.371879546705 03:51:40 INFO - PROCESS | 20105 | |3;mootools.html;1537.1315206908096;1574.5119013105934;1752.3779058434257;1758.7361895715649;1826.926922923084;8667.13328667133;8942.821143577132;8987.59555819988;9416.246700263979;9494.477803720793;8931.062238464949;9141.725748227547;9304.069593040693;9354.62581496741;9382.202512786422;2367.550165468564;2403.8677872716994;2425.684660994077;2428.7206971198275;2431.744666809986;2416.66166736657;2417.4198192433864;2469.76537228963;2474.39377352548;2480.6899137607797;2415.9637605435933;2430.404550885036;2458.754124587536;2465.7410971847967;2494.48862983088;2383.8688872112025;2393.9401514962265;2408.458096928186;2416.2026531244733;2421.903123875043;2381.0356805493802;2396.101461951768;2402.303332033708;2402.531506356261;2422.4428381472185;9472.526373681358;9538.713838584854;9545.47499887506;9581.904180958241;9584.329096963216;5418.160185171266;5542.722863856831;5613.494785469327;5617.241672374218;5620.5503559715125;3351.1957130288556;3399.558057452515;3439.1917899293644;3492.7904325740283;3514.841832117561;973.6689525561272;984.714432814483;1000.7147962830632;1007.0584003956325;1011.2314640872916;13014.284214368206;13399.397027133802;13434.059615826896;13452.058355915187;13497.460101596023;4895.951040489549;4941.2835138905375;4951.950480495221;5009.699418034929;5181.53366197044;11372.829407558893;11402.94298528502;11417.942910285561;11437.256578322382;11447.427628618536;5556.944430555724;5563.693996830132;5576.804811831566;5597.244372009808;5603.355614104348;4532.161550113174;5081.542661160439;5114.360704911886;5201.6358854880555;5228.320318358589;4321.719088259316;4378.190034843564;4383.145286669069;4419.602235798793;4423.800928958204;1386.4592808804575;1389.4095009621074;1399.6500874781304;1400.4958215042577;1412.8233970753656;983.9262055345878;984.8965858584888;1008.8284991551454;1020.2195320579763;1049.2340591368343;6055.788047418408;6265.843353916098;6266.965950618188;6273.341299163613;6484.740610375627;451.8531477269835;459.6139243035866;464.64454692160524;470.8752180672125;471.5520255757045;4457.554244575516;4458.7547684877645;4480.955190448054;4550.431196100488;4554.3851580036935;11249.943750281196;11333.376664283378;11372.374519401346;11400.600978965696;11827.290362578273;11150.49822757978;11633.302001879914;11707.063434925356;11844.052475801915;11918.880811191777;8263.256306932404;8416.915830841735;8424.705135320235;8433;8498.107698691549;6399.64801935898;6477.060826180272;6550.868982620416;6564.8358791030605;6709.93290067093;10612.734681633021;10888.51001704941;10917.181211409017;10941.890581094087;11014.559417623526;10752.623658171926;11163.106951443702;11202.38386888729;11347.546098156312;11373.601923932623;7662.923370766221;8229.341652667892;8498.830023399374;8508.914910850812;8523.147685231675;9157.86263206039;9189.081091890757;9242.306826988137;9243.491607961627;9249.491277979776;7911.28798408146;8182.304504117216;8230.876536852073;8279.047909490244;8538.871916921375;7801.45389822707;7830.8825367620675;7893.960530197312;7970.322522585413;8046.155153708776;7068.752593659197;7161.928380716335;7168.032315637322;7203.567785932861;7332.450066244946;5225.320708307896;5309;5377.596680248918;5460.6996615186545;5567.359753628222;5531.8893622128135;5622.437756224344;5637.943620563906;5650.067738823048;5668.489835914623 03:51:40 INFO - PROCESS | 20105 | |4;prototype.html;333.19034745568274;350.4585415533001;356.3247645711377;356.4225953954594;357.27116681968783;5715.457031582004;5739.483446489815;5857.941420585793;5868;5927.407259274081;5706.543476521879;5747.971260143704;5748.5688573357065;5762.4525670061275;5765.924267263782;4331.7400955942585;4487.214737420946;4505.504394516601;4514.841980530682;4519.34469501922;4467.553244675522;4469.687121901468;4471.709338892962;4480.260756975095;4483.444436671099;4407.250767369539;4420.8010639521135;4425.849279187402;4431.357453169288;4455.732656040632;4396.582324679151;4419.182451246497;4422.336649502568;4479.731216127043;4480.171168333869;3834.731568790186;3840.7311488195837;3868.723321303963;3877.670398016172;3908.6515152272423;5582.580032962126;5599.216109744639;5599.496045355938;5599.580031497654;5613.764971706218;5063.316452278968;5082.313887625197;5121.871953201163;5140.203268493389;5150;5962.344142144404;5988.940110598882;6000.609960352606;6002.459778619901;6036.486898613623;4240.554741752133;4274.529801721839;4276.828926842923;4296.63478604319;4309.6336811371075;5561.694106824123;6139.293981192175;6325.652089135096;6410.67946602668;6459.67701614922;4364.672649551297;4381.291296394409;4389.144116897238;4440.600345968814;4443.488998765183;4479.977600111979;4493.550644935481;4518.751468669255;4522.819087236474;4529.987558273777;5002.574781143643;5120.718360490208;5147.6911385317;5177.378714554277;5214.947850521522;6068.726907289182;6074.271087469444;6077.9392206078255;6083.817485475354;6097;1540.3761476601994;1555.3700751195784;1557.509384543865;1569.4977607165827;1574.527641707483;970.2722957781664;986.329296078659;998.5157198758596;1013.601230302193;1033.3489901362093;5169.53474187325;5185.637005409585;5205.538317019215;5224.738763061831;5227.320448341691;5470.234167216593;5492.368377636623;5496.615236933456;5523;5528.7235638218735;4828.058528586892;5184.533391994739;5208.817691380859;5214.84355469329;5252.711100889488;2894.8552572371295;2906.6076079729387;2922.6346706661666;2928.326484908483;2944.4994350960387;5539.390667026624;5603.915941260884;5654.5193658538665;5666.263385759825;5699.8860022800145;5309.247948177092;5528.281323427928;5549.500544950974;5554.139108438118;6150.200473938449;6299.937000629935;6413.422791948654;6463.967680161569;6471.579347342407;6490.545661803629;6239.410644582447;6256.374362563707;6259.874802504016;6269.83690626733;6275.309715931153;5961.701914904324;6130.938690613037;6145.754169833157;6174.722137503733;6202.100695399232;6482.740690372332;6495.265222497177;6501.9674901625185;6504.60972341661;6534.869302613826;4386.780660967002;4426.9778651106535;4432.825301295224;4466.218411777991;4481.417415735934;6182.165407669907;6183.783567575113;6189.938100618936;6226.968865155645;6274.749010039547;5897.292324920865;6076.179715738319;6099.542534309856;6156.968200493737;6203.193584833943;6022.849428764316;6084.235571684162;6092.512598991982;6097.469550136643;6098.512119030555;6004.339522652592;6036.3058248302;6037.667928263988;6043.972524670904;6051.5461340400525;5783.3638299787835;6070.362611925684;6077.969610151921;6099.329073801967;6150.723217455135;5935.495482884004;5968.641881487125;5985.970070149621;6009.437546237922;6040.969795150996 03:51:40 INFO - PROCESS | 20105 | |5;yui.html;741.6254791330381;785.8899754034433;860.3289434241292;867.1155421470103;874.7856775090104;15092.320845561948;17325.393611223593;17668.38160664377;17929.372471963485;17962.730559041625;15860.603484912854;16071.276792544335;16100.677986440263;16132.919335403336;16146.83853161468;724.3842733676386;865.4936861935776;868.5049521772593;890.66154861153;893.1113542025694;884.6107712606465;888.3071204460499;889.4618755652834;890.0120865838913;890.1721399098835;942.7313215733517;943.7546237978106;944.7118628818208;947.7630592351912;949.5015117063527;937.9062093790567;939.539625583466;940.7318914109514;941.8210539997413;943.8725772020758;692.3146085375492;696.2897844198889;698.2877464985737;700.0164768500265;702.0662518849917;16111.355545778271;16281.104539250337;16319.592010199722;16324.836751632569;16344.101074440901;15560;15979.840201597952;16314.428994985237;16956.576085597837;16972.066536340495;12635.74728505434;12896.87103128966;12910.87089129106;12974.286414247212;13383.330833458289;4015.959840401588;4031.596840315974;4146;4249.978750106261;4258.127083947783;80699;80858.13837730214;80903;82305.58847205725;82342;12023.519059237533;12140;12146.453409596412;12268.509259629693;12316.568920087753;20867.791322086887;21322.573548528944;21420.78579214219;21774.237901673365;21859.344219673436;9007.63969441215;9230.907690923004;9283.11810378013;9332.300077494216;9339.112784285482;4840.1287768201355;4953.554180123806;4999.200127979506;5022.070916880389;5118.948810511847;3815.9618403815607;3918.49059622253;3926.725129240983;3942.6845852331744;3984.8007599620482;682.2767866061891;684.466116429176;697.9755708550176;698.6157613312657;706.0742272962345;662.2715013485127;710.3354801689812;728.3917928529631;767.6852490478877;781.4646966827742;10133.594656213669;10189.694309170736;10604.681859544226;10882.727931801768;11002.50488728009;672.277301900459;696.2584847137782;707.6850801393331;727.2763600217817;728.2717282717283;4918.778654960535;4979.551840334315;4997.250412438163;5047.873803154877;5064.290999260106;109632;128751;130697.34651326682;134144;137736;113349;118245;118559.40720296343;120015.39992299983;120354.3982280083;102562;103103.96896031094;103363;103856.48071759744;108821;9234.215091717278;9356.391834530734;9462.195713364441;9674.467904265051;10037;41441;52932.470675294295;54886;56551;56679;81940;88554.55722721345;89965;90292.09707902838;91391.54304228703;12255.754884902073;12368.381580920737;12419.627411177678;12650.43073061696;12741.872581274069;13612.65968350799;13658.863411365759;13699.726005479635;13731.794023089862;14199.929000354932;13212.933935330262;13272.668183295109;13296.202227866359;13312.201267923569;13482.19106853592;13912.176643572826;13955.930220348833;14105.717885642434;14108.717825643223;14548.272586370427;12711;12815.295158766357;12982.285974271506;13090;13340.399682014528;10792.08267297257;10970.945145274542;11100.722481937693;11367.943160284145;11491.885081149416;12259.203151795105;12659.11386202957;12698.492060317853;12895.226286422845;13188.142770720257 03:51:40 INFO - PROCESS | 20105 | __end_tp_report 03:51:40 INFO - PROCESS | 20105 | __start_cc_report 03:51:40 INFO - PROCESS | 20105 | _x_x_mozilla_cycle_collect,325 03:51:40 INFO - PROCESS | 20105 | __end_cc_report 03:51:40 INFO - PROCESS | 20105 | __startTimestamp1470826300429__endTimestamp 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | ------- Summary: start ------- 03:51:40 INFO - PROCESS | 20105 | Number of tests: 6 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#0] dojo.html Cycles:165 Average:5724.78 Median:5955.00 stddev:646.13 (10.9%) stddev-sans-first:619.09 03:51:40 INFO - PROCESS | 20105 | Values: 3283.6 3300.6 3316.4 3329.5 3332.1 5750.0 5751.1 5754.5 5803.7 5844.9 5735.5 5772.0 5776.3 5788.0 5806.0 5258.5 5275.4 5300.1 5332.0 5365.2 5162.0 5169.6 5209.2 5215.9 5232.9 5238.1 5267.1 5274.6 5344.8 5420.0 5314.0 5316.5 5316.9 5325.8 5347.8 5084.4 5126.3 5161.8 5226.1 5288.7 5465.9 5708.3 5714.2 5728.7 5739.4 6102.3 6109.8 6152.6 6153.8 6156.5 6072.2 6079.7 6207.1 6220.7 6245.9 5704.9 5778.3 5784.0 5804.7 5828.4 6325.9 6337.9 6339.3 6348.5 6354.4 5936.3 6019.7 6032.7 6074.1 6078.8 6131.6 6144.6 6145.8 6146.7 6152.8 6067.1 6082.4 6095.6 6098.9 6107.4 5943.6 6060.9 6088.0 6098.0 6122.7 4698.6 4726.8 4733.9 4765.2 4768.8 4171.3 4181.1 4203.6 4227.1 4232.5 5721.9 5749.2 5928.7 5945.3 5954.7 6090.0 6180.3 6208.4 6211.7 6235.6 5859.6 5891.5 5923.6 5930.3 5953.4 5183.2 5217.7 5327.8 5332.5 5345.2 6217.4 6356.3 6357.2 6370.6 6387.1 6163.2 6164.6 6166.4 6178.9 6182.4 6143.8 6246.7 6366.7 6371.3 6389.2 6018.2 6122.2 6131.6 6132.4 6132.5 6175.3 6210.8 6224.3 6234.7 6235.0 5935.3 5970.1 6068.1 6072.3 6091.1 5955.0 5992.3 6060.3 6084.5 6108.1 5955.7 5995.1 5995.7 6002.0 6003.1 5946.0 5951.5 6018.7 6042.7 6049.3 5842.6 5946.1 5960.2 5969.4 5985.2 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#1] ext.html Cycles:180 Average:63357.61 Median:234668.18 stddev:128952.79 (55.0%) stddev-sans-first:129228.40 03:51:40 INFO - PROCESS | 20105 | Values: 583.6 648.0 667.3 672.6 711.9 41032.6 46269.5 46336.0 46338.0 46449.5 46116.0 46653.5 46676.5 46698.0 46901.8 9067.2 9210.0 9241.0 9255.5 9260.0 9236.7 9251.7 9284.4 9285.8 9312.1 9332.4 9349.7 9358.5 9361.5 9380.1 9193.5 9252.4 9253.2 9260.2 9287.4 9176.9 9249.2 9263.6 9265.3 9267.6 44011.5 44068.3 44102.1 44457.1 44478.6 3657.1 3743.7 3853.9 4362.5 4435.3 34867.5 35335.3 35572.8 35613.1 36777.4 4087.3 4146.9 4183.5 4214.6 4229.4 369225.0 369899.0 370148.0 370693.0 371116.1 38342.8 39712.6 64013.7 64057.4 64446.0 38849.6 39039.4 39112.4 39114.4 39229.8 15938.8 15959.5 16070.9 16117.4 16121.0 13354.3 13463.1 13542.9 13557.8 13576.5 8960.3 8969.1 9094.8 9133.6 9163.6 3388.0 3474.5 3499.7 3526.5 3544.0 1052.8 1055.0 1125.4 1134.9 1156.8 31488.5 32821.8 32963.5 33073.3 33141.5 1157.1 1172.2 1175.4 1194.7 1194.7 17671.7 17715.5 17888.3 17892.0 17947.3 614082.0 615371.0 625322.0 626708.0 628954.0 64663.0 65409.7 65443.7 65650.0 66036.0 1420.4 1449.5 1450.3 1451.4 1474.8 32187.0 32941.7 33934.7 34083.7 34371.8 55296.7 55572.0 56136.4 56177.4 56202.4 421884.0 423543.0 423832.0 426094.0 426451.0 30992.5 31079.0 31438.0 31614.9 31675.8 51081.7 51471.0 51488.7 52656.7 52775.0 42885.4 48262.8 48328.3 49026.5 49325.3 45598.5 46040.8 46432.0 46651.2 46728.5 45150.0 45261.8 45314.0 45384.8 45455.5 37798.0 39809.0 40133.4 40367.6 40613.8 30138.5 30775.2 30828.7 30994.8 31111.5 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#2] jquery.html Cycles:180 Average:30311.88 Median:21570.78 stddev:86348.87 (400.3%) stddev-sans-first:86561.93 03:51:40 INFO - PROCESS | 20105 | Values: 418.8 421.2 426.1 430.2 439.2 19055.0 20686.3 20960.8 20967.8 21561.6 20427.9 20440.7 20986.3 21203.0 21332.9 5729.7 5870.5 5918.1 5943.1 5948.2 5594.0 5819.5 5849.6 5861.7 5929.2 5724.1 5797.8 5875.8 5884.3 5891.7 5762.4 5852.3 5959.3 6107.0 6107.1 5691.1 6042.7 6109.6 6113.5 6131.1 14950.2 15231.2 18987.8 24732.9 24961.3 2430.8 2444.7 2598.0 2663.5 2902.3 10579.6 10610.2 10813.9 10991.1 11177.6 1892.8 1938.9 1967.5 1982.2 1989.1 76519.6 83621.0 84994.2 86579.0 87794.6 9618.0 10234.9 10401.1 10413.8 10670.8 14418.1 14447.3 14463.3 14508.9 14524.0 8297.6 8413.5 8421.6 8481.5 8557.9 8460.7 8511.4 8573.3 8580.2 8703.3 4378.5 4394.3 4426.9 4472.3 4513.1 1982.3 2035.3 2056.5 2142.2 2182.8 1010.4 1017.9 1037.4 1044.7 1112.9 20470.4 20533.8 20908.0 21104.9 21580.0 1033.6 1047.3 1054.2 1063.5 1095.1 11015.4 11385.5 11495.8 11667.6 11872.8 517954.0 520013.0 522430.0 526914.0 530374.0 92049.5 94629.0 100289.5 100458.0 101597.0 986.5 999.8 1015.5 1018.7 1029.6 17971.8 18235.7 18425.6 18482.4 18601.0 35943.3 41669.8 42566.6 43393.0 43482.3 59819.0 60708.4 61382.0 61656.4 62791.4 8035.4 8100.7 8195.8 8503.4 8939.6 12185.5 12792.9 12897.3 12948.8 13084.5 11135.8 11201.7 11564.3 11628.3 11668.2 11075.9 11357.8 11384.6 11764.4 11834.2 11133.3 11246.9 11309.8 11436.1 11554.0 7861.8 7992.4 7996.0 8077.5 8224.0 10891.1 11020.8 11155.4 11171.3 11420.4 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#3] mootools.html Cycles:180 Average:6166.67 Median:471.21 stddev:3576.59 (759.0%) stddev-sans-first:3569.70 03:51:40 INFO - PROCESS | 20105 | Values: 1537.1 1574.5 1752.4 1758.7 1826.9 8667.1 8942.8 8987.6 9416.2 9494.5 8931.1 9141.7 9304.1 9354.6 9382.2 2367.6 2403.9 2425.7 2428.7 2431.7 2416.7 2417.4 2469.8 2474.4 2480.7 2416.0 2430.4 2458.8 2465.7 2494.5 2383.9 2393.9 2408.5 2416.2 2421.9 2381.0 2396.1 2402.3 2402.5 2422.4 9472.5 9538.7 9545.5 9581.9 9584.3 5418.2 5542.7 5613.5 5617.2 5620.6 3351.2 3399.6 3439.2 3492.8 3514.8 973.7 984.7 1000.7 1007.1 1011.2 13014.3 13399.4 13434.1 13452.1 13497.5 4896.0 4941.3 4952.0 5009.7 5181.5 11372.8 11402.9 11417.9 11437.3 11447.4 5556.9 5563.7 5576.8 5597.2 5603.4 4532.2 5081.5 5114.4 5201.6 5228.3 4321.7 4378.2 4383.1 4419.6 4423.8 1386.5 1389.4 1399.7 1400.5 1412.8 983.9 984.9 1008.8 1020.2 1049.2 6055.8 6265.8 6267.0 6273.3 6484.7 451.9 459.6 464.6 470.9 471.6 4457.6 4458.8 4481.0 4550.4 4554.4 11249.9 11333.4 11372.4 11400.6 11827.3 11150.5 11633.3 11707.1 11844.1 11918.9 8263.3 8416.9 8424.7 8433.0 8498.1 6399.6 6477.1 6550.9 6564.8 6709.9 10612.7 10888.5 10917.2 10941.9 11014.6 10752.6 11163.1 11202.4 11347.5 11373.6 7662.9 8229.3 8498.8 8508.9 8523.1 9157.9 9189.1 9242.3 9243.5 9249.5 7911.3 8182.3 8230.9 8279.0 8538.9 7801.5 7830.9 7894.0 7970.3 8046.2 7068.8 7161.9 7168.0 7203.6 7332.5 5225.3 5309.0 5377.6 5460.7 5567.4 5531.9 5622.4 5637.9 5650.1 5668.5 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#4] prototype.html Cycles:180 Average:4990.43 Median:5551.82 stddev:1479.14 (26.6%) stddev-sans-first:1441.40 03:51:40 INFO - PROCESS | 20105 | Values: 333.2 350.5 356.3 356.4 357.3 5715.5 5739.5 5857.9 5868.0 5927.4 5706.5 5748.0 5748.6 5762.5 5765.9 4331.7 4487.2 4505.5 4514.8 4519.3 4467.6 4469.7 4471.7 4480.3 4483.4 4407.3 4420.8 4425.8 4431.4 4455.7 4396.6 4419.2 4422.3 4479.7 4480.2 3834.7 3840.7 3868.7 3877.7 3908.7 5582.6 5599.2 5599.5 5599.6 5613.8 5063.3 5082.3 5121.9 5140.2 5150.0 5962.3 5988.9 6000.6 6002.5 6036.5 4240.6 4274.5 4276.8 4296.6 4309.6 5561.7 6139.3 6325.7 6410.7 6459.7 4364.7 4381.3 4389.1 4440.6 4443.5 4480.0 4493.6 4518.8 4522.8 4530.0 5002.6 5120.7 5147.7 5177.4 5214.9 6068.7 6074.3 6077.9 6083.8 6097.0 1540.4 1555.4 1557.5 1569.5 1574.5 970.3 986.3 998.5 1013.6 1033.3 5169.5 5185.6 5205.5 5224.7 5227.3 5470.2 5492.4 5496.6 5523.0 5528.7 4828.1 5184.5 5208.8 5214.8 5252.7 2894.9 2906.6 2922.6 2928.3 2944.5 5539.4 5603.9 5654.5 5666.3 5699.9 5309.2 5528.3 5549.5 5554.1 6150.2 6299.9 6413.4 6464.0 6471.6 6490.5 6239.4 6256.4 6259.9 6269.8 6275.3 5961.7 6130.9 6145.8 6174.7 6202.1 6482.7 6495.3 6502.0 6504.6 6534.9 4386.8 4427.0 4432.8 4466.2 4481.4 6182.2 6183.8 6189.9 6227.0 6274.7 5897.3 6076.2 6099.5 6157.0 6203.2 6022.8 6084.2 6092.5 6097.5 6098.5 6004.3 6036.3 6037.7 6044.0 6051.5 5783.4 6070.4 6078.0 6099.3 6150.7 5935.5 5968.6 5986.0 6009.4 6041.0 03:51:40 INFO - PROCESS | 20105 | 03:51:40 INFO - PROCESS | 20105 | [#5] yui.html Cycles:180 Average:23075.69 Median:12837.65 stddev:34606.76 (269.6%) stddev-sans-first:34663.21 03:51:40 INFO - PROCESS | 20105 | Values: 741.6 785.9 860.3 867.1 874.8 15092.3 17325.4 17668.4 17929.4 17962.7 15860.6 16071.3 16100.7 16132.9 16146.8 724.4 865.5 868.5 890.7 893.1 884.6 888.3 889.5 890.0 890.2 942.7 943.8 944.7 947.8 949.5 937.9 939.5 940.7 941.8 943.9 692.3 696.3 698.3 700.0 702.1 16111.4 16281.1 16319.6 16324.8 16344.1 15560.0 15979.8 16314.4 16956.6 16972.1 12635.7 12896.9 12910.9 12974.3 13383.3 4016.0 4031.6 4146.0 4250.0 4258.1 80699.0 80858.1 80903.0 82305.6 82342.0 12023.5 12140.0 12146.5 12268.5 12316.6 20867.8 21322.6 21420.8 21774.2 21859.3 9007.6 9230.9 9283.1 9332.3 9339.1 4840.1 4953.6 4999.2 5022.1 5118.9 3816.0 3918.5 3926.7 3942.7 3984.8 682.3 684.5 698.0 698.6 706.1 662.3 710.3 728.4 767.7 781.5 10133.6 10189.7 10604.7 10882.7 11002.5 672.3 696.3 707.7 727.3 728.3 4918.8 4979.6 4997.3 5047.9 5064.3 109632.0 128751.0 130697.3 134144.0 137736.0 113349.0 118245.0 118559.4 120015.4 120354.4 102562.0 103104.0 103363.0 103856.5 108821.0 9234.2 9356.4 9462.2 9674.5 10037.0 41441.0 52932.5 54886.0 56551.0 56679.0 81940.0 88554.6 89965.0 90292.1 91391.5 12255.8 12368.4 12419.6 12650.4 12741.9 13612.7 13658.9 13699.7 13731.8 14199.9 13212.9 13272.7 13296.2 13312.2 13482.2 13912.2 13955.9 14105.7 14108.7 14548.3 12711.0 12815.3 12982.3 13090.0 13340.4 10792.1 10970.9 11100.7 11367.9 11491.9 12259.2 12659.1 12698.5 12895.2 13188.1 03:51:40 INFO - PROCESS | 20105 | -------- Summary: end -------- 03:51:40 INFO - PROCESS | 20105 | 03:51:41 INFO - TEST-INFO | 20105: exit 0 03:51:41 INFO - TEST-OK | dromaeo_css | took 1110888ms 03:51:41 INFO - TEST-START | kraken 03:51:41 INFO - operating with platform_type : linux_ 03:51:41 INFO - Initialising browser for kraken test... 03:51:41 INFO - TEST-INFO | started process 20367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwA3pJ/profile http://localhost:51434/getInfo.html) 03:51:45 INFO - PROCESS | 20367 | __metrics Screen width/height:1600/1200 03:51:45 INFO - PROCESS | 20367 | colorDepth:24 03:51:45 INFO - PROCESS | 20367 | Browser inner width/height: 1024/697 03:51:45 INFO - PROCESS | 20367 | __metrics 03:51:46 ERROR - PROCESS | 20367 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:51:47 INFO - TEST-INFO | 20367: exit 0 03:51:47 INFO - Browser initialized. 03:51:47 INFO - Running cycle 1/1 for kraken test... 03:51:47 INFO - TEST-INFO | started process 20491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwA3pJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:58 INFO - PROCESS | 20491 | RSS: Main: 152924160 03:51:58 INFO - PROCESS | 20491 | 03:52:01 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:02 INFO - PROCESS | 20491 | RSS: Main: 158146560 03:52:02 INFO - PROCESS | 20491 | 03:52:04 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-dft) 03:52:05 INFO - PROCESS | 20491 | RSS: Main: 156835840 03:52:05 INFO - PROCESS | 20491 | 03:52:08 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-fft) 03:52:08 INFO - PROCESS | 20491 | RSS: Main: 157573120 03:52:08 INFO - PROCESS | 20491 | 03:52:11 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator) 03:52:11 INFO - PROCESS | 20491 | RSS: Main: 157745152 03:52:11 INFO - PROCESS | 20491 | 03:52:13 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:14 INFO - PROCESS | 20491 | RSS: Main: 157503488 03:52:14 INFO - PROCESS | 20491 | 03:52:17 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:18 INFO - PROCESS | 20491 | RSS: Main: 156889088 03:52:18 INFO - PROCESS | 20491 | 03:52:21 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:22 INFO - PROCESS | 20491 | RSS: Main: 157814784 03:52:22 INFO - PROCESS | 20491 | 03:52:25 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial) 03:52:25 INFO - PROCESS | 20491 | RSS: Main: 158621696 03:52:25 INFO - PROCESS | 20491 | 03:52:27 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:27 INFO - PROCESS | 20491 | RSS: Main: 157741056 03:52:27 INFO - PROCESS | 20491 | 03:52:29 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:30 INFO - PROCESS | 20491 | RSS: Main: 157454336 03:52:30 INFO - PROCESS | 20491 | 03:52:32 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:32 INFO - PROCESS | 20491 | RSS: Main: 157724672 03:52:32 INFO - PROCESS | 20491 | 03:52:35 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:36 INFO - PROCESS | 20491 | RSS: Main: 158441472 03:52:36 INFO - PROCESS | 20491 | 03:52:38 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:39 INFO - PROCESS | 20491 | RSS: Main: 158457856 03:52:39 INFO - PROCESS | 20491 | 03:52:40 INFO - PROCESS | 20491 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51434/tests/kraken/driver.html?testName=ai-astar) 03:52:41 INFO - PROCESS | 20491 | RSS: Main: 158830592 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | __start_tp_report 03:52:41 INFO - PROCESS | 20491 | _x_x_mozilla_page_load 03:52:41 INFO - PROCESS | 20491 | _x_x_mozilla_page_load_details 03:52:41 INFO - PROCESS | 20491 | |i|pagename|runs| 03:52:41 INFO - PROCESS | 20491 | |0;ai-astar;99;110;104;111;110;111;110;113;109;111 03:52:41 INFO - PROCESS | 20491 | |1;audio-beat-detection;147;119;139;170;119;148;154;118;177;119 03:52:41 INFO - PROCESS | 20491 | |2;audio-dft;161;163;161;165;171;163;163;163;161;161 03:52:41 INFO - PROCESS | 20491 | |3;audio-fft;74;75;75;180;77;76;74;76;171;76 03:52:41 INFO - PROCESS | 20491 | |4;audio-oscillator;83;84;144;83;83;83;138;83;84;142 03:52:41 INFO - PROCESS | 20491 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 03:52:41 INFO - PROCESS | 20491 | |6;imaging-darkroom;147;147;147;147;147;148;148;147;147;146 03:52:41 INFO - PROCESS | 20491 | |7;imaging-desaturate;96;95;95;96;96;96;94;95;100;95 03:52:41 INFO - PROCESS | 20491 | |8;json-parse-financial;54;53;51;49;49;50;50;50;50;52 03:52:41 INFO - PROCESS | 20491 | |9;json-stringify-tinderbox;62;59;60;59;59;59;60;60;59;59 03:52:41 INFO - PROCESS | 20491 | |10;stanford-crypto-aes;72;74;73;82;72;73;77;72;77;74 03:52:41 INFO - PROCESS | 20491 | |11;stanford-crypto-ccm;123;142;125;120;117;118;127;122;151;132 03:52:41 INFO - PROCESS | 20491 | |12;stanford-crypto-pbkdf2;159;155;157;157;162;157;153;156;157;157 03:52:41 INFO - PROCESS | 20491 | |13;stanford-crypto-sha256-iterative;66;64;63;63;63;62;62;70;61;61 03:52:41 INFO - PROCESS | 20491 | __end_tp_report 03:52:41 INFO - PROCESS | 20491 | __start_cc_report 03:52:41 INFO - PROCESS | 20491 | _x_x_mozilla_cycle_collect,865 03:52:41 INFO - PROCESS | 20491 | __end_cc_report 03:52:41 INFO - PROCESS | 20491 | __startTimestamp1470826361239__endTimestamp 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | ------- Summary: start ------- 03:52:41 INFO - PROCESS | 20491 | Number of tests: 14 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.16 (3.7%) stddev-sans-first:2.47 03:52:41 INFO - PROCESS | 20491 | Values: 99.0 110.0 104.0 111.0 110.0 111.0 110.0 113.0 109.0 111.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:147.50 stddev:22.05 (14.9%) stddev-sans-first:23.28 03:52:41 INFO - PROCESS | 20491 | Values: 147.0 119.0 139.0 170.0 119.0 148.0 154.0 118.0 177.0 119.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:3.05 (1.9%) stddev-sans-first:3.13 03:52:41 INFO - PROCESS | 20491 | Values: 161.0 163.0 161.0 165.0 171.0 163.0 163.0 163.0 161.0 161.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:42.28 (56.0%) stddev-sans-first:44.13 03:52:41 INFO - PROCESS | 20491 | Values: 74.0 75.0 75.0 180.0 77.0 76.0 74.0 76.0 171.0 76.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.00 stddev:28.08 (33.8%) stddev-sans-first:29.04 03:52:41 INFO - PROCESS | 20491 | Values: 83.0 84.0 144.0 83.0 83.0 83.0 138.0 83.0 84.0 142.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:52:41 INFO - PROCESS | 20491 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:52:41 INFO - PROCESS | 20491 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 146.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.62 (1.7%) stddev-sans-first:1.72 03:52:41 INFO - PROCESS | 20491 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 94.0 95.0 100.0 95.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:50.50 stddev:1.69 (3.3%) stddev-sans-first:1.33 03:52:41 INFO - PROCESS | 20491 | Values: 54.0 53.0 51.0 49.0 49.0 50.0 50.0 50.0 50.0 52.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:0.97 (1.6%) stddev-sans-first:0.50 03:52:41 INFO - PROCESS | 20491 | Values: 62.0 59.0 60.0 59.0 59.0 59.0 60.0 60.0 59.0 59.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:3.20 (4.3%) stddev-sans-first:3.26 03:52:41 INFO - PROCESS | 20491 | Values: 72.0 74.0 73.0 82.0 72.0 73.0 77.0 72.0 77.0 74.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:126.00 stddev:11.04 (8.8%) stddev-sans-first:11.57 03:52:41 INFO - PROCESS | 20491 | Values: 123.0 142.0 125.0 120.0 117.0 118.0 127.0 122.0 151.0 132.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:2.36 (1.5%) stddev-sans-first:2.39 03:52:41 INFO - PROCESS | 20491 | Values: 159.0 155.0 157.0 157.0 162.0 157.0 153.0 156.0 157.0 157.0 03:52:41 INFO - PROCESS | 20491 | 03:52:41 INFO - PROCESS | 20491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.72 (4.3%) stddev-sans-first:2.73 03:52:41 INFO - PROCESS | 20491 | Values: 66.0 64.0 63.0 63.0 63.0 62.0 62.0 70.0 61.0 61.0 03:52:41 INFO - PROCESS | 20491 | -------- Summary: end -------- 03:52:41 INFO - PROCESS | 20491 | 03:52:42 INFO - TEST-INFO | 20491: exit 0 03:52:42 INFO - TEST-OK | kraken | took 61047ms 03:52:42 INFO - SUITE-END | took 1171s 03:52:42 INFO - Completed test suite (00:19:32) 03:52:42 INFO - javascript benchmark 03:52:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7578.023221363789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.638799732029, 3300.587426571677, 3316.3864685033273, 3329.450640644294, 3332.083676988828, 5749.971250143749, 5751.051076572371, 5754.539636829054, 5803.709814509273, 5844.853878653025, 5735.512481439072, 5771.989901767184, 5776.335721392041, 5788.0, 5806.0, 5258.526732594075, 5275.393329767068, 5300.09898317285, 5331.973340133294, 5365.168398898177, 5162.045021671003, 5169.612279079065, 5209.244659524366, 5215.869603259911, 5232.92150617741, 5238.13570760824, 5267.051930652481, 5274.604404669646, 5344.839654810343, 5420.0, 5314.043472175026, 5316.468353164652, 5316.9202461963105, 5325.840224793243, 5347.812826551091, 5084.3644544431945, 5126.282320475137, 5161.845144645667, 5226.085435048852, 5288.68267903927, 5465.9180112298345, 5708.343540492855, 5714.228579141804, 5728.68492232927, 5739.368669446358, 6102.298235702907, 6109.7861574844665, 6152.600080994721, 6153.846153846145, 6156.507479401637, 6072.210612620375, 6079.726412311456, 6207.068939659042, 6220.720067596969, 6245.875082498324, 5704.885902281972, 5778.27771528559, 5784.0, 5804.738786754564, 5828.388019258002, 6325.861344957952, 6337.936620633827, 6339.334369891095, 6348.523860710465, 6354.4281014708895, 5936.347001829881, 6019.729112189962, 6032.698365081728, 6074.119252708332, 6078.787242446581, 6131.621347939075, 6144.617461071312, 6145.801568694062, 6146.692665366714, 6152.78465253714, 6067.059605761114, 6082.422169893853, 6095.603785753912, 6098.878022439526, 6107.389261073946, 5943.5839491236065, 6060.939390606038, 6087.96956015226, 6098.0, 6122.7244773984385, 4698.624110071186, 4726.787294571753, 4733.857984260478, 4765.213739732905, 4768.785404656799, 4171.270027745132, 4181.142865712522, 4203.579642035772, 4227.070044590185, 4232.513260975027, 5721.914171287434, 5749.1663708762, 5928.703564821742, 5945.316288626776, 5954.702264886739, 6089.969550152309, 6180.258368995659, 6208.410201030895, 6211.689415529206, 6235.563510554218, 5859.589828711949, 5891.499222566044, 5923.555733320019, 5930.258717660293, 5953.404659534099, 5183.222516622537, 5217.739113044333, 5327.840164795062, 5332.466753324637, 5345.198220266913, 6217.440430361289, 6356.269029061717, 6357.205349331333, 6370.58591191571, 6387.137736405526, 6163.19878415803, 6164.568480206342, 6166.383361663888, 6178.907316390348, 6182.350853160354, 6143.849652621725, 6246.718897649525, 6366.681665916593, 6371.267304260069, 6389.233292004989, 6018.247719035121, 6122.173506576733, 6131.595232866953, 6132.386102851662, 6132.477886260874, 6175.2589689237575, 6210.844728881633, 6224.2842073160355, 6234.688265586793, 6235.033569796688, 5935.258092738408, 5970.134330522137, 6068.089786531879, 6072.332043475126, 6091.147239386578, 5955.0, 5992.280926288873, 6060.272767267956, 6084.543659225487, 6108.08378743192, 5955.67243801595, 5995.100734889801, 5995.700214989146, 6002.039673652194, 6003.099535069775, 5946.048632218997, 5951.49412299942, 6018.699065046818, 6042.697865106815, 6049.334573197033, 5842.649441033552, 5946.137810017437, 5960.165576819162, 5969.403059693996, 5985.162077309094], "value": 5681.057517986234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5710752596841, 647.9902801457978, 667.3026687111967, 672.5897202706349, 711.8967749676294, 41032.589674103285, 46269.537304626945, 46336.0, 46338.0, 46449.53550464494, 46116.0, 46653.53346466534, 46676.533234667644, 46698.0, 46901.765491172584, 9067.183953444188, 9210.032946540618, 9241.0, 9255.537223138816, 9259.953700231523, 9236.67671631493, 9251.676191333305, 9284.442933424016, 9285.814283714322, 9312.115349041831, 9332.39339442934, 9349.719508414759, 9358.532073396304, 9361.48511831849, 9380.108889655507, 9193.494357810318, 9252.444853308823, 9253.213476854475, 9260.212881905047, 9287.442753434816, 9176.8623470648, 9249.213816825579, 9263.583138758771, 9265.258779297708, 9267.582958766872, 44011.47908167339, 44068.3389749154, 44102.117957640665, 44457.11085778266, 44478.55521444776, 3657.140571965586, 3743.7005039596766, 3853.865114720971, 4362.520122786491, 4435.334699795024, 34867.476987845206, 35335.293294133975, 35572.822135889415, 35613.109672258404, 36777.448338274946, 4087.264292427362, 4146.896327591804, 4183.4979802423595, 4214.557471465513, 4229.407882896397, 369225.0, 369899.0, 370148.0, 370693.0, 371116.1444192789, 38342.80828595839, 39712.60287397089, 64013.67993160005, 64057.359426406074, 64446.0, 38849.611503885164, 39039.414408783894, 39112.413313800316, 39114.413283800764, 39229.80385098056, 15938.760918586231, 15959.521214363587, 16070.919645401931, 16117.355305787873, 16121.0, 13354.265515396746, 13463.124896881867, 13542.864571354357, 13557.796633050511, 13576.456941722221, 8960.283177345797, 8969.058248883905, 9094.818103638023, 9133.588988495534, 9163.633454661873, 3387.9502900744696, 3474.5483087198504, 3499.650034996531, 3526.506289119474, 3544.0, 1052.7578656908954, 1054.9683509494728, 1125.3697929159532, 1134.9489272982735, 1156.8264760286024, 31488.473370890115, 32821.835890820395, 32963.50554741681, 33073.32293291753, 33141.50287745686, 1157.0685598093448, 1172.191188080239, 1175.4122938530734, 1194.6774370919802, 1194.6893807610084, 17671.73492397615, 17715.468535943943, 17888.28446862111, 17892.0, 17947.282108715764, 614082.0, 615371.0, 625322.0, 626708.0, 628954.0, 64663.0, 65409.67295163589, 65443.67278163579, 65650.0, 66036.0, 1420.4034305591676, 1449.5361484324915, 1450.260367212729, 1451.4194322271176, 1474.786156007373, 32187.0, 32941.67058329482, 33934.66065339414, 34083.65916340805, 34371.828140859136, 55296.72351638216, 55572.0, 56136.43863561312, 56177.43822561722, 56202.43797562135, 421884.0, 423543.0, 423832.0, 426094.0, 426451.0, 30992.535111972888, 31079.0, 31438.0, 31614.893478728132, 31675.841620791747, 51081.74459127681, 51471.0, 51488.742556286976, 52656.736716316176, 52775.0, 42885.356719648604, 48262.75868620635, 48328.275075873185, 49026.509734902196, 49325.2601210975, 45598.54401455943, 46040.7697961508, 46432.0, 46651.18291548708, 46728.532714672416, 45150.0, 45261.77369113265, 45314.0, 45384.77307613441, 45455.54544454513, 37798.0, 39809.0, 40133.397999029454, 40367.59632403756, 40613.79693101515, 30138.54792178163, 30775.2306192347, 30828.691713082582, 30994.845025774728, 31111.53332699966], "value": 20179.997160439656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.7906046976512, 421.2320078885266, 426.086045432547, 430.1847998043707, 439.2269605494329, 19055.0, 20686.27598034069, 20960.790392096093, 20967.790322096775, 21561.568768624657, 20427.897860510715, 20440.72041984733, 20986.265480708178, 21203.0, 21332.89333553334, 5729.656220626765, 5870.530357571384, 5918.082697181922, 5943.108533719934, 5948.167256584082, 5594.0, 5819.534437245032, 5849.64902105875, 5861.677607731573, 5929.169916211734, 5724.055530837428, 5797.768089276424, 5875.794347197849, 5884.293884733816, 5891.734871930774, 5762.423757624225, 5852.297724273072, 5959.344472108086, 6107.0, 6107.083937409379, 5691.146328050825, 6042.697865106771, 6109.5723299369065, 6113.480354169901, 6131.080337949299, 14950.177740224284, 15231.162286074261, 18987.810121898743, 24732.876335618388, 24961.251162465156, 2430.7812296893367, 2444.6944131983323, 2598.038725671495, 2663.533881570737, 2902.2889392099073, 10579.576816927314, 10610.204234682353, 10813.945930270298, 10991.120710343153, 11177.552897884076, 1892.8391086757642, 1938.8545859060628, 1967.45894878908, 1982.1575830272077, 1989.1446677928484, 76519.61740191319, 83620.99999999939, 84994.15005849986, 86579.0, 87794.56102719446, 9618.0, 10234.897651023542, 10401.063904248502, 10413.791724165474, 10670.786584268426, 14418.13491190532, 14447.349869255908, 14463.27683615815, 14508.927455362656, 14524.0, 8297.58512074394, 8413.52763266426, 8421.621027053798, 8481.533515656698, 8557.914420855712, 8460.703875364332, 8511.446755960842, 8573.31413486932, 8580.227779499875, 8703.347248956354, 4378.540253273361, 4394.318880573516, 4426.933595996063, 4472.306792447176, 4513.119941611354, 1982.2764690887723, 2035.2571311471206, 2056.4961584411617, 2142.1752625239396, 2182.7598964113936, 1010.4240582867842, 1017.8931212222758, 1037.4242295525905, 1044.738815296176, 1112.8887111288807, 20470.38588842337, 20533.794662053486, 20908.0, 21104.89447552783, 21580.0, 1033.6330602635956, 1047.314009323894, 1054.177741361739, 1063.547992103353, 1095.085603521053, 11015.394153321484, 11385.487653055632, 11495.827562586568, 11667.59163429276, 11872.76254474923, 517954.0, 520013.0, 522430.0, 526914.0, 530374.0, 92049.53975230081, 94629.0, 100289.49855250678, 100458.0, 101597.0, 986.5018165826211, 999.820032394176, 1015.4973288222377, 1018.6994836523244, 1029.5572903651353, 17971.820281797016, 18235.66596815406, 18425.63148736991, 18482.445526634223, 18601.0, 35943.281134376644, 41669.79165104155, 42566.574334256264, 43393.0, 43482.34776478419, 59819.0, 60708.392916070276, 61382.0, 61656.383436166856, 62791.372086278556, 8035.357171426389, 8100.71647492335, 8195.770634404887, 8503.362247831561, 8939.59771810257, 12185.451654675384, 12792.936035319764, 12897.290649014394, 12948.8057679133, 13084.476620935437, 11135.777284454427, 11201.719957000814, 11564.306141631529, 11628.302301861915, 11668.241564298294, 11075.944620277169, 11357.829632555353, 11384.601538946097, 11764.352960586908, 11834.171607987702, 11133.276337038067, 11246.943765281121, 11309.830352544554, 11436.1422893285, 11554.017908477874, 7861.8034549134445, 7992.40056995716, 7996.046898162511, 8077.474964127313, 8224.0, 10891.128709703364, 11020.779584408427, 11155.44222788841, 11171.273867198606, 11420.371879546705], "value": 9403.44444746687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.1315206908096, 1574.5119013105934, 1752.3779058434257, 1758.7361895715649, 1826.926922923084, 8667.13328667133, 8942.821143577132, 8987.59555819988, 9416.246700263979, 9494.477803720793, 8931.062238464949, 9141.725748227547, 9304.069593040693, 9354.62581496741, 9382.202512786422, 2367.550165468564, 2403.8677872716994, 2425.684660994077, 2428.7206971198275, 2431.744666809986, 2416.66166736657, 2417.4198192433864, 2469.76537228963, 2474.39377352548, 2480.6899137607797, 2415.9637605435933, 2430.404550885036, 2458.754124587536, 2465.7410971847967, 2494.48862983088, 2383.8688872112025, 2393.9401514962265, 2408.458096928186, 2416.2026531244733, 2421.903123875043, 2381.0356805493802, 2396.101461951768, 2402.303332033708, 2402.531506356261, 2422.4428381472185, 9472.526373681358, 9538.713838584854, 9545.47499887506, 9581.904180958241, 9584.329096963216, 5418.160185171266, 5542.722863856831, 5613.494785469327, 5617.241672374218, 5620.5503559715125, 3351.1957130288556, 3399.558057452515, 3439.1917899293644, 3492.7904325740283, 3514.841832117561, 973.6689525561272, 984.714432814483, 1000.7147962830632, 1007.0584003956325, 1011.2314640872916, 13014.284214368206, 13399.397027133802, 13434.059615826896, 13452.058355915187, 13497.460101596023, 4895.951040489549, 4941.2835138905375, 4951.950480495221, 5009.699418034929, 5181.53366197044, 11372.829407558893, 11402.94298528502, 11417.942910285561, 11437.256578322382, 11447.427628618536, 5556.944430555724, 5563.693996830132, 5576.804811831566, 5597.244372009808, 5603.355614104348, 4532.161550113174, 5081.542661160439, 5114.360704911886, 5201.6358854880555, 5228.320318358589, 4321.719088259316, 4378.190034843564, 4383.145286669069, 4419.602235798793, 4423.800928958204, 1386.4592808804575, 1389.4095009621074, 1399.6500874781304, 1400.4958215042577, 1412.8233970753656, 983.9262055345878, 984.8965858584888, 1008.8284991551454, 1020.2195320579763, 1049.2340591368343, 6055.788047418408, 6265.843353916098, 6266.965950618188, 6273.341299163613, 6484.740610375627, 451.8531477269835, 459.6139243035866, 464.64454692160524, 470.8752180672125, 471.5520255757045, 4457.554244575516, 4458.7547684877645, 4480.955190448054, 4550.431196100488, 4554.3851580036935, 11249.943750281196, 11333.376664283378, 11372.374519401346, 11400.600978965696, 11827.290362578273, 11150.49822757978, 11633.302001879914, 11707.063434925356, 11844.052475801915, 11918.880811191777, 8263.256306932404, 8416.915830841735, 8424.705135320235, 8433.0, 8498.107698691549, 6399.64801935898, 6477.060826180272, 6550.868982620416, 6564.8358791030605, 6709.93290067093, 10612.734681633021, 10888.51001704941, 10917.181211409017, 10941.890581094087, 11014.559417623526, 10752.623658171926, 11163.106951443702, 11202.38386888729, 11347.546098156312, 11373.601923932623, 7662.923370766221, 8229.341652667892, 8498.830023399374, 8508.914910850812, 8523.147685231675, 9157.86263206039, 9189.081091890757, 9242.306826988137, 9243.491607961627, 9249.491277979776, 7911.28798408146, 8182.304504117216, 8230.876536852073, 8279.047909490244, 8538.871916921375, 7801.45389822707, 7830.8825367620675, 7893.960530197312, 7970.322522585413, 8046.155153708776, 7068.752593659197, 7161.928380716335, 7168.032315637322, 7203.567785932861, 7332.450066244946, 5225.320708307896, 5309.0, 5377.596680248918, 5460.6996615186545, 5567.359753628222, 5531.8893622128135, 5622.437756224344, 5637.943620563906, 5650.067738823048, 5668.489835914623], "value": 4810.2045612619695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.19034745568274, 350.4585415533001, 356.3247645711377, 356.4225953954594, 357.27116681968783, 5715.457031582004, 5739.483446489815, 5857.941420585793, 5868.0, 5927.407259274081, 5706.543476521879, 5747.971260143704, 5748.5688573357065, 5762.4525670061275, 5765.924267263782, 4331.7400955942585, 4487.214737420946, 4505.504394516601, 4514.841980530682, 4519.34469501922, 4467.553244675522, 4469.687121901468, 4471.709338892962, 4480.260756975095, 4483.444436671099, 4407.250767369539, 4420.8010639521135, 4425.849279187402, 4431.357453169288, 4455.732656040632, 4396.582324679151, 4419.182451246497, 4422.336649502568, 4479.731216127043, 4480.171168333869, 3834.731568790186, 3840.7311488195837, 3868.723321303963, 3877.670398016172, 3908.6515152272423, 5582.580032962126, 5599.216109744639, 5599.496045355938, 5599.580031497654, 5613.764971706218, 5063.316452278968, 5082.313887625197, 5121.871953201163, 5140.203268493389, 5150.0, 5962.344142144404, 5988.940110598882, 6000.609960352606, 6002.459778619901, 6036.486898613623, 4240.554741752133, 4274.529801721839, 4276.828926842923, 4296.63478604319, 4309.6336811371075, 5561.694106824123, 6139.293981192175, 6325.652089135096, 6410.67946602668, 6459.67701614922, 4364.672649551297, 4381.291296394409, 4389.144116897238, 4440.600345968814, 4443.488998765183, 4479.977600111979, 4493.550644935481, 4518.751468669255, 4522.819087236474, 4529.987558273777, 5002.574781143643, 5120.718360490208, 5147.6911385317, 5177.378714554277, 5214.947850521522, 6068.726907289182, 6074.271087469444, 6077.9392206078255, 6083.817485475354, 6097.0, 1540.3761476601994, 1555.3700751195784, 1557.509384543865, 1569.4977607165827, 1574.527641707483, 970.2722957781664, 986.329296078659, 998.5157198758596, 1013.601230302193, 1033.3489901362093, 5169.53474187325, 5185.637005409585, 5205.538317019215, 5224.738763061831, 5227.320448341691, 5470.234167216593, 5492.368377636623, 5496.615236933456, 5523.0, 5528.7235638218735, 4828.058528586892, 5184.533391994739, 5208.817691380859, 5214.84355469329, 5252.711100889488, 2894.8552572371295, 2906.6076079729387, 2922.6346706661666, 2928.326484908483, 2944.4994350960387, 5539.390667026624, 5603.915941260884, 5654.5193658538665, 5666.263385759825, 5699.8860022800145, 5309.247948177092, 5528.281323427928, 5549.500544950974, 5554.139108438118, 6150.200473938449, 6299.937000629935, 6413.422791948654, 6463.967680161569, 6471.579347342407, 6490.545661803629, 6239.410644582447, 6256.374362563707, 6259.874802504016, 6269.83690626733, 6275.309715931153, 5961.701914904324, 6130.938690613037, 6145.754169833157, 6174.722137503733, 6202.100695399232, 6482.740690372332, 6495.265222497177, 6501.9674901625185, 6504.60972341661, 6534.869302613826, 4386.780660967002, 4426.9778651106535, 4432.825301295224, 4466.218411777991, 4481.417415735934, 6182.165407669907, 6183.783567575113, 6189.938100618936, 6226.968865155645, 6274.749010039547, 5897.292324920865, 6076.179715738319, 6099.542534309856, 6156.968200493737, 6203.193584833943, 6022.849428764316, 6084.235571684162, 6092.512598991982, 6097.469550136643, 6098.512119030555, 6004.339522652592, 6036.3058248302, 6037.667928263988, 6043.972524670904, 6051.5461340400525, 5783.3638299787835, 6070.362611925684, 6077.969610151921, 6099.329073801967, 6150.723217455135, 5935.495482884004, 5968.641881487125, 5985.970070149621, 6009.437546237922, 6040.969795150996], "value": 4518.688532265907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6254791330381, 785.8899754034433, 860.3289434241292, 867.1155421470103, 874.7856775090104, 15092.320845561948, 17325.393611223593, 17668.38160664377, 17929.372471963485, 17962.730559041625, 15860.603484912854, 16071.276792544335, 16100.677986440263, 16132.919335403336, 16146.83853161468, 724.3842733676386, 865.4936861935776, 868.5049521772593, 890.66154861153, 893.1113542025694, 884.6107712606465, 888.3071204460499, 889.4618755652834, 890.0120865838913, 890.1721399098835, 942.7313215733517, 943.7546237978106, 944.7118628818208, 947.7630592351912, 949.5015117063527, 937.9062093790567, 939.539625583466, 940.7318914109514, 941.8210539997413, 943.8725772020758, 692.3146085375492, 696.2897844198889, 698.2877464985737, 700.0164768500265, 702.0662518849917, 16111.355545778271, 16281.104539250337, 16319.592010199722, 16324.836751632569, 16344.101074440901, 15560.0, 15979.840201597952, 16314.428994985237, 16956.576085597837, 16972.066536340495, 12635.74728505434, 12896.87103128966, 12910.87089129106, 12974.286414247212, 13383.330833458289, 4015.959840401588, 4031.596840315974, 4146.0, 4249.978750106261, 4258.127083947783, 80699.0, 80858.13837730214, 80903.0, 82305.58847205725, 82342.0, 12023.519059237533, 12140.0, 12146.453409596412, 12268.509259629693, 12316.568920087753, 20867.791322086887, 21322.573548528944, 21420.78579214219, 21774.237901673365, 21859.344219673436, 9007.63969441215, 9230.907690923004, 9283.11810378013, 9332.300077494216, 9339.112784285482, 4840.1287768201355, 4953.554180123806, 4999.200127979506, 5022.070916880389, 5118.948810511847, 3815.9618403815607, 3918.49059622253, 3926.725129240983, 3942.6845852331744, 3984.8007599620482, 682.2767866061891, 684.466116429176, 697.9755708550176, 698.6157613312657, 706.0742272962345, 662.2715013485127, 710.3354801689812, 728.3917928529631, 767.6852490478877, 781.4646966827742, 10133.594656213669, 10189.694309170736, 10604.681859544226, 10882.727931801768, 11002.50488728009, 672.277301900459, 696.2584847137782, 707.6850801393331, 727.2763600217817, 728.2717282717283, 4918.778654960535, 4979.551840334315, 4997.250412438163, 5047.873803154877, 5064.290999260106, 109632.0, 128751.0, 130697.34651326682, 134144.0, 137736.0, 113349.0, 118245.0, 118559.40720296343, 120015.39992299983, 120354.3982280083, 102562.0, 103103.96896031094, 103363.0, 103856.48071759744, 108821.0, 9234.215091717278, 9356.391834530734, 9462.195713364441, 9674.467904265051, 10037.0, 41441.0, 52932.470675294295, 54886.0, 56551.0, 56679.0, 81940.0, 88554.55722721345, 89965.0, 90292.09707902838, 91391.54304228703, 12255.754884902073, 12368.381580920737, 12419.627411177678, 12650.43073061696, 12741.872581274069, 13612.65968350799, 13658.863411365759, 13699.726005479635, 13731.794023089862, 14199.929000354932, 13212.933935330262, 13272.668183295109, 13296.202227866359, 13312.201267923569, 13482.19106853592, 13912.176643572826, 13955.930220348833, 14105.717885642434, 14108.717825643223, 14548.272586370427, 12711.0, 12815.295158766357, 12982.285974271506, 13090.0, 13340.399682014528, 10792.08267297257, 10970.945145274542, 11100.722481937693, 11367.943160284145, 11491.885081149416, 12259.203151795105, 12659.11386202957, 12698.492060317853, 12895.226286422845, 13188.142770720257], "value": 8081.313728646077, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 111.0, 110.0, 111.0, 110.0, 113.0, 109.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 139.0, 170.0, 119.0, 148.0, 154.0, 118.0, 177.0, 119.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 165.0, 171.0, 163.0, 163.0, 163.0, 161.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 180.0, 77.0, 76.0, 74.0, 76.0, 171.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 144.0, 83.0, 83.0, 83.0, 138.0, 83.0, 84.0, 142.0], "value": 100.7, "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, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 100.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 52.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 82.0, 72.0, 73.0, 77.0, 72.0, 77.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 142.0, 125.0, 120.0, 117.0, 118.0, 127.0, 122.0, 151.0, 132.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 157.0, 157.0, 162.0, 157.0, 153.0, 156.0, 157.0, 157.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 63.0, 63.0, 62.0, 62.0, 70.0, 61.0, 61.0], "value": 63.5, "unit": "score"}]}]} 03:52:42 INFO - Return code: 0 03:52:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:42 ERROR - # TBPL SUCCESS # 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - [mozharness: 2016-08-10 10:52:42.572796Z] Finished run-tests step (success) 03:52:42 INFO - Running post-run listener: _resource_record_post_run 03:52:42 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 270336; Write bytes: 326926336; Read time: 68; Write time: 448204 03:52:42 INFO - TinderboxPrint: CPU usage
13.3% 03:52:42 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 68 03:52:42 INFO - TinderboxPrint: I/O write bytes / time
326,926,336 / 448,204 03:52:42 INFO - TinderboxPrint: CPU idle
8,219.8 (86.7%) 03:52:42 INFO - TinderboxPrint: CPU user
1,200.1 (12.7%) 03:52:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78360576; Read time: 0; Write time: 167072 03:52:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247664640; Read time: 56; Write time: 281120 03:52:43 INFO - Running post-run listener: _upload_blobber_files 03:52:43 INFO - Blob upload gear active. 03:52:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:44 INFO - (blobuploader) - INFO - Done attempting. 03:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:45 INFO - (blobuploader) - INFO - Done attempting. 03:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:48 INFO - (blobuploader) - INFO - Done attempting. 03:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:48 INFO - Return code: 0 03:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa578fcab47277ba7aa86dd06c9d97a85e296f18e62a18273fa8b2e9e707ea0d63ade1a46a4079b2a1dbb2b9ffb137b0f3a79f992e1714f99b6172aa0b3a269f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5d6700402e261a74ac8df8d038713d36ad3328ce29b8fb77e9049d242981a02ff5461914494395c77cbf922ed54dffe66d5a42aaa94c63c0f907937ac8bdd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f7239524058c911697f2bb14f1ff0155eccfb0fce59798478024bdb047706a10bd35624f056e20559315feb90765b78550e19046aa34a07b35442585ce0f8d5"} 03:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:48 INFO - Contents: 03:52:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa578fcab47277ba7aa86dd06c9d97a85e296f18e62a18273fa8b2e9e707ea0d63ade1a46a4079b2a1dbb2b9ffb137b0f3a79f992e1714f99b6172aa0b3a269f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5d6700402e261a74ac8df8d038713d36ad3328ce29b8fb77e9049d242981a02ff5461914494395c77cbf922ed54dffe66d5a42aaa94c63c0f907937ac8bdd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f7239524058c911697f2bb14f1ff0155eccfb0fce59798478024bdb047706a10bd35624f056e20559315feb90765b78550e19046aa34a07b35442585ce0f8d5"} 03:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:48 INFO - Copying logs to upload dir... 03:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.279034 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-10 03:52:48.280154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 03:52:48.283626) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 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/aa578fcab47277ba7aa86dd06c9d97a85e296f18e62a18273fa8b2e9e707ea0d63ade1a46a4079b2a1dbb2b9ffb137b0f3a79f992e1714f99b6172aa0b3a269f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5d6700402e261a74ac8df8d038713d36ad3328ce29b8fb77e9049d242981a02ff5461914494395c77cbf922ed54dffe66d5a42aaa94c63c0f907937ac8bdd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f7239524058c911697f2bb14f1ff0155eccfb0fce59798478024bdb047706a10bd35624f056e20559315feb90765b78550e19046aa34a07b35442585ce0f8d5"} build_url:https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/Lqxq_9ClRWGXghV-aSjIww/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/aa578fcab47277ba7aa86dd06c9d97a85e296f18e62a18273fa8b2e9e707ea0d63ade1a46a4079b2a1dbb2b9ffb137b0f3a79f992e1714f99b6172aa0b3a269f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5d6700402e261a74ac8df8d038713d36ad3328ce29b8fb77e9049d242981a02ff5461914494395c77cbf922ed54dffe66d5a42aaa94c63c0f907937ac8bdd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f7239524058c911697f2bb14f1ff0155eccfb0fce59798478024bdb047706a10bd35624f056e20559315feb90765b78550e19046aa34a07b35442585ce0f8d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 03:52:48.308505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:52:48.308832) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470820635.702339-86321437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 03:52:48.392800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 03:52:48.393106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 03:52:48.393409) ========= ========= Total master_lag: 0.16 =========