builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1472104515.19 results: success (0) buildid: 20160824201226 builduid: 9588af9f17174cd1bf1e88124384d3f9 revision: 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.187933) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.188409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.188691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.203144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.203421) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 22:55:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 33.3M=0s 2016-08-24 22:55:15 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.316610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.316932) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:15.367324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 22:55:15.367695) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 --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 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 --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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 22:55:15,838 truncating revision to first 12 chars 2016-08-24 22:55:15,838 Setting DEBUG logging. 2016-08-24 22:55:15,838 attempt 1/10 2016-08-24 22:55:15,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8a0abccd9563?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 22:55:16,879 unpacking tar archive at: mozilla-aurora-8a0abccd9563/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 22:55:16.699038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:16.699375) ========= script_repo_revision: 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:16.699764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:16.700033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 22:55:16.710518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-24 22:55:16.710866) ========= /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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:55:17 INFO - MultiFileLogger online at 20160824 22:55:17 in /builds/slave/test 22:55:17 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 22:55:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:55:17 INFO - {'append_to_log': False, 22:55:17 INFO - 'base_work_dir': '/builds/slave/test', 22:55:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:55:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:55:17 INFO - 'branch': 'Mozilla-Aurora', 22:55:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:55:17 INFO - 'config_files': ('talos/linux_config.py',), 22:55:17 INFO - 'default_actions': ('clobber', 22:55:17 INFO - 'read-buildbot-config', 22:55:17 INFO - 'download-and-extract', 22:55:17 INFO - 'populate-webroot', 22:55:17 INFO - 'create-virtualenv', 22:55:17 INFO - 'install', 22:55:17 INFO - 'run-tests'), 22:55:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:55:17 INFO - 'download_minidump_stackwalk': True, 22:55:17 INFO - 'download_symbols': 'ondemand', 22:55:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:55:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:55:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:55:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:55:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:55:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:55:17 INFO - 'installer_path': 'installer.exe', 22:55:17 INFO - 'log_level': 'info', 22:55:17 INFO - 'log_name': 'talos', 22:55:17 INFO - 'log_to_console': True, 22:55:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:55:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:55:17 INFO - 'opt_config_files': (), 22:55:17 INFO - 'pip_index': False, 22:55:17 INFO - 'sps_profile': False, 22:55:17 INFO - 'sps_profile_interval': 0, 22:55:17 INFO - 'suite': 'dromaeojs-e10s', 22:55:17 INFO - 'system_bits': '32', 22:55:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:55:17 INFO - 'title': 'talos-linux64-ix-015', 22:55:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:55:17 INFO - 'use_talos_json': True, 22:55:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:55:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:55:17 INFO - 'work_dir': 'build'} 22:55:17 INFO - [mozharness: 2016-08-25 05:55:17.278639Z] Running clobber step. 22:55:17 INFO - Running pre-action listener: _resource_record_pre_action 22:55:17 INFO - Running main action method: clobber 22:55:17 INFO - rmtree: /builds/slave/test/build 22:55:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:55:18 INFO - Running post-action listener: _resource_record_post_action 22:55:18 INFO - [mozharness: 2016-08-25 05:55:18.251434Z] Finished clobber step (success) 22:55:18 INFO - [mozharness: 2016-08-25 05:55:18.251534Z] Running read-buildbot-config step. 22:55:18 INFO - Running pre-action listener: _resource_record_pre_action 22:55:18 INFO - Running main action method: read_buildbot_config 22:55:18 INFO - Using buildbot properties: 22:55:18 INFO - { 22:55:18 INFO - "project": "", 22:55:18 INFO - "product": "firefox", 22:55:18 INFO - "script_repo_revision": "production", 22:55:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:55:18 INFO - "repository": "", 22:55:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:55:18 INFO - "buildid": "20160824201226", 22:55:18 INFO - "pgo_build": "True", 22:55:18 INFO - "basedir": "/builds/slave/test", 22:55:18 INFO - "buildnumber": 473, 22:55:18 INFO - "slavename": "talos-linux64-ix-015", 22:55:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:55:18 INFO - "platform": "ubuntu64_hw", 22:55:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:55:18 INFO - "branch": "mozilla-aurora", 22:55:18 INFO - "repo_path": "releases/mozilla-aurora", 22:55:18 INFO - "revision": "8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5", 22:55:18 INFO - "stage_platform": "linux64-pgo", 22:55:18 INFO - "builduid": "9588af9f17174cd1bf1e88124384d3f9", 22:55:18 INFO - "slavebuilddir": "test" 22:55:18 INFO - } 22:55:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 22:55:18 INFO - Running post-action listener: _resource_record_post_action 22:55:18 INFO - [mozharness: 2016-08-25 05:55:18.253992Z] Finished read-buildbot-config step (success) 22:55:18 INFO - [mozharness: 2016-08-25 05:55:18.254081Z] Running download-and-extract step. 22:55:18 INFO - Running pre-action listener: _resource_record_pre_action 22:55:18 INFO - Running main action method: download_and_extract 22:55:18 INFO - mkdir: /builds/slave/test/build/tests 22:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:18 INFO - https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:55:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:55:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:55:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:55:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:55:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:55:18 INFO - retry: Failed, sleeping 30 seconds before retrying 22:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:55:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:55:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:55:48 INFO - retry: Failed, sleeping 60 seconds before retrying 22:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:56:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:56:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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! 22:56:48 INFO - Caught exception: HTTP Error 404: Not Found 22:56:48 INFO - Caught exception: HTTP Error 404: Not Found 22:56:48 INFO - Caught exception: HTTP Error 404: Not Found 22:56:48 INFO - trying https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - Downloading https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:56:48 INFO - Downloaded 1361 bytes. 22:56:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:56:48 INFO - Using the following test package requirements: 22:56:48 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 22:56:48 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:56:48 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:56:48 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'jsshell-linux-x86_64.zip'], 22:56:48 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:56:48 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 22:56:48 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:56:48 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:56:48 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:56:48 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:56:48 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:56:48 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:48 INFO - https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:56:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:56:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:56:48 INFO - retry: Failed, sleeping 30 seconds before retrying 22:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:57:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:57:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:57:18 INFO - retry: Failed, sleeping 60 seconds before retrying 22:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:58:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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! 22:58:19 INFO - Caught exception: HTTP Error 404: Not Found 22:58:19 INFO - Caught exception: HTTP Error 404: Not Found 22:58:19 INFO - Caught exception: HTTP Error 404: Not Found 22:58:19 INFO - trying https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:19 INFO - Downloading https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:20 INFO - Downloaded 21769366 bytes. 22:58:20 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'] 22:58:20 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 22:58:21 INFO - Return code: 0 22:58:21 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 22:58:21 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')]} 22:58:21 INFO - https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:58:21 INFO - retry: Failed, sleeping 30 seconds before retrying 22:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:58:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:58:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:58:51 INFO - retry: Failed, sleeping 60 seconds before retrying 22:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:59:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:59:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:59:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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! 22:59:51 INFO - Caught exception: HTTP Error 404: Not Found 22:59:51 INFO - Caught exception: HTTP Error 404: Not Found 22:59:51 INFO - Caught exception: HTTP Error 404: Not Found 22:59:51 INFO - trying https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:59:52 INFO - Downloaded 21769366 bytes. 22:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:59:53 INFO - Return code: 0 22:59: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')]} 22:59:53 INFO - https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 22:59:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:59:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:59:53 INFO - retry: Failed, sleeping 30 seconds before retrying 23:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:00:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 23:00:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 23:00:23 INFO - retry: Failed, sleeping 60 seconds before retrying 23:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 23:01:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 23:01:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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! 23:01:23 INFO - Caught exception: HTTP Error 404: Not Found 23:01:23 INFO - Caught exception: HTTP Error 404: Not Found 23:01:23 INFO - Caught exception: HTTP Error 404: Not Found 23:01:23 INFO - trying https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 23:01:23 INFO - Downloading https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:24 INFO - Downloaded 14413723 bytes. 23:01:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:01:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:01:24 INFO - Return code: 0 23:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:24 INFO - https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:01:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 23:01:24 INFO - retry: Failed, sleeping 30 seconds before retrying 23:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:01:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:01:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 23:01:54 INFO - retry: Failed, sleeping 60 seconds before retrying 23:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:02:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 23:02:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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! 23:02:54 INFO - Caught exception: HTTP Error 404: Not Found 23:02:54 INFO - Caught exception: HTTP Error 404: Not Found 23:02:54 INFO - Caught exception: HTTP Error 404: Not Found 23:02:54 INFO - trying https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - Downloading https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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 23:02:55 INFO - Downloaded 63753543 bytes. 23:02:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:02:55 INFO - mkdir: /builds/slave/test/properties 23:02:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:02:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:02:55 INFO - Contents: 23:02:55 INFO - build_url:https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 23:02:56 INFO - Running post-action listener: _resource_record_post_action 23:02:56 INFO - Running post-action listener: set_extra_try_arguments 23:02:56 INFO - [mozharness: 2016-08-25 06:02:56.571034Z] Finished download-and-extract step (success) 23:02:56 INFO - [mozharness: 2016-08-25 06:02:56.571267Z] Running populate-webroot step. 23:02:56 INFO - Running pre-action listener: _resource_record_pre_action 23:02:56 INFO - Running main action method: populate_webroot 23:02:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:56 INFO - '--tppagecycles', 23:02:56 INFO - '7'], 23:02:56 INFO - 'tests': ['tsvgm']}}, 23:02:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:02:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:02:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:02:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['damp', 'tps']}, 23:02:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['damp', 'tps']}, 23:02:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['dromaeo_dom']}, 23:02:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['basic_compositor_video']}, 23:02:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:02:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'other-e10s': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore', 23:02:56 INFO - 'tabpaint']}, 23:02:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['tsvgx', 23:02:56 INFO - 'tsvgr_opacity', 23:02:56 INFO - 'tart', 23:02:56 INFO - 'tscrollx', 23:02:56 INFO - 'cart']}, 23:02:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:02:56 INFO - 'tsvgr_opacity', 23:02:56 INFO - 'tart', 23:02:56 INFO - 'tscrollx', 23:02:56 INFO - 'cart']}, 23:02:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--disable-e10s'], 23:02:56 INFO - 'tests': ['tp5o']}, 23:02:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['tp5o']}, 23:02:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--disable-e10s', 23:02:56 INFO - '--xperf_path', 23:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:56 INFO - 'tests': ['tp5n']}, 23:02:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--xperf_path', 23:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:56 INFO - 'tests': ['tp5n']}}, 23:02:56 INFO - 'talos.zip': {'path': '', 23:02:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:56 INFO - Running post-action listener: _resource_record_post_action 23:02:56 INFO - [mozharness: 2016-08-25 06:02:56.588441Z] Finished populate-webroot step (success) 23:02:56 INFO - [mozharness: 2016-08-25 06:02:56.588530Z] Running create-virtualenv step. 23:02:56 INFO - Running pre-action listener: _resource_record_pre_action 23:02:56 INFO - Running main action method: create_virtualenv 23:02:56 INFO - Creating virtualenv /builds/slave/test/build/venv 23:02:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:02:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:02:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:56 INFO - Using real prefix '/usr' 23:02:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:02:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:59 INFO - Installing pip.................done. 23:02:59 INFO - Return code: 0 23:02:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:02:59 INFO - Using env: {'DISPLAY': ':0', 23:02:59 INFO - 'HOME': '/home/cltbld', 23:02:59 INFO - 'LANG': 'en_US.UTF-8', 23:02:59 INFO - 'LANGUAGE': 'en_US:en', 23:02:59 INFO - 'LOGNAME': 'cltbld', 23:02:59 INFO - 'MAIL': '/var/mail/cltbld', 23:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:59 INFO - 'MOZ_NO_REMOTE': '1', 23:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:59 INFO - 'NO_EM_RESTART': '1', 23:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:59 INFO - 'PWD': '/builds/slave/test', 23:02:59 INFO - 'SHELL': '/bin/bash', 23:02:59 INFO - 'SHLVL': '1', 23:02:59 INFO - 'TERM': 'linux', 23:02:59 INFO - 'TMOUT': '86400', 23:02:59 INFO - 'USER': 'cltbld', 23:02:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:59 INFO - '_': '/tools/buildbot/bin/python'} 23:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:02:59 INFO - Cleaning up... 23:02:59 INFO - Return code: 0 23:02:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:02:59 INFO - Using env: {'DISPLAY': ':0', 23:02:59 INFO - 'HOME': '/home/cltbld', 23:02:59 INFO - 'LANG': 'en_US.UTF-8', 23:02:59 INFO - 'LANGUAGE': 'en_US:en', 23:02:59 INFO - 'LOGNAME': 'cltbld', 23:02:59 INFO - 'MAIL': '/var/mail/cltbld', 23:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:59 INFO - 'MOZ_NO_REMOTE': '1', 23:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:59 INFO - 'NO_EM_RESTART': '1', 23:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:59 INFO - 'PWD': '/builds/slave/test', 23:02:59 INFO - 'SHELL': '/bin/bash', 23:02:59 INFO - 'SHLVL': '1', 23:02:59 INFO - 'TERM': 'linux', 23:02:59 INFO - 'TMOUT': '86400', 23:02:59 INFO - 'USER': 'cltbld', 23:02:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:59 INFO - '_': '/tools/buildbot/bin/python'} 23:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:59 INFO - Downloading/unpacking psutil>=3.1.1 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:01 INFO - Installing collected packages: psutil 23:03:01 INFO - Running setup.py install for psutil 23:03:01 INFO - building 'psutil._psutil_linux' extension 23:03:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:03:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:03:01 INFO - building 'psutil._psutil_posix' extension 23:03:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:03:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:03:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:02 INFO - Successfully installed psutil 23:03:02 INFO - Cleaning up... 23:03:02 INFO - Return code: 0 23:03:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:03:02 INFO - Using env: {'DISPLAY': ':0', 23:03:02 INFO - 'HOME': '/home/cltbld', 23:03:02 INFO - 'LANG': 'en_US.UTF-8', 23:03:02 INFO - 'LANGUAGE': 'en_US:en', 23:03:02 INFO - 'LOGNAME': 'cltbld', 23:03:02 INFO - 'MAIL': '/var/mail/cltbld', 23:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:02 INFO - 'MOZ_NO_REMOTE': '1', 23:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:02 INFO - 'NO_EM_RESTART': '1', 23:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:02 INFO - 'PWD': '/builds/slave/test', 23:03:02 INFO - 'SHELL': '/bin/bash', 23:03:02 INFO - 'SHLVL': '1', 23:03:02 INFO - 'TERM': 'linux', 23:03:02 INFO - 'TMOUT': '86400', 23:03:02 INFO - 'USER': 'cltbld', 23:03:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:02 INFO - '_': '/tools/buildbot/bin/python'} 23:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:03:04 INFO - Installing collected packages: mozsystemmonitor 23:03:04 INFO - Running setup.py install for mozsystemmonitor 23:03:04 INFO - Successfully installed mozsystemmonitor 23:03:04 INFO - Cleaning up... 23:03:04 INFO - Return code: 0 23:03:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:03:04 INFO - Using env: {'DISPLAY': ':0', 23:03:04 INFO - 'HOME': '/home/cltbld', 23:03:04 INFO - 'LANG': 'en_US.UTF-8', 23:03:04 INFO - 'LANGUAGE': 'en_US:en', 23:03:04 INFO - 'LOGNAME': 'cltbld', 23:03:04 INFO - 'MAIL': '/var/mail/cltbld', 23:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:04 INFO - 'MOZ_NO_REMOTE': '1', 23:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:04 INFO - 'NO_EM_RESTART': '1', 23:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:04 INFO - 'PWD': '/builds/slave/test', 23:03:04 INFO - 'SHELL': '/bin/bash', 23:03:04 INFO - 'SHLVL': '1', 23:03:04 INFO - 'TERM': 'linux', 23:03:04 INFO - 'TMOUT': '86400', 23:03:04 INFO - 'USER': 'cltbld', 23:03:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:04 INFO - '_': '/tools/buildbot/bin/python'} 23:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:04 INFO - Downloading/unpacking jsonschema==2.5.1 23:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:03:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - Downloading functools32-3.2.3-2.tar.gz 23:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:03:06 INFO - warning: no files found matching '*.txt' 23:03:06 INFO - no previously-included directories found matching 'build' 23:03:06 INFO - no previously-included directories found matching 'dist' 23:03:06 INFO - no previously-included directories found matching '.git*' 23:03:06 INFO - Installing collected packages: jsonschema, functools32 23:03:06 INFO - Running setup.py install for functools32 23:03:06 INFO - warning: no files found matching '*.txt' 23:03:06 INFO - no previously-included directories found matching 'build' 23:03:06 INFO - no previously-included directories found matching 'dist' 23:03:06 INFO - no previously-included directories found matching '.git*' 23:03:06 INFO - Successfully installed jsonschema functools32 23:03:06 INFO - Cleaning up... 23:03:06 INFO - Return code: 0 23:03:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:03:06 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')]} 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:06 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')]} 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:06 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 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:06 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 23:03:06 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 23:03:06 INFO - Using env: {'DISPLAY': ':0', 23:03:06 INFO - 'HOME': '/home/cltbld', 23:03:06 INFO - 'LANG': 'en_US.UTF-8', 23:03:06 INFO - 'LANGUAGE': 'en_US:en', 23:03:06 INFO - 'LOGNAME': 'cltbld', 23:03:06 INFO - 'MAIL': '/var/mail/cltbld', 23:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:06 INFO - 'MOZ_NO_REMOTE': '1', 23:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:06 INFO - 'NO_EM_RESTART': '1', 23:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:06 INFO - 'PWD': '/builds/slave/test', 23:03:06 INFO - 'SHELL': '/bin/bash', 23:03:06 INFO - 'SHLVL': '1', 23:03:06 INFO - 'TERM': 'linux', 23:03:06 INFO - 'TMOUT': '86400', 23:03:06 INFO - 'USER': 'cltbld', 23:03:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:06 INFO - '_': '/tools/buildbot/bin/python'} 23:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:03:07 INFO - Cleaning up... 23:03:07 INFO - Return code: 0 23:03:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:03:07 INFO - Using env: {'DISPLAY': ':0', 23:03:07 INFO - 'HOME': '/home/cltbld', 23:03:07 INFO - 'LANG': 'en_US.UTF-8', 23:03:07 INFO - 'LANGUAGE': 'en_US:en', 23:03:07 INFO - 'LOGNAME': 'cltbld', 23:03:07 INFO - 'MAIL': '/var/mail/cltbld', 23:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:07 INFO - 'MOZ_NO_REMOTE': '1', 23:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:07 INFO - 'NO_EM_RESTART': '1', 23:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:07 INFO - 'PWD': '/builds/slave/test', 23:03:07 INFO - 'SHELL': '/bin/bash', 23:03:07 INFO - 'SHLVL': '1', 23:03:07 INFO - 'TERM': 'linux', 23:03:07 INFO - 'TMOUT': '86400', 23:03:07 INFO - 'USER': 'cltbld', 23:03:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:07 INFO - '_': '/tools/buildbot/bin/python'} 23:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:07 INFO - Downloading/unpacking blobuploader==1.2.4 23:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:09 INFO - Downloading blobuploader-1.2.4.tar.gz 23:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:03:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:03:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:10 INFO - Downloading docopt-0.6.1.tar.gz 23:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:03:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:03:10 INFO - Running setup.py install for blobuploader 23:03:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:03:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:03:10 INFO - Running setup.py install for requests 23:03:10 INFO - Running setup.py install for docopt 23:03:10 INFO - Successfully installed blobuploader requests docopt 23:03:10 INFO - Cleaning up... 23:03:10 INFO - Return code: 0 23:03:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:03: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')]} 23:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03: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')]} 23:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:03:10 INFO - Using env: {'DISPLAY': ':0', 23:03:10 INFO - 'HOME': '/home/cltbld', 23:03:10 INFO - 'LANG': 'en_US.UTF-8', 23:03:10 INFO - 'LANGUAGE': 'en_US:en', 23:03:10 INFO - 'LOGNAME': 'cltbld', 23:03:10 INFO - 'MAIL': '/var/mail/cltbld', 23:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:10 INFO - 'MOZ_NO_REMOTE': '1', 23:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:10 INFO - 'NO_EM_RESTART': '1', 23:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:10 INFO - 'PWD': '/builds/slave/test', 23:03:10 INFO - 'SHELL': '/bin/bash', 23:03:10 INFO - 'SHLVL': '1', 23:03:10 INFO - 'TERM': 'linux', 23:03:10 INFO - 'TMOUT': '86400', 23:03:10 INFO - 'USER': 'cltbld', 23:03:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:10 INFO - '_': '/tools/buildbot/bin/python'} 23:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:03:11 INFO - Running setup.py (path:/tmp/pip-8t8w41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:03:11 INFO - Running setup.py (path:/tmp/pip-TRMGIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:03:11 INFO - Running setup.py (path:/tmp/pip-v2L1CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:03:11 INFO - Running setup.py (path:/tmp/pip-twCTeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:03:11 INFO - Running setup.py (path:/tmp/pip-HN8gK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:03:11 INFO - Running setup.py (path:/tmp/pip-ixkt0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:03:11 INFO - Running setup.py (path:/tmp/pip-xHgziA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:03:11 INFO - Running setup.py (path:/tmp/pip-5Wrksq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:03:11 INFO - Running setup.py (path:/tmp/pip-2IN0Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:03:11 INFO - Running setup.py (path:/tmp/pip-3ZO4Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:03:11 INFO - Running setup.py (path:/tmp/pip-FFKgX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:03:11 INFO - Running setup.py (path:/tmp/pip-DEwSaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:03:11 INFO - Running setup.py (path:/tmp/pip-FT2T8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:03:11 INFO - Running setup.py (path:/tmp/pip-hzInIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:12 INFO - Running setup.py (path:/tmp/pip-oh4zHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:03:12 INFO - Running setup.py (path:/tmp/pip-90QCs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:03:12 INFO - Running setup.py (path:/tmp/pip-zt_UyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:03:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:03:12 INFO - Running setup.py install for manifestparser 23:03:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:03:12 INFO - Running setup.py install for mozcrash 23:03:12 INFO - Running setup.py install for mozdebug 23:03:12 INFO - Running setup.py install for mozdevice 23:03:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:03:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:03:12 INFO - Running setup.py install for mozfile 23:03:12 INFO - Running setup.py install for mozhttpd 23:03:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:03:12 INFO - Running setup.py install for mozinfo 23:03:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:03:12 INFO - Running setup.py install for mozInstall 23:03:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Running setup.py install for mozleak 23:03:13 INFO - Running setup.py install for mozlog 23:03:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Running setup.py install for moznetwork 23:03:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Running setup.py install for mozprocess 23:03:13 INFO - Running setup.py install for mozprofile 23:03:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Running setup.py install for mozrunner 23:03:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:03:13 INFO - Running setup.py install for mozscreenshot 23:03:13 INFO - Running setup.py install for moztest 23:03:13 INFO - Running setup.py install for mozversion 23:03:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:03:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:03:14 INFO - Cleaning up... 23:03:14 INFO - Return code: 0 23:03:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:03:14 INFO - Using env: {'DISPLAY': ':0', 23:03:14 INFO - 'HOME': '/home/cltbld', 23:03:14 INFO - 'LANG': 'en_US.UTF-8', 23:03:14 INFO - 'LANGUAGE': 'en_US:en', 23:03:14 INFO - 'LOGNAME': 'cltbld', 23:03:14 INFO - 'MAIL': '/var/mail/cltbld', 23:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:14 INFO - 'MOZ_NO_REMOTE': '1', 23:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:14 INFO - 'NO_EM_RESTART': '1', 23:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:14 INFO - 'PWD': '/builds/slave/test', 23:03:14 INFO - 'SHELL': '/bin/bash', 23:03:14 INFO - 'SHLVL': '1', 23:03:14 INFO - 'TERM': 'linux', 23:03:14 INFO - 'TMOUT': '86400', 23:03:14 INFO - 'USER': 'cltbld', 23:03:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:14 INFO - '_': '/tools/buildbot/bin/python'} 23:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:03:14 INFO - Running setup.py (path:/tmp/pip-g8MlDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:03:14 INFO - Running setup.py (path:/tmp/pip-0ABWdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:03:14 INFO - Running setup.py (path:/tmp/pip-u91j8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:03:14 INFO - Running setup.py (path:/tmp/pip-0kwLgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:03:14 INFO - Running setup.py (path:/tmp/pip-FLFzp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:03:14 INFO - Running setup.py (path:/tmp/pip-9nXXDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:03:14 INFO - Running setup.py (path:/tmp/pip-B3pkTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:03:14 INFO - Running setup.py (path:/tmp/pip-cS8Zoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:03:14 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)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:03:14 INFO - Running setup.py (path:/tmp/pip-iWZhXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:03:14 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)) 23:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:03:14 INFO - Running setup.py (path:/tmp/pip-K6lvy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:03:15 INFO - Running setup.py (path:/tmp/pip-liJ9di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:03:15 INFO - Running setup.py (path:/tmp/pip-SSujlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:03:15 INFO - Running setup.py (path:/tmp/pip-37EyoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:03:15 INFO - Running setup.py (path:/tmp/pip-vE4JLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:15 INFO - Running setup.py (path:/tmp/pip-hIsFaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:03:15 INFO - Running setup.py (path:/tmp/pip-EGgJUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:03:15 INFO - Running setup.py (path:/tmp/pip-nEK_YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:03:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:17 INFO - Downloading blessings-1.6.tar.gz 23:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:03:17 INFO - Installing collected packages: blessings 23:03:17 INFO - Running setup.py install for blessings 23:03:17 INFO - Successfully installed blessings 23:03:17 INFO - Cleaning up... 23:03:17 INFO - Return code: 0 23:03:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:03:17 INFO - Reading from file tmpfile_stdout 23:03:17 INFO - Current package versions: 23:03:17 INFO - argparse == 1.2.1 23:03:17 INFO - blessings == 1.6 23:03:17 INFO - blobuploader == 1.2.4 23:03:17 INFO - docopt == 0.6.1 23:03:17 INFO - functools32 == 3.2.3-2 23:03:17 INFO - jsonschema == 2.5.1 23:03:17 INFO - manifestparser == 1.1 23:03:17 INFO - mozInstall == 1.12 23:03:17 INFO - mozcrash == 0.17 23:03:17 INFO - mozdebug == 0.1 23:03:17 INFO - mozdevice == 0.48 23:03:17 INFO - mozfile == 1.2 23:03:17 INFO - mozhttpd == 0.7 23:03:17 INFO - mozinfo == 0.9 23:03:17 INFO - mozleak == 0.1 23:03:17 INFO - mozlog == 3.3 23:03:17 INFO - moznetwork == 0.27 23:03:17 INFO - mozprocess == 0.23 23:03:17 INFO - mozprofile == 0.28 23:03:17 INFO - mozrunner == 6.12 23:03:17 INFO - mozscreenshot == 0.1 23:03:17 INFO - mozsystemmonitor == 0.3 23:03:17 INFO - moztest == 0.7 23:03:17 INFO - mozversion == 1.4 23:03:17 INFO - psutil == 3.1.1 23:03:17 INFO - requests == 1.2.3 23:03:17 INFO - wsgiref == 0.1.2 23:03:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:03:17 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')]} 23:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:17 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')]} 23:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:17 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 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:17 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 23:03:17 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 23:03:17 INFO - Using env: {'DISPLAY': ':0', 23:03:17 INFO - 'HOME': '/home/cltbld', 23:03:17 INFO - 'LANG': 'en_US.UTF-8', 23:03:17 INFO - 'LANGUAGE': 'en_US:en', 23:03:17 INFO - 'LOGNAME': 'cltbld', 23:03:17 INFO - 'MAIL': '/var/mail/cltbld', 23:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:17 INFO - 'MOZ_NO_REMOTE': '1', 23:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:17 INFO - 'NO_EM_RESTART': '1', 23:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:17 INFO - 'PWD': '/builds/slave/test', 23:03:17 INFO - 'SHELL': '/bin/bash', 23:03:17 INFO - 'SHLVL': '1', 23:03:17 INFO - 'TERM': 'linux', 23:03:17 INFO - 'TMOUT': '86400', 23:03:17 INFO - 'USER': 'cltbld', 23:03:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:17 INFO - '_': '/tools/buildbot/bin/python'} 23:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:03:18 INFO - Cleaning up... 23:03:18 INFO - Return code: 0 23:03:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e17030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2046400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, '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': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', '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 23:03:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:03:18 INFO - Using env: {'DISPLAY': ':0', 23:03:18 INFO - 'HOME': '/home/cltbld', 23:03:18 INFO - 'LANG': 'en_US.UTF-8', 23:03:18 INFO - 'LANGUAGE': 'en_US:en', 23:03:18 INFO - 'LOGNAME': 'cltbld', 23:03:18 INFO - 'MAIL': '/var/mail/cltbld', 23:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:18 INFO - 'MOZ_NO_REMOTE': '1', 23:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:18 INFO - 'NO_EM_RESTART': '1', 23:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:18 INFO - 'PWD': '/builds/slave/test', 23:03:18 INFO - 'SHELL': '/bin/bash', 23:03:18 INFO - 'SHLVL': '1', 23:03:18 INFO - 'TERM': 'linux', 23:03:18 INFO - 'TMOUT': '86400', 23:03:18 INFO - 'USER': 'cltbld', 23:03:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:18 INFO - '_': '/tools/buildbot/bin/python'} 23:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:03:18 INFO - Cleaning up... 23:03:18 INFO - Return code: 0 23:03:18 INFO - Running post-action listener: _resource_record_post_action 23:03:18 INFO - Running post-action listener: _start_resource_monitoring 23:03:18 INFO - Starting resource monitoring. 23:03:18 INFO - [mozharness: 2016-08-25 06:03:18.334962Z] Finished create-virtualenv step (success) 23:03:18 INFO - [mozharness: 2016-08-25 06:03:18.335429Z] Running install step. 23:03:18 INFO - Running pre-action listener: _resource_record_pre_action 23:03:18 INFO - Running main action method: install 23:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:03:18 INFO - Reading from file tmpfile_stdout 23:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 23:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:03:18 INFO - Reading from file tmpfile_stdout 23:03:18 INFO - Output received: 23:03:18 INFO - Usage: mozinstall [options] installer 23:03:18 INFO - Options: 23:03:18 INFO - -h, --help show this help message and exit 23:03:18 INFO - -d DEST, --destination=DEST 23:03:18 INFO - Directory to install application into. [default: 23:03:18 INFO - "/builds/slave/test"] 23:03:18 INFO - --app=APP Application being installed. [default: firefox] 23:03:18 INFO - mkdir: /builds/slave/test/build/application 23:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:03:35 INFO - Reading from file tmpfile_stdout 23:03:35 INFO - Output received: 23:03:35 INFO - /builds/slave/test/build/application/firefox/firefox 23:03:35 INFO - Running post-action listener: _resource_record_post_action 23:03:35 INFO - [mozharness: 2016-08-25 06:03:35.190849Z] Finished install step (success) 23:03:35 INFO - [mozharness: 2016-08-25 06:03:35.191124Z] Running run-tests step. 23:03:35 INFO - Running pre-action listener: _resource_record_pre_action 23:03:35 INFO - Running main action method: run_tests 23:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:03:35 INFO - Python 2.7.3 23:03:35 INFO - Return code: 0 23:03:35 INFO - grabbing minidump binary from tooltool 23:03: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')]} 23:03:35 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 0x20d5570>, '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 0x20d6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:03:35 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 23:03:35 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 23:03:35 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 23:03:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:03:35 INFO - Return code: 0 23:03:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:03:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:03:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:03:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:03:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:03:35 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/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 23:03:35 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/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 23:03:35 INFO - Using env: {'DISPLAY': ':0', 23:03:35 INFO - 'HOME': '/home/cltbld', 23:03:35 INFO - 'LANG': 'en_US.UTF-8', 23:03:35 INFO - 'LANGUAGE': 'en_US:en', 23:03:35 INFO - 'LOGNAME': 'cltbld', 23:03:35 INFO - 'MAIL': '/var/mail/cltbld', 23:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:35 INFO - 'MOZ_NO_REMOTE': '1', 23:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:35 INFO - 'NO_EM_RESTART': '1', 23:03:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:35 INFO - 'PWD': '/builds/slave/test', 23:03:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:03:35 INFO - 'SHELL': '/bin/bash', 23:03:35 INFO - 'SHLVL': '1', 23:03:35 INFO - 'TERM': 'linux', 23:03:35 INFO - 'TMOUT': '86400', 23:03:35 INFO - 'USER': 'cltbld', 23:03:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211', 23:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:35 INFO - '_': '/tools/buildbot/bin/python'} 23:03:35 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/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 23:03:35 INFO - mozversion application_buildid: 20160824201226 23:03:35 INFO - mozversion application_changeset: 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 23:03:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:03:35 INFO - mozversion application_name: Firefox 23:03:35 INFO - mozversion application_remotingname: firefox-dev 23:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:03:35 INFO - mozversion application_vendor: Mozilla 23:03:35 INFO - mozversion application_version: 50.0a2 23:03:35 INFO - mozversion platform_buildid: 20160824201226 23:03:35 INFO - mozversion platform_changeset: 8a0abccd95639178abc9c36aebd9e0c7cf9ea5d5 23:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:03:35 INFO - mozversion platform_version: 50.0a2 23:03:35 INFO - using testdate: 1472105015 23:03:35 INFO - actual date: 1472105015 23:03:35 INFO - starting webserver on 'localhost:41409' 23:03:35 INFO - SUITE-START | Running 2 tests 23:03:35 INFO - TEST-START | dromaeo_css 23:03:35 INFO - operating with platform_type : linux_ 23:03:35 INFO - Initialising browser for dromaeo_css test... 23:03:35 INFO - TEST-INFO | started process 30263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpELzEPS/profile http://localhost:41409/getInfo.html) 23:03:39 INFO - PROCESS | 30263 | __metrics Screen width/height:1600/1200 23:03:39 INFO - PROCESS | 30263 | colorDepth:24 23:03:39 INFO - PROCESS | 30263 | Browser inner width/height: 1024/697 23:03:39 INFO - PROCESS | 30263 | __metrics 23:03:40 ERROR - PROCESS | 30263 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:03:41 INFO - TEST-INFO | 30263: exit 0 23:03:41 INFO - Browser initialized. 23:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 23:03:41 INFO - TEST-INFO | started process 30387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpELzEPS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:53 INFO - PROCESS | 30387 | RSS: Main: 152862720 23:03:53 INFO - PROCESS | 30387 | 23:04:42 INFO - PROCESS | 30387 | 1472105082602 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] 23:06:50 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41409/tests/dromaeo/cssquery-ext.html) 23:06:52 INFO - PROCESS | 30387 | RSS: Main: 157663232 23:06:52 INFO - PROCESS | 30387 | 23:09:54 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-ext.html (next: http://localhost:41409/tests/dromaeo/cssquery-jquery.html) 23:09:54 INFO - PROCESS | 30387 | RSS: Main: 153948160 23:09:54 INFO - PROCESS | 30387 | 23:12:56 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41409/tests/dromaeo/cssquery-mootools.html) 23:12:57 INFO - PROCESS | 30387 | RSS: Main: 154071040 23:12:57 INFO - PROCESS | 30387 | 23:15:58 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41409/tests/dromaeo/cssquery-prototype.html) 23:15:59 INFO - PROCESS | 30387 | RSS: Main: 152772608 23:15:59 INFO - PROCESS | 30387 | 23:19:01 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41409/tests/dromaeo/cssquery-yui.html) 23:19:02 INFO - PROCESS | 30387 | RSS: Main: 155164672 23:19:02 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-yui.html (next: http://localhost:41409/tests/dromaeo/cssquery-dojo.html) 23:22:04 INFO - PROCESS | 30387 | RSS: Main: 155877376 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | __start_tp_report 23:22:04 INFO - PROCESS | 30387 | _x_x_mozilla_page_load 23:22:04 INFO - PROCESS | 30387 | _x_x_mozilla_page_load_details 23:22:04 INFO - PROCESS | 30387 | |i|pagename|runs| 23:22:04 INFO - PROCESS | 30387 | |0;dojo.html;3313.668633136687;3314.188023934136;3328.7337013038946;3353.7820041697305;3368.040108569057;5640.520555752761;5707.571932105098;5721.056025755751;5736.627119237247;5754.798582049629;5641.830745077644;5665.065264231407;5706.029974904266;5709.942900570993;5751.539876809856;5171.793128274874;5224;5241.3186285782795;5265.210218467241;5278.604104692164;5143.434222235551;5146.845594632148;5178.818741344054;5186.896262074756;5225.399079105894;5236.869078273055;5254.290670759437;5257.605679574028;5308.840734777963;5325;5309.840704778863;5322.866928326784;5340.092184328673;5341.092014357569;5344.144936810092;4976.129177393942;5049.166887463564;5223.660462069954;5230.895382092375;5298.6555873868465;5411.404745477994;5444.428335024805;5558.888822223533;5575.609707320489;5590.385057643656;6014.578979471439;6053.364396738367;6055.303640081403;6072.271327440735;6082.878342433127;5853.502452291517;6106.542009349317;6114;6122.969385153046;6135.69321533926;5588.413216612278;5612.7754889804355;5633.746481408305;5681.176229446707;5719.170720245583;6188.8762224755255;6210.192674952227;6226.315105338409;6229.501639868799;6231.158793562901;5781.277340332458;5854.151148083504;5953;5964.373740757244;5976.910346344808;5936.406359364029;6021.066734656135;6078.969605151946;6163.19878415812;6165.8458538536;6103.69896940161;6135.662538560422;6136.355682653257;6148.231471066117;6159.96920015406;5913.408659134138;6120.540959427972;6134.01366997351;6142.696488816694;6152.969235153795;4592.127495775792;4614.238650622609;4631.004334068191;4656.254999200111;4692.249240121632;4135.91728165435;4147.440095587118;4151.667866570667;4176.91646167081;4179.4357761701785;5518.862028449321;5803.65178089316;5803.738831752581;5813;5815.651060936273;6077.36187700294;6085.330613632497;6125.693715314216;6212.099245609452;6217.253929528486;5829.038208695518;5884.323302820145;5902.586818922634;5909.379515150933;5924.377940316204;5138.845834624967;5289.6032797539565;5295;5342.839714808562;5352.330958630171;6188.504919606421;6295.401936815995;6301.495880329563;6410.519211059189;6411.903821442682;6102.481289090477;6117.204763380732;6143.201383820075;6144.662043587646;6145.72344244519;6094.634321940698;6157.353477884758;6367.458766004941;6387.201599800025;6404.263509696445;5894.440028197314;5965.940340596539;5990.550708696952;6008.909866351921;6039.607425517327;6062.42406971337;6079.787207447718;6089.330173680803;6096;6116.418940200674;5781.046127389102;5823.155642431739;5895.7052147391605;5924.46679798803;5936.46571808522;5835.94164058354;5911.91132133027;5923.437273459187;5931.347551769216;5937.643741375531;5895.498882595028;5902.6458412495385;5917.37867523921;5924.851878703067;5929.407059294036;5863.2670916135485;5888.735006924613;5942.1978032965;5953.166556681981;5961.254843144607;5770.769169233352;5849.736761845642;5854.590178687451;5873.295204575478;5888.970555147197 23:22:04 INFO - PROCESS | 30387 | |1;ext.html;581.4563383236674;605.7698074731601;638.635977492829;656.8029591122663;669.7622344067859;40910;46253.53746462534;46442.535574644244;46473.76763116188;46545.53454465454;47279.29081063778;47371.289430658566;47976.520234797645;48129;48384.51615483844;9125.726228213165;9247.907520924806;9257.675981340655;9271.397359171666;9271.768205794875;9210.723678289629;9305.162535371815;9338.813223735522;9365.859512107323;9367.718968430958;9283.535823208813;9295.628174872996;9329.346945713804;9334.113259240361;9385.95307023464;9316.953415232914;9355.719328420124;9378.015308392623;9402.811943761155;9424.858627120599;9196.310276729271;9204.815903681889;9248.121428464285;9258.166764991116;9299.209567186797;37200.25599487995;37504.43743343852;37625.435618465744;37724.24551508955;37725.43411848824;3215.324781795826;3661.3958696814993;3822.2928758179823;4137.2552940470705;4370.2133615949115;33719.32561348759;33871.49192762111;34800.82599586986;35878.46182307268;35904.281914361825;4733.313669517901;4742.739149346785;4752.42970843501;4769.236922092448;4859.58693511052;412971;414351;415497;416263;417499;66234;66742.99885501721;66804;67076.6646166766;67225.66387168033;39408.6059139405;39885.40171897424;39951.80024099861;41199;70387.2961270391;19090.904545477184;19097.713534296996;19216.61566768657;19396.321128760424;19397.32109376165;12683.302418367079;12762.489500420064;12776.6805829855;12779.297138657277;12789.680257993625;21000.15999360039;21007.684884726743;21160.78839211619;21192.046357913932;21230.36308910735;7616.80957976055;7618.200088990576;7716.344110750649;7727.343175830005;7970.123286438487;1032.4218437674776;1086.3970496374588;1112.4826955465746;1121.3608243301403;1157.9478923448464;33788.324233515195;34639.30721385558;34708.30583388318;34763.826180868935;35109.82445087809;1142.2118738070706;1157.2073129906041;1160.8200728887036;1166.8716441191461;1169.7835900358461;17758.37845675395;17850.285988560572;18018.459446216635;18092.457226282968;18205;647582;649083;649525;653280;655176;64656.35343646503;64755.352446475874;65389.67305163444;65426;65773;1390.478570536049;1410.2384712255268;1414.2575148047358;1430.5493769462587;1431.6921861799763;32111.357772843945;33262.33475330528;33282.5007624881;33564.49653255252;33592.328153436305;55408.168877466065;55661.721691391285;55725.44274557203;55810;55821.720891395285;401106;401455;402258;402730;402880;29905;29922.850385747934;30668.23329416693;30708.84645576758;30825.229369265948;51923.22115168351;52181.21728174004;52266.738666306424;52779.73610131925;53373.46626533685;43080;43814.56185438105;44152.33771493366;44651;45623.77188114038;42602.360964584936;43774.12451751011;44524;44588.33117503305;45256.54743452524;44249;44807.327890081026;45898.31152532648;45988;48534.75732621314;38168;38907;40153.39769903512;40493.1901361977;40883.79558102191;30507.2373190672;31037.379252415278;31072.68927310698;31248;31350.843245783624 23:22:04 INFO - PROCESS | 30387 | |2;jquery.html;404.24002874595755;409.80534246233026;411.8990847242426;425.5404163503417;428.712762449159;19576.21695132195;20123.39629811104;20273.695894561555;20795.480112997146;21116.57766844664;19814.900925495353;19937.501562460944;20254;20258;20482.2831200908;5741.224934633823;5955.731992060346;5957.523398128161;5964.552658550604;5968.462838344548;5829.533637309027;5851.444112809298;5872.941270587304;5876.941230587703;5888.528917686596;5712.828615141552;5837.620554663955;5864.23764910561;5884.558658100659;5887.470127688529;5601.187827764971;5762.106873434583;5832.88334233313;5847.122931560258;5859.384764599698;5638.830835074954;5736.598438109334;5741.224934633813;5754.453326933976;5859.414058594107;23343.649845252334;23632.40918977022;23740.64389034166;23757.16849910245;24207.878960605085;2449.216250799745;2642.524345617788;2679.866006699657;2740.643716316886;3013.0659495556447;11232.831507527393;11239.66281011571;11448.94275528617;15488.690226195526;15594.37622495099;1959.3962406126752;2034.0744961042838;2057.0537552725764;2066.3904148276297;2111.3032699209225;82122.58938705268;83437.58281208554;83535.582322088;83806;84950.57524712398;11276.210665253517;11359.659210223706;11425.485853136628;11706.239094458833;11724.472398741906;16142.950708203929;16146.950448220829;16149.273282702306;16172.272247748644;16320.428784992468;8481.660733570712;8604.440711353742;8772.95613521941;8892.15524525169;8899.777505562413;8460.407771456063;8512.829743405096;8600;8679.91320086791;8755.255803256667;4884.902301953941;4932.446279421971;4979.6265280104135;5064.5441910228255;5080.644354895122;1948.5323522354533;2058.2898899879815;2076.0761461149646;2122.204173434962;2147.7530084040222;951.2817822544073;988.7676396046924;1051.915846732275;1052.8210204265292;1078.4769386847372;19533;20448.488787780425;20662.276820311217;20777.480562986046;20788.480287992617;1068.4123731947398;1072.5441687282873;1084.0947808579767;1107.457345900503;1135.5911871726173;10676.412797296223;11613.535458581731;11624.476898539586;11669.183157179086;11739.413029348669;491792;492349;498539;505344;517195;88809.55595222111;89344;103023;104263.47868260762;105463.4726826361;1036.4506811389974;1063.7287491689724;1074.5648012554927;1083.8861919498497;1094.1356328500397;16488.25802838899;18500.869148234535;18961.90519047396;18990.525236869187;19166.13752381174;39741;40052.799736001136;44941.550584493736;46023.76988115038;47720.522794772995;52353.21470178026;61280;61964.38035619767;62787;63120.68439657772;8722.738317850475;8856.822863542822;9001.279897608045;9136.451812891248;9298.116678915492;13175.14361566495;13609.931950340186;13628.454861805416;14138.22239776822;14225;11534.711632209262;11956.163068585116;12073.456694448596;12271.69320766988;12681.682957926125;9775;10198.847017294598;11849.348285844362;12516.31160286193;12546.1844980076;11778.411079446165;12262.325572093263;12510.499580016698;12647;12680.619581412573;8950.731478055668;9048.909510904807;9206.861897071416;9207.217386522221;9491.098345657152;9263.305252106255;12370.319632420304;12500.812487812509;12631.242125472501;12884.677883052998 23:22:04 INFO - PROCESS | 30387 | |3;mootools.html;1591.8328575499568;1617.4096454794;1778.4486809089183;1881.6142690748397;1900.2873922279136;8479;9169.862452063217;9250;9968.451735154573;9987.750306242348;9523.714288571355;9920;9927.156191723694;9932.056454636799;9963.950180249089;2547.9617805732883;2590.5984572391217;2613.2421597736634;2616.6859976802716;2618.1621880998086;2518.6096155095897;2608.752168543985;2627.986860065697;2649.854258015818;2649.973500265002;2563.6667233259745;2568.640390345344;2610.765031147196;2634.789216862656;2635.156749840052;2529.4435224250637;2547.426828963478;2559.641650168978;2575.742425757428;2579.0844250291066;2494.5759220932487;2501.574732295514;2506.8370555913807;2545.389106614418;2559.091522509501;9806.362586431858;9952.80094398108;10012.9486403928;10018.448985305806;10040.64857729976;5767.913481297784;5949.25634295713;5954.106883967396;5976.193213916109;5977.342492325841;3498.6151523332414;3579;3639.5268615080136;3686.4838922550866;3689.5019172411917;1204.0909113619161;1206.8069108942527;1216.22769541341;1258.1318889965894;1278.718681889992;13269.800952985714;13682.657933551642;13720.862791372057;13837.446502140003;13940.302984850818;4928.063667903087;5026.623003274696;5050.419201791768;5100.2349647553165;5196.68819870809;10732.2487425881;10760.46197690128;10772.892271077346;10804;10827.67516974492;5827.825165245049;5874.50066744323;5891.617044892068;5899.970500147472;5913.64518128905;4856.174450343379;5214.7914083437;5312.07038768214;5338.039152952429;5503.257060296889;4183.853565125206;4205.978970105191;4298.3552467130185;4347.478302603708;4369.9126017479475;1263.0258875518848;1267.8399264672905;1274.936253187337;1281.9743605127844;1289.8000809874484;1004.829179039565;1055.303499690216;1056.8890266522058;1066.0139371081718;1106.1869525898458;6575.276719560845;6755.695993680296;6804.65976701163;6841.315868413119;6863.004864294649;471.8133893258458;491.4643039087412;492.8964917367393;493.71364608526966;498.77056553985574;4743.0988112258565;4750.477447480775;4767.713937163781;4792.353032340589;4877.439094504178;12010;12076.335801531;12174.330411827257;12241.143119981516;12414.875851241553;12206.450709718085;12239.20445171061;12244.75510489803;12310.569130080405;12352.938235308766;8973.910260897308;9023.593938272794;9083.318751093562;9203.125703058198;9243.76890577741;6658.76694315716;6734.9326506734305;6745.156855393076;6815.625140617313;6838.623875686885;11168.274062185932;11286.49210785533;11291.548338066385;11445.542178312775;11484.540618375171;11176.161787866105;11400.771984560428;11458.312501249618;11484.425778710864;11592.0146787524;8006.919930800617;8050.074241462306;8085.83828323442;8092.069412017458;8154;9432.811343772948;9546.236301095756;9575;9576.521173941414;9585.616575336908;8034.196580342153;8263;8487.957560212159;8498.957505212435;8641.265492433213;8304.377171712025;8405.831883362422;8442.451240669337;8447.366447516339;8555.144485551395;7571.46999710015;7571.772846814604;7609.124950630527;7615.923840761521;7664.770056898302;5817.563682723728;5873.119032145041;5955.285365756137;6093.390660933871;6135.662538560422;5705.914411283751;5723.7996670116345;5728.742206600629;5769.68266745333;5820.70896455184 23:22:04 INFO - PROCESS | 30387 | |4;prototype.html;357.3888650407803;357.6298531020394;357.7513628028521;362.5305229727506;367.3332900785075;5868.853278668035;5884.029135192699;5888.175655408241;5900.580761887627;5915.674637894914;5528.226048353224;5749.540036797057;5760.971195144029;5791.333996590393;5797.478226959573;4504.414426124607;4526.23054080807;4541.841035563756;4583.610393116589;4593.53007037748;4541.205289074399;4575.633949284066;4577.885552861172;4593.839215627454;4597.816087356502;4518.6951488587065;4565.840195593155;4576.816927322903;4579.564941330568;4585.816567337302;4445.911081778362;4497.797599108048;4531.750753708545;4545.0909818036525;4570.131674981742;4040.0505881117915;4040.353543433066;4046.817893194813;4057.107436363995;4060.4721386219603;5647.407022262644;5658.377578466366;5695.373508914016;5724.570657200727;5724.8282551523525;4954.900901981976;5173.896522069537;5176.7152806596;5183.3261675981885;5196.792128314863;6078.63230773077;6084.209052823105;6096.512279017668;6138.785142520035;6144.446999770043;4161.56303588122;4345.152695224432;4371.300591905312;4374.409454723604;4381.978090109561;6027.48766354856;6209.9068513972325;6305;6317.6209427434505;6353;4414.161309351213;4447.132809102259;4474.843380481668;4495.25828238337;4496.955030449653;4503.121891231244;4535.297028960516;4544.409226800561;4551.453825540956;4551.840685576055;5010.624203184776;5185.196294574347;5187;5198.818041368534;5221.765020574083;6081;6138.386161383915;6140.723667434976;6161.630302181883;6196.459451624813;1537.0931150620963;1543.5446543269538;1552.8524790144918;1556.3852278350214;1558.8519090686366;971.8473581017938;1006.808706345792;1007.8460163113194;1010.8079464901646;1021.8211812932707;5238.502342277554;5249.580033597303;5275.894482110336;5278.762455689503;5281.709505977131;5465.289512363447;5499.5976026113885;5583.441655834384;5592.468715472024;5627.296587926509;4934.827281045146;5219.869503262449;5274.92087618686;5288.735563221823;5317.41508434072;2934.8972785952815;2959.230600044004;2965.866536005885;2967.3916847046303;2992.5361568956846;5653.971730141323;5718.228039214736;5763.596548241583;5804.622699524517;5817.185594016841;5545.251391062155;5571.609987300931;5611.663300202001;5612.239799334456;5639.351474580394;5704.973104841169;5719.28508936383;5731.942680573225;5835.416458354215;5861.9706901465215;5281.9471805281455;5515.172724091419;5539.972300138474;5565.777368905198;5583.720813959205;5331.920021199763;5387.730613469389;5432.864178395572;5507.127576623967;5520.613557050968;6158.907616385668;6335.493160547053;6527.184101987252;6527.836804079936;6531.510136739858;4442.933355999728;4455.7994890229365;4458.308962110878;4458.799354029012;4478.664100192434;6132.2947860996555;6242.875142497215;6278.843028924313;6352.491800656029;6359.236891573041;6009.759609615567;6065.363136870565;6083.391660833881;6093.29927058394;6108.72510737009;5844.912326315194;6079.112421599705;6140.815775526741;6151.938480615316;6163.260408750799;6059.697165109523;6071.421430428209;6075.270967483753;6101.938980610137;6169.96915015422;6196.876062478816;6212.751489940351;6213.720382582705;6221.377862213742;6239.688015599111;5760.308762948473;5973.522118230444;5976.671283079472;5991.970040149771;6004.909926351021 23:22:04 INFO - PROCESS | 30387 | |5;yui.html;823.4194892600717;831.210350167341;837.61469723927;854.94442861214;928.9117533834284;16647.00117992921;16840.74738878918;16873.578160545978;16977;16997.660046799072;16638.251278692456;16767.580810479743;16853.157342132876;16863.747043794323;16887.831121688778;870.1820288928387;873.8252349530088;880.0187790613484;885.8006948436615;900.4732231644496;880.3705350674267;881.0880738435688;883.9071897450772;885.9822803543925;890.812929284851;932.1796818799481;932.324065052838;934.0892629686069;934.9392289501161;935.036911980661;924.9815003699888;927.7309580221728;928.3130483442238;929.5956259027345;930.692871352452;687.0861753867345;687.161662771418;687.5015613680092;688.6178171115029;689.3451221339698;15590.766138507932;15591.45429909959;15604.60988475286;15641.810146579488;15651.608709782233;14843.925780371137;14877.256137193097;14898.329575169035;15255;16275.593110172222;13149.408276627575;13304.467821287137;13481.797773033413;13579.185248885;13893.930530347385;4652.534746525354;4656.4877863434995;4680.555347242007;4830.420349558076;4873.293372460973;89250.5537472315;89444;90333.54833225792;90799;92597.53701231451;12086;12105.818412723816;12126.696832579257;12142.392880355947;12329.815052774216;22563.21028764018;22799.430014249778;22823.429414264778;22840.65739013916;22921.88539057294;9376.109269619512;9455.76360590977;9522.90477095234;9552.283578731623;9616.23070154386;5390.218418329398;5406.59450541211;5424.105022671294;5436.456354364532;5508.944910550843;3882.165334453106;4017.6986725995666;4027.134166154291;4039.2729308724124;4048.1701251244012;665.0356982375478;665.6937808608094;688.1913751342153;688.3735800421592;694.4687314204638;697.7801992372387;812.9354123808705;822.9012518497818;843.5697794125041;845.8942632170979;10149.179139908485;10513.789724205473;10555.525001374957;10801.513931873085;10922.563097476172;657.9407853293227;749.3967356278248;817.9877301840477;843.3000609494105;861.9870701939476;5094.133997220481;5150.098732721759;5161.27742116104;5161.329027226511;5220.650707181783;101078;102140;103073;135503.32248338696;137555;70619.64690176517;83376.58311708523;88547.55726221327;105025.94974050162;105626.1996161221;87072.99999999873;91398.54300728453;93439.53280233691;94688;96267.51866240765;10056.145227655732;10146.644867429604;10279.229057820543;10477;10548.894511054792;53770.19344709754;54192.45807541874;55809.720951394986;56350.718246408505;56533.71733141472;72912;82914;83493.58253208695;83544;83676;13067.869321307046;13082.934585327013;13349.265790381622;13485.056046076681;13595.45618175262;15039.924800375928;15104.924475377993;15124.621884452978;15125.848741512884;15197.316120774813;13694.65763355924;13957;13992.650183745081;14156.787648185491;14491.492797752027;13293.66765830862;13416.530421435204;13517.932410337886;13577.389017494434;13646.181229126285;13507.527236546674;13747.381367838272;13805.378757956118;13844.10013349129;13888.305584720521;11091.944540277247;11523.481443334902;11816.291022538675;11869.10981676395;12002.21985570935;10163.644272450429;10356.689299321033;10909.781804364027;11145.331280123219;12187.75624487523 23:22:04 INFO - PROCESS | 30387 | __end_tp_report 23:22:04 INFO - PROCESS | 30387 | __start_cc_report 23:22:04 INFO - PROCESS | 30387 | _x_x_mozilla_cycle_collect,334 23:22:04 INFO - PROCESS | 30387 | __end_cc_report 23:22:04 INFO - PROCESS | 30387 | __startTimestamp1472106124891__endTimestamp 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | ------- Summary: start ------- 23:22:04 INFO - PROCESS | 30387 | Number of tests: 6 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#0] dojo.html Cycles:165 Average:5659.40 Median:5884.32 stddev:631.92 (10.7%) stddev-sans-first:606.47 23:22:04 INFO - PROCESS | 30387 | Values: 3313.7 3314.2 3328.7 3353.8 3368.0 5640.5 5707.6 5721.1 5736.6 5754.8 5641.8 5665.1 5706.0 5709.9 5751.5 5171.8 5224.0 5241.3 5265.2 5278.6 5143.4 5146.8 5178.8 5186.9 5225.4 5236.9 5254.3 5257.6 5308.8 5325.0 5309.8 5322.9 5340.1 5341.1 5344.1 4976.1 5049.2 5223.7 5230.9 5298.7 5411.4 5444.4 5558.9 5575.6 5590.4 6014.6 6053.4 6055.3 6072.3 6082.9 5853.5 6106.5 6114.0 6123.0 6135.7 5588.4 5612.8 5633.7 5681.2 5719.2 6188.9 6210.2 6226.3 6229.5 6231.2 5781.3 5854.2 5953.0 5964.4 5976.9 5936.4 6021.1 6079.0 6163.2 6165.8 6103.7 6135.7 6136.4 6148.2 6160.0 5913.4 6120.5 6134.0 6142.7 6153.0 4592.1 4614.2 4631.0 4656.3 4692.2 4135.9 4147.4 4151.7 4176.9 4179.4 5518.9 5803.7 5803.7 5813.0 5815.7 6077.4 6085.3 6125.7 6212.1 6217.3 5829.0 5884.3 5902.6 5909.4 5924.4 5138.8 5289.6 5295.0 5342.8 5352.3 6188.5 6295.4 6301.5 6410.5 6411.9 6102.5 6117.2 6143.2 6144.7 6145.7 6094.6 6157.4 6367.5 6387.2 6404.3 5894.4 5965.9 5990.6 6008.9 6039.6 6062.4 6079.8 6089.3 6096.0 6116.4 5781.0 5823.2 5895.7 5924.5 5936.5 5835.9 5911.9 5923.4 5931.3 5937.6 5895.5 5902.6 5917.4 5924.9 5929.4 5863.3 5888.7 5942.2 5953.2 5961.3 5770.8 5849.7 5854.6 5873.3 5889.0 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#1] ext.html Cycles:180 Average:65603.86 Median:23725.11 stddev:133745.53 (563.7%) stddev-sans-first:134031.62 23:22:04 INFO - PROCESS | 30387 | Values: 581.5 605.8 638.6 656.8 669.8 40910.0 46253.5 46442.5 46473.8 46545.5 47279.3 47371.3 47976.5 48129.0 48384.5 9125.7 9247.9 9257.7 9271.4 9271.8 9210.7 9305.2 9338.8 9365.9 9367.7 9283.5 9295.6 9329.3 9334.1 9386.0 9317.0 9355.7 9378.0 9402.8 9424.9 9196.3 9204.8 9248.1 9258.2 9299.2 37200.3 37504.4 37625.4 37724.2 37725.4 3215.3 3661.4 3822.3 4137.3 4370.2 33719.3 33871.5 34800.8 35878.5 35904.3 4733.3 4742.7 4752.4 4769.2 4859.6 412971.0 414351.0 415497.0 416263.0 417499.0 66234.0 66743.0 66804.0 67076.7 67225.7 39408.6 39885.4 39951.8 41199.0 70387.3 19090.9 19097.7 19216.6 19396.3 19397.3 12683.3 12762.5 12776.7 12779.3 12789.7 21000.2 21007.7 21160.8 21192.0 21230.4 7616.8 7618.2 7716.3 7727.3 7970.1 1032.4 1086.4 1112.5 1121.4 1157.9 33788.3 34639.3 34708.3 34763.8 35109.8 1142.2 1157.2 1160.8 1166.9 1169.8 17758.4 17850.3 18018.5 18092.5 18205.0 647582.0 649083.0 649525.0 653280.0 655176.0 64656.4 64755.4 65389.7 65426.0 65773.0 1390.5 1410.2 1414.3 1430.5 1431.7 32111.4 33262.3 33282.5 33564.5 33592.3 55408.2 55661.7 55725.4 55810.0 55821.7 401106.0 401455.0 402258.0 402730.0 402880.0 29905.0 29922.9 30668.2 30708.8 30825.2 51923.2 52181.2 52266.7 52779.7 53373.5 43080.0 43814.6 44152.3 44651.0 45623.8 42602.4 43774.1 44524.0 44588.3 45256.5 44249.0 44807.3 45898.3 45988.0 48534.8 38168.0 38907.0 40153.4 40493.2 40883.8 30507.2 31037.4 31072.7 31248.0 31350.8 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#2] jquery.html Cycles:180 Average:30102.40 Median:23686.53 stddev:82709.33 (349.2%) stddev-sans-first:82911.29 23:22:04 INFO - PROCESS | 30387 | Values: 404.2 409.8 411.9 425.5 428.7 19576.2 20123.4 20273.7 20795.5 21116.6 19814.9 19937.5 20254.0 20258.0 20482.3 5741.2 5955.7 5957.5 5964.6 5968.5 5829.5 5851.4 5872.9 5876.9 5888.5 5712.8 5837.6 5864.2 5884.6 5887.5 5601.2 5762.1 5832.9 5847.1 5859.4 5638.8 5736.6 5741.2 5754.5 5859.4 23343.6 23632.4 23740.6 23757.2 24207.9 2449.2 2642.5 2679.9 2740.6 3013.1 11232.8 11239.7 11448.9 15488.7 15594.4 1959.4 2034.1 2057.1 2066.4 2111.3 82122.6 83437.6 83535.6 83806.0 84950.6 11276.2 11359.7 11425.5 11706.2 11724.5 16143.0 16147.0 16149.3 16172.3 16320.4 8481.7 8604.4 8773.0 8892.2 8899.8 8460.4 8512.8 8600.0 8679.9 8755.3 4884.9 4932.4 4979.6 5064.5 5080.6 1948.5 2058.3 2076.1 2122.2 2147.8 951.3 988.8 1051.9 1052.8 1078.5 19533.0 20448.5 20662.3 20777.5 20788.5 1068.4 1072.5 1084.1 1107.5 1135.6 10676.4 11613.5 11624.5 11669.2 11739.4 491792.0 492349.0 498539.0 505344.0 517195.0 88809.6 89344.0 103023.0 104263.5 105463.5 1036.5 1063.7 1074.6 1083.9 1094.1 16488.3 18500.9 18961.9 18990.5 19166.1 39741.0 40052.8 44941.6 46023.8 47720.5 52353.2 61280.0 61964.4 62787.0 63120.7 8722.7 8856.8 9001.3 9136.5 9298.1 13175.1 13609.9 13628.5 14138.2 14225.0 11534.7 11956.2 12073.5 12271.7 12681.7 9775.0 10198.8 11849.3 12516.3 12546.2 11778.4 12262.3 12510.5 12647.0 12680.6 8950.7 9048.9 9206.9 9207.2 9491.1 9263.3 12370.3 12500.8 12631.2 12884.7 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#3] mootools.html Cycles:180 Average:6410.30 Median:4759.10 stddev:3676.36 (77.2%) stddev-sans-first:3668.84 23:22:04 INFO - PROCESS | 30387 | Values: 1591.8 1617.4 1778.4 1881.6 1900.3 8479.0 9169.9 9250.0 9968.5 9987.8 9523.7 9920.0 9927.2 9932.1 9964.0 2548.0 2590.6 2613.2 2616.7 2618.2 2518.6 2608.8 2628.0 2649.9 2650.0 2563.7 2568.6 2610.8 2634.8 2635.2 2529.4 2547.4 2559.6 2575.7 2579.1 2494.6 2501.6 2506.8 2545.4 2559.1 9806.4 9952.8 10012.9 10018.4 10040.6 5767.9 5949.3 5954.1 5976.2 5977.3 3498.6 3579.0 3639.5 3686.5 3689.5 1204.1 1206.8 1216.2 1258.1 1278.7 13269.8 13682.7 13720.9 13837.4 13940.3 4928.1 5026.6 5050.4 5100.2 5196.7 10732.2 10760.5 10772.9 10804.0 10827.7 5827.8 5874.5 5891.6 5900.0 5913.6 4856.2 5214.8 5312.1 5338.0 5503.3 4183.9 4206.0 4298.4 4347.5 4369.9 1263.0 1267.8 1274.9 1282.0 1289.8 1004.8 1055.3 1056.9 1066.0 1106.2 6575.3 6755.7 6804.7 6841.3 6863.0 471.8 491.5 492.9 493.7 498.8 4743.1 4750.5 4767.7 4792.4 4877.4 12010.0 12076.3 12174.3 12241.1 12414.9 12206.5 12239.2 12244.8 12310.6 12352.9 8973.9 9023.6 9083.3 9203.1 9243.8 6658.8 6734.9 6745.2 6815.6 6838.6 11168.3 11286.5 11291.5 11445.5 11484.5 11176.2 11400.8 11458.3 11484.4 11592.0 8006.9 8050.1 8085.8 8092.1 8154.0 9432.8 9546.2 9575.0 9576.5 9585.6 8034.2 8263.0 8488.0 8499.0 8641.3 8304.4 8405.8 8442.5 8447.4 8555.1 7571.5 7571.8 7609.1 7615.9 7664.8 5817.6 5873.1 5955.3 6093.4 6135.7 5705.9 5723.8 5728.7 5769.7 5820.7 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#4] prototype.html Cycles:180 Average:4977.63 Median:5511.15 stddev:1441.91 (26.2%) stddev-sans-first:1403.64 23:22:04 INFO - PROCESS | 30387 | Values: 357.4 357.6 357.8 362.5 367.3 5868.9 5884.0 5888.2 5900.6 5915.7 5528.2 5749.5 5761.0 5791.3 5797.5 4504.4 4526.2 4541.8 4583.6 4593.5 4541.2 4575.6 4577.9 4593.8 4597.8 4518.7 4565.8 4576.8 4579.6 4585.8 4445.9 4497.8 4531.8 4545.1 4570.1 4040.1 4040.4 4046.8 4057.1 4060.5 5647.4 5658.4 5695.4 5724.6 5724.8 4954.9 5173.9 5176.7 5183.3 5196.8 6078.6 6084.2 6096.5 6138.8 6144.4 4161.6 4345.2 4371.3 4374.4 4382.0 6027.5 6209.9 6305.0 6317.6 6353.0 4414.2 4447.1 4474.8 4495.3 4497.0 4503.1 4535.3 4544.4 4551.5 4551.8 5010.6 5185.2 5187.0 5198.8 5221.8 6081.0 6138.4 6140.7 6161.6 6196.5 1537.1 1543.5 1552.9 1556.4 1558.9 971.8 1006.8 1007.8 1010.8 1021.8 5238.5 5249.6 5275.9 5278.8 5281.7 5465.3 5499.6 5583.4 5592.5 5627.3 4934.8 5219.9 5274.9 5288.7 5317.4 2934.9 2959.2 2965.9 2967.4 2992.5 5654.0 5718.2 5763.6 5804.6 5817.2 5545.3 5571.6 5611.7 5612.2 5639.4 5705.0 5719.3 5731.9 5835.4 5862.0 5281.9 5515.2 5540.0 5565.8 5583.7 5331.9 5387.7 5432.9 5507.1 5520.6 6158.9 6335.5 6527.2 6527.8 6531.5 4442.9 4455.8 4458.3 4458.8 4478.7 6132.3 6242.9 6278.8 6352.5 6359.2 6009.8 6065.4 6083.4 6093.3 6108.7 5844.9 6079.1 6140.8 6151.9 6163.3 6059.7 6071.4 6075.3 6101.9 6170.0 6196.9 6212.8 6213.7 6221.4 6239.7 5760.3 5973.5 5976.7 5992.0 6004.9 23:22:04 INFO - PROCESS | 30387 | 23:22:04 INFO - PROCESS | 30387 | [#5] yui.html Cycles:180 Average:21907.68 Median:4043.72 stddev:31186.90 (771.2%) stddev-sans-first:31234.21 23:22:04 INFO - PROCESS | 30387 | Values: 823.4 831.2 837.6 854.9 928.9 16647.0 16840.7 16873.6 16977.0 16997.7 16638.3 16767.6 16853.2 16863.7 16887.8 870.2 873.8 880.0 885.8 900.5 880.4 881.1 883.9 886.0 890.8 932.2 932.3 934.1 934.9 935.0 925.0 927.7 928.3 929.6 930.7 687.1 687.2 687.5 688.6 689.3 15590.8 15591.5 15604.6 15641.8 15651.6 14843.9 14877.3 14898.3 15255.0 16275.6 13149.4 13304.5 13481.8 13579.2 13893.9 4652.5 4656.5 4680.6 4830.4 4873.3 89250.6 89444.0 90333.5 90799.0 92597.5 12086.0 12105.8 12126.7 12142.4 12329.8 22563.2 22799.4 22823.4 22840.7 22921.9 9376.1 9455.8 9522.9 9552.3 9616.2 5390.2 5406.6 5424.1 5436.5 5508.9 3882.2 4017.7 4027.1 4039.3 4048.2 665.0 665.7 688.2 688.4 694.5 697.8 812.9 822.9 843.6 845.9 10149.2 10513.8 10555.5 10801.5 10922.6 657.9 749.4 818.0 843.3 862.0 5094.1 5150.1 5161.3 5161.3 5220.7 101078.0 102140.0 103073.0 135503.3 137555.0 70619.6 83376.6 88547.6 105025.9 105626.2 87073.0 91398.5 93439.5 94688.0 96267.5 10056.1 10146.6 10279.2 10477.0 10548.9 53770.2 54192.5 55809.7 56350.7 56533.7 72912.0 82914.0 83493.6 83544.0 83676.0 13067.9 13082.9 13349.3 13485.1 13595.5 15039.9 15104.9 15124.6 15125.8 15197.3 13694.7 13957.0 13992.7 14156.8 14491.5 13293.7 13416.5 13517.9 13577.4 13646.2 13507.5 13747.4 13805.4 13844.1 13888.3 11091.9 11523.5 11816.3 11869.1 12002.2 10163.6 10356.7 10909.8 11145.3 12187.8 23:22:04 INFO - PROCESS | 30387 | -------- Summary: end -------- 23:22:04 INFO - PROCESS | 30387 | 23:22:05 INFO - TEST-INFO | 30387: exit 0 23:22:05 INFO - TEST-OK | dromaeo_css | took 1110200ms 23:22:05 INFO - TEST-START | kraken 23:22:05 INFO - operating with platform_type : linux_ 23:22:05 INFO - Initialising browser for kraken test... 23:22:05 INFO - TEST-INFO | started process 30652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMKddN/profile http://localhost:41409/getInfo.html) 23:22:09 INFO - PROCESS | 30652 | __metrics Screen width/height:1600/1200 23:22:09 INFO - PROCESS | 30652 | colorDepth:24 23:22:09 INFO - PROCESS | 30652 | Browser inner width/height: 1024/697 23:22:09 INFO - PROCESS | 30652 | __metrics 23:22:10 ERROR - PROCESS | 30652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:22:11 INFO - TEST-INFO | 30652: exit 0 23:22:11 INFO - Browser initialized. 23:22:11 INFO - Running cycle 1/1 for kraken test... 23:22:11 INFO - TEST-INFO | started process 30777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMKddN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:22 INFO - PROCESS | 30777 | RSS: Main: 152838144 23:22:22 INFO - PROCESS | 30777 | 23:22:25 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-beat-detection) 23:22:26 INFO - PROCESS | 30777 | RSS: Main: 158720000 23:22:26 INFO - PROCESS | 30777 | 23:22:28 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-dft) 23:22:29 INFO - PROCESS | 30777 | RSS: Main: 156778496 23:22:29 INFO - PROCESS | 30777 | 23:22:32 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-fft) 23:22:33 INFO - PROCESS | 30777 | RSS: Main: 157569024 23:22:33 INFO - PROCESS | 30777 | 23:22:35 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-oscillator) 23:22:35 INFO - PROCESS | 30777 | RSS: Main: 157384704 23:22:35 INFO - PROCESS | 30777 | 23:22:37 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:22:38 INFO - PROCESS | 30777 | RSS: Main: 157155328 23:22:38 INFO - PROCESS | 30777 | 23:22:41 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-darkroom) 23:22:42 INFO - PROCESS | 30777 | RSS: Main: 156688384 23:22:42 INFO - PROCESS | 30777 | 23:22:45 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-desaturate) 23:22:46 INFO - PROCESS | 30777 | RSS: Main: 157114368 23:22:46 INFO - PROCESS | 30777 | 23:22:49 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41409/tests/kraken/driver.html?testName=json-parse-financial) 23:22:49 INFO - PROCESS | 30777 | RSS: Main: 157716480 23:22:49 INFO - PROCESS | 30777 | 23:22:51 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:51 INFO - PROCESS | 30777 | RSS: Main: 157151232 23:22:51 INFO - PROCESS | 30777 | 23:22:53 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:54 INFO - PROCESS | 30777 | RSS: Main: 157618176 23:22:54 INFO - PROCESS | 30777 | 23:22:56 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:22:56 INFO - PROCESS | 30777 | RSS: Main: 157863936 23:22:56 INFO - PROCESS | 30777 | 23:22:59 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:23:00 INFO - PROCESS | 30777 | RSS: Main: 158097408 23:23:00 INFO - PROCESS | 30777 | 23:23:02 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:23:03 INFO - PROCESS | 30777 | RSS: Main: 158187520 23:23:03 INFO - PROCESS | 30777 | 23:23:04 INFO - PROCESS | 30777 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41409/tests/kraken/driver.html?testName=ai-astar) 23:23:05 INFO - PROCESS | 30777 | RSS: Main: 158806016 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | __start_tp_report 23:23:05 INFO - PROCESS | 30777 | _x_x_mozilla_page_load 23:23:05 INFO - PROCESS | 30777 | _x_x_mozilla_page_load_details 23:23:05 INFO - PROCESS | 30777 | |i|pagename|runs| 23:23:05 INFO - PROCESS | 30777 | |0;ai-astar;101;111;103;111;113;113;111;111;110;111 23:23:05 INFO - PROCESS | 30777 | |1;audio-beat-detection;144;115;142;185;119;147;146;118;180;117 23:23:05 INFO - PROCESS | 30777 | |2;audio-dft;163;162;166;167;162;162;163;165;163;161 23:23:05 INFO - PROCESS | 30777 | |3;audio-fft;76;75;76;181;76;75;75;75;179;75 23:23:05 INFO - PROCESS | 30777 | |4;audio-oscillator;84;83;147;84;83;84;153;84;84;144 23:23:05 INFO - PROCESS | 30777 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 23:23:05 INFO - PROCESS | 30777 | |6;imaging-darkroom;147;147;147;148;147;147;146;148;147;146 23:23:05 INFO - PROCESS | 30777 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;97;94 23:23:05 INFO - PROCESS | 30777 | |8;json-parse-financial;52;51;50;51;50;53;52;50;51;51 23:23:05 INFO - PROCESS | 30777 | |9;json-stringify-tinderbox;63;59;59;59;60;60;60;60;59;59 23:23:05 INFO - PROCESS | 30777 | |10;stanford-crypto-aes;73;73;72;77;72;73;73;72;72;72 23:23:05 INFO - PROCESS | 30777 | |11;stanford-crypto-ccm;123;125;119;127;122;124;120;116;156;134 23:23:05 INFO - PROCESS | 30777 | |12;stanford-crypto-pbkdf2;156;149;151;157;153;151;154;156;148;151 23:23:05 INFO - PROCESS | 30777 | |13;stanford-crypto-sha256-iterative;64;62;61;64;61;63;61;60;61;62 23:23:05 INFO - PROCESS | 30777 | __end_tp_report 23:23:05 INFO - PROCESS | 30777 | __start_cc_report 23:23:05 INFO - PROCESS | 30777 | _x_x_mozilla_cycle_collect,872 23:23:05 INFO - PROCESS | 30777 | __end_cc_report 23:23:05 INFO - PROCESS | 30777 | __startTimestamp1472106185233__endTimestamp 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | ------- Summary: start ------- 23:23:05 INFO - PROCESS | 30777 | Number of tests: 14 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:4.09 (3.7%) stddev-sans-first:2.96 23:23:05 INFO - PROCESS | 30777 | Values: 101.0 111.0 103.0 111.0 113.0 113.0 111.0 111.0 110.0 111.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:145.00 stddev:25.37 (17.5%) stddev-sans-first:26.89 23:23:05 INFO - PROCESS | 30777 | Values: 144.0 115.0 142.0 185.0 119.0 147.0 146.0 118.0 180.0 117.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 23:23:05 INFO - PROCESS | 30777 | Values: 163.0 162.0 166.0 167.0 162.0 162.0 163.0 165.0 163.0 161.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#3] audio-fft Cycles:10 Average:96.30 Median:75.00 stddev:44.12 (58.8%) stddev-sans-first:46.18 23:23:05 INFO - PROCESS | 30777 | Values: 76.0 75.0 76.0 181.0 76.0 75.0 75.0 75.0 179.0 75.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:84.00 stddev:31.13 (37.1%) stddev-sans-first:32.25 23:23:05 INFO - PROCESS | 30777 | Values: 84.0 83.0 147.0 84.0 83.0 84.0 153.0 84.0 84.0 144.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:23:05 INFO - PROCESS | 30777 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:23:05 INFO - PROCESS | 30777 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 146.0 148.0 147.0 146.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 23:23:05 INFO - PROCESS | 30777 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 97.0 94.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 23:23:05 INFO - PROCESS | 30777 | Values: 52.0 51.0 50.0 51.0 50.0 53.0 52.0 50.0 51.0 51.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.23 (2.0%) stddev-sans-first:0.53 23:23:05 INFO - PROCESS | 30777 | Values: 63.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 59.0 59.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 23:23:05 INFO - PROCESS | 30777 | Values: 73.0 73.0 72.0 77.0 72.0 73.0 73.0 72.0 72.0 72.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:124.50 stddev:11.43 (9.2%) stddev-sans-first:12.05 23:23:05 INFO - PROCESS | 30777 | Values: 123.0 125.0 119.0 127.0 122.0 124.0 120.0 116.0 156.0 134.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.50 stddev:3.10 (2.0%) stddev-sans-first:3.03 23:23:05 INFO - PROCESS | 30777 | Values: 156.0 149.0 151.0 157.0 153.0 151.0 154.0 156.0 148.0 151.0 23:23:05 INFO - PROCESS | 30777 | 23:23:05 INFO - PROCESS | 30777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.22 23:23:05 INFO - PROCESS | 30777 | Values: 64.0 62.0 61.0 64.0 61.0 63.0 61.0 60.0 61.0 62.0 23:23:05 INFO - PROCESS | 30777 | -------- Summary: end -------- 23:23:05 INFO - PROCESS | 30777 | 23:23:06 INFO - TEST-INFO | 30777: exit 0 23:23:06 INFO - TEST-OK | kraken | took 60513ms 23:23:06 INFO - SUITE-END | took 1170s 23:23:06 INFO - Completed test suite (00:19:30) 23:23:06 INFO - javascript benchmark 23:23:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7746.5109942349045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.668633136687, 3314.188023934136, 3328.7337013038946, 3353.7820041697305, 3368.040108569057, 5640.520555752761, 5707.571932105098, 5721.056025755751, 5736.627119237247, 5754.798582049629, 5641.830745077644, 5665.065264231407, 5706.029974904266, 5709.942900570993, 5751.539876809856, 5171.793128274874, 5224.0, 5241.3186285782795, 5265.210218467241, 5278.604104692164, 5143.434222235551, 5146.845594632148, 5178.818741344054, 5186.896262074756, 5225.399079105894, 5236.869078273055, 5254.290670759437, 5257.605679574028, 5308.840734777963, 5325.0, 5309.840704778863, 5322.866928326784, 5340.092184328673, 5341.092014357569, 5344.144936810092, 4976.129177393942, 5049.166887463564, 5223.660462069954, 5230.895382092375, 5298.6555873868465, 5411.404745477994, 5444.428335024805, 5558.888822223533, 5575.609707320489, 5590.385057643656, 6014.578979471439, 6053.364396738367, 6055.303640081403, 6072.271327440735, 6082.878342433127, 5853.502452291517, 6106.542009349317, 6114.0, 6122.969385153046, 6135.69321533926, 5588.413216612278, 5612.7754889804355, 5633.746481408305, 5681.176229446707, 5719.170720245583, 6188.8762224755255, 6210.192674952227, 6226.315105338409, 6229.501639868799, 6231.158793562901, 5781.277340332458, 5854.151148083504, 5953.0, 5964.373740757244, 5976.910346344808, 5936.406359364029, 6021.066734656135, 6078.969605151946, 6163.19878415812, 6165.8458538536, 6103.69896940161, 6135.662538560422, 6136.355682653257, 6148.231471066117, 6159.96920015406, 5913.408659134138, 6120.540959427972, 6134.01366997351, 6142.696488816694, 6152.969235153795, 4592.127495775792, 4614.238650622609, 4631.004334068191, 4656.254999200111, 4692.249240121632, 4135.91728165435, 4147.440095587118, 4151.667866570667, 4176.91646167081, 4179.4357761701785, 5518.862028449321, 5803.65178089316, 5803.738831752581, 5813.0, 5815.651060936273, 6077.36187700294, 6085.330613632497, 6125.693715314216, 6212.099245609452, 6217.253929528486, 5829.038208695518, 5884.323302820145, 5902.586818922634, 5909.379515150933, 5924.377940316204, 5138.845834624967, 5289.6032797539565, 5295.0, 5342.839714808562, 5352.330958630171, 6188.504919606421, 6295.401936815995, 6301.495880329563, 6410.519211059189, 6411.903821442682, 6102.481289090477, 6117.204763380732, 6143.201383820075, 6144.662043587646, 6145.72344244519, 6094.634321940698, 6157.353477884758, 6367.458766004941, 6387.201599800025, 6404.263509696445, 5894.440028197314, 5965.940340596539, 5990.550708696952, 6008.909866351921, 6039.607425517327, 6062.42406971337, 6079.787207447718, 6089.330173680803, 6096.0, 6116.418940200674, 5781.046127389102, 5823.155642431739, 5895.7052147391605, 5924.46679798803, 5936.46571808522, 5835.94164058354, 5911.91132133027, 5923.437273459187, 5931.347551769216, 5937.643741375531, 5895.498882595028, 5902.6458412495385, 5917.37867523921, 5924.851878703067, 5929.407059294036, 5863.2670916135485, 5888.735006924613, 5942.1978032965, 5953.166556681981, 5961.254843144607, 5770.769169233352, 5849.736761845642, 5854.590178687451, 5873.295204575478, 5888.970555147197], "value": 5617.61220229083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4563383236674, 605.7698074731601, 638.635977492829, 656.8029591122663, 669.7622344067859, 40910.0, 46253.53746462534, 46442.535574644244, 46473.76763116188, 46545.53454465454, 47279.29081063778, 47371.289430658566, 47976.520234797645, 48129.0, 48384.51615483844, 9125.726228213165, 9247.907520924806, 9257.675981340655, 9271.397359171666, 9271.768205794875, 9210.723678289629, 9305.162535371815, 9338.813223735522, 9365.859512107323, 9367.718968430958, 9283.535823208813, 9295.628174872996, 9329.346945713804, 9334.113259240361, 9385.95307023464, 9316.953415232914, 9355.719328420124, 9378.015308392623, 9402.811943761155, 9424.858627120599, 9196.310276729271, 9204.815903681889, 9248.121428464285, 9258.166764991116, 9299.209567186797, 37200.25599487995, 37504.43743343852, 37625.435618465744, 37724.24551508955, 37725.43411848824, 3215.324781795826, 3661.3958696814993, 3822.2928758179823, 4137.2552940470705, 4370.2133615949115, 33719.32561348759, 33871.49192762111, 34800.82599586986, 35878.46182307268, 35904.281914361825, 4733.313669517901, 4742.739149346785, 4752.42970843501, 4769.236922092448, 4859.58693511052, 412971.0, 414351.0, 415497.0, 416263.0, 417499.0, 66234.0, 66742.99885501721, 66804.0, 67076.6646166766, 67225.66387168033, 39408.6059139405, 39885.40171897424, 39951.80024099861, 41199.0, 70387.2961270391, 19090.904545477184, 19097.713534296996, 19216.61566768657, 19396.321128760424, 19397.32109376165, 12683.302418367079, 12762.489500420064, 12776.6805829855, 12779.297138657277, 12789.680257993625, 21000.15999360039, 21007.684884726743, 21160.78839211619, 21192.046357913932, 21230.36308910735, 7616.80957976055, 7618.200088990576, 7716.344110750649, 7727.343175830005, 7970.123286438487, 1032.4218437674776, 1086.3970496374588, 1112.4826955465746, 1121.3608243301403, 1157.9478923448464, 33788.324233515195, 34639.30721385558, 34708.30583388318, 34763.826180868935, 35109.82445087809, 1142.2118738070706, 1157.2073129906041, 1160.8200728887036, 1166.8716441191461, 1169.7835900358461, 17758.37845675395, 17850.285988560572, 18018.459446216635, 18092.457226282968, 18205.0, 647582.0, 649083.0, 649525.0, 653280.0, 655176.0, 64656.35343646503, 64755.352446475874, 65389.67305163444, 65426.0, 65773.0, 1390.478570536049, 1410.2384712255268, 1414.2575148047358, 1430.5493769462587, 1431.6921861799763, 32111.357772843945, 33262.33475330528, 33282.5007624881, 33564.49653255252, 33592.328153436305, 55408.168877466065, 55661.721691391285, 55725.44274557203, 55810.0, 55821.720891395285, 401106.0, 401455.0, 402258.0, 402730.0, 402880.0, 29905.0, 29922.850385747934, 30668.23329416693, 30708.84645576758, 30825.229369265948, 51923.22115168351, 52181.21728174004, 52266.738666306424, 52779.73610131925, 53373.46626533685, 43080.0, 43814.56185438105, 44152.33771493366, 44651.0, 45623.77188114038, 42602.360964584936, 43774.12451751011, 44524.0, 44588.33117503305, 45256.54743452524, 44249.0, 44807.327890081026, 45898.31152532648, 45988.0, 48534.75732621314, 38168.0, 38907.0, 40153.39769903512, 40493.1901361977, 40883.79558102191, 30507.2373190672, 31037.379252415278, 31072.68927310698, 31248.0, 31350.843245783624], "value": 21361.341002395293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.24002874595755, 409.80534246233026, 411.8990847242426, 425.5404163503417, 428.712762449159, 19576.21695132195, 20123.39629811104, 20273.695894561555, 20795.480112997146, 21116.57766844664, 19814.900925495353, 19937.501562460944, 20254.0, 20258.0, 20482.2831200908, 5741.224934633823, 5955.731992060346, 5957.523398128161, 5964.552658550604, 5968.462838344548, 5829.533637309027, 5851.444112809298, 5872.941270587304, 5876.941230587703, 5888.528917686596, 5712.828615141552, 5837.620554663955, 5864.23764910561, 5884.558658100659, 5887.470127688529, 5601.187827764971, 5762.106873434583, 5832.88334233313, 5847.122931560258, 5859.384764599698, 5638.830835074954, 5736.598438109334, 5741.224934633813, 5754.453326933976, 5859.414058594107, 23343.649845252334, 23632.40918977022, 23740.64389034166, 23757.16849910245, 24207.878960605085, 2449.216250799745, 2642.524345617788, 2679.866006699657, 2740.643716316886, 3013.0659495556447, 11232.831507527393, 11239.66281011571, 11448.94275528617, 15488.690226195526, 15594.37622495099, 1959.3962406126752, 2034.0744961042838, 2057.0537552725764, 2066.3904148276297, 2111.3032699209225, 82122.58938705268, 83437.58281208554, 83535.582322088, 83806.0, 84950.57524712398, 11276.210665253517, 11359.659210223706, 11425.485853136628, 11706.239094458833, 11724.472398741906, 16142.950708203929, 16146.950448220829, 16149.273282702306, 16172.272247748644, 16320.428784992468, 8481.660733570712, 8604.440711353742, 8772.95613521941, 8892.15524525169, 8899.777505562413, 8460.407771456063, 8512.829743405096, 8600.0, 8679.91320086791, 8755.255803256667, 4884.902301953941, 4932.446279421971, 4979.6265280104135, 5064.5441910228255, 5080.644354895122, 1948.5323522354533, 2058.2898899879815, 2076.0761461149646, 2122.204173434962, 2147.7530084040222, 951.2817822544073, 988.7676396046924, 1051.915846732275, 1052.8210204265292, 1078.4769386847372, 19533.0, 20448.488787780425, 20662.276820311217, 20777.480562986046, 20788.480287992617, 1068.4123731947398, 1072.5441687282873, 1084.0947808579767, 1107.457345900503, 1135.5911871726173, 10676.412797296223, 11613.535458581731, 11624.476898539586, 11669.183157179086, 11739.413029348669, 491792.0, 492349.0, 498539.0, 505344.0, 517195.0, 88809.55595222111, 89344.0, 103023.0, 104263.47868260762, 105463.4726826361, 1036.4506811389974, 1063.7287491689724, 1074.5648012554927, 1083.8861919498497, 1094.1356328500397, 16488.25802838899, 18500.869148234535, 18961.90519047396, 18990.525236869187, 19166.13752381174, 39741.0, 40052.799736001136, 44941.550584493736, 46023.76988115038, 47720.522794772995, 52353.21470178026, 61280.0, 61964.38035619767, 62787.0, 63120.68439657772, 8722.738317850475, 8856.822863542822, 9001.279897608045, 9136.451812891248, 9298.116678915492, 13175.14361566495, 13609.931950340186, 13628.454861805416, 14138.22239776822, 14225.0, 11534.711632209262, 11956.163068585116, 12073.456694448596, 12271.69320766988, 12681.682957926125, 9775.0, 10198.847017294598, 11849.348285844362, 12516.31160286193, 12546.1844980076, 11778.411079446165, 12262.325572093263, 12510.499580016698, 12647.0, 12680.619581412573, 8950.731478055668, 9048.909510904807, 9206.861897071416, 9207.217386522221, 9491.098345657152, 9263.305252106255, 12370.319632420304, 12500.812487812509, 12631.242125472501, 12884.677883052998], "value": 9727.160004483343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1591.8328575499568, 1617.4096454794, 1778.4486809089183, 1881.6142690748397, 1900.2873922279136, 8479.0, 9169.862452063217, 9250.0, 9968.451735154573, 9987.750306242348, 9523.714288571355, 9920.0, 9927.156191723694, 9932.056454636799, 9963.950180249089, 2547.9617805732883, 2590.5984572391217, 2613.2421597736634, 2616.6859976802716, 2618.1621880998086, 2518.6096155095897, 2608.752168543985, 2627.986860065697, 2649.854258015818, 2649.973500265002, 2563.6667233259745, 2568.640390345344, 2610.765031147196, 2634.789216862656, 2635.156749840052, 2529.4435224250637, 2547.426828963478, 2559.641650168978, 2575.742425757428, 2579.0844250291066, 2494.5759220932487, 2501.574732295514, 2506.8370555913807, 2545.389106614418, 2559.091522509501, 9806.362586431858, 9952.80094398108, 10012.9486403928, 10018.448985305806, 10040.64857729976, 5767.913481297784, 5949.25634295713, 5954.106883967396, 5976.193213916109, 5977.342492325841, 3498.6151523332414, 3579.0, 3639.5268615080136, 3686.4838922550866, 3689.5019172411917, 1204.0909113619161, 1206.8069108942527, 1216.22769541341, 1258.1318889965894, 1278.718681889992, 13269.800952985714, 13682.657933551642, 13720.862791372057, 13837.446502140003, 13940.302984850818, 4928.063667903087, 5026.623003274696, 5050.419201791768, 5100.2349647553165, 5196.68819870809, 10732.2487425881, 10760.46197690128, 10772.892271077346, 10804.0, 10827.67516974492, 5827.825165245049, 5874.50066744323, 5891.617044892068, 5899.970500147472, 5913.64518128905, 4856.174450343379, 5214.7914083437, 5312.07038768214, 5338.039152952429, 5503.257060296889, 4183.853565125206, 4205.978970105191, 4298.3552467130185, 4347.478302603708, 4369.9126017479475, 1263.0258875518848, 1267.8399264672905, 1274.936253187337, 1281.9743605127844, 1289.8000809874484, 1004.829179039565, 1055.303499690216, 1056.8890266522058, 1066.0139371081718, 1106.1869525898458, 6575.276719560845, 6755.695993680296, 6804.65976701163, 6841.315868413119, 6863.004864294649, 471.8133893258458, 491.4643039087412, 492.8964917367393, 493.71364608526966, 498.77056553985574, 4743.0988112258565, 4750.477447480775, 4767.713937163781, 4792.353032340589, 4877.439094504178, 12010.0, 12076.335801531, 12174.330411827257, 12241.143119981516, 12414.875851241553, 12206.450709718085, 12239.20445171061, 12244.75510489803, 12310.569130080405, 12352.938235308766, 8973.910260897308, 9023.593938272794, 9083.318751093562, 9203.125703058198, 9243.76890577741, 6658.76694315716, 6734.9326506734305, 6745.156855393076, 6815.625140617313, 6838.623875686885, 11168.274062185932, 11286.49210785533, 11291.548338066385, 11445.542178312775, 11484.540618375171, 11176.161787866105, 11400.771984560428, 11458.312501249618, 11484.425778710864, 11592.0146787524, 8006.919930800617, 8050.074241462306, 8085.83828323442, 8092.069412017458, 8154.0, 9432.811343772948, 9546.236301095756, 9575.0, 9576.521173941414, 9585.616575336908, 8034.196580342153, 8263.0, 8487.957560212159, 8498.957505212435, 8641.265492433213, 8304.377171712025, 8405.831883362422, 8442.451240669337, 8447.366447516339, 8555.144485551395, 7571.46999710015, 7571.772846814604, 7609.124950630527, 7615.923840761521, 7664.770056898302, 5817.563682723728, 5873.119032145041, 5955.285365756137, 6093.390660933871, 6135.662538560422, 5705.914411283751, 5723.7996670116345, 5728.742206600629, 5769.68266745333, 5820.70896455184], "value": 5025.339029859177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3888650407803, 357.6298531020394, 357.7513628028521, 362.5305229727506, 367.3332900785075, 5868.853278668035, 5884.029135192699, 5888.175655408241, 5900.580761887627, 5915.674637894914, 5528.226048353224, 5749.540036797057, 5760.971195144029, 5791.333996590393, 5797.478226959573, 4504.414426124607, 4526.23054080807, 4541.841035563756, 4583.610393116589, 4593.53007037748, 4541.205289074399, 4575.633949284066, 4577.885552861172, 4593.839215627454, 4597.816087356502, 4518.6951488587065, 4565.840195593155, 4576.816927322903, 4579.564941330568, 4585.816567337302, 4445.911081778362, 4497.797599108048, 4531.750753708545, 4545.0909818036525, 4570.131674981742, 4040.0505881117915, 4040.353543433066, 4046.817893194813, 4057.107436363995, 4060.4721386219603, 5647.407022262644, 5658.377578466366, 5695.373508914016, 5724.570657200727, 5724.8282551523525, 4954.900901981976, 5173.896522069537, 5176.7152806596, 5183.3261675981885, 5196.792128314863, 6078.63230773077, 6084.209052823105, 6096.512279017668, 6138.785142520035, 6144.446999770043, 4161.56303588122, 4345.152695224432, 4371.300591905312, 4374.409454723604, 4381.978090109561, 6027.48766354856, 6209.9068513972325, 6305.0, 6317.6209427434505, 6353.0, 4414.161309351213, 4447.132809102259, 4474.843380481668, 4495.25828238337, 4496.955030449653, 4503.121891231244, 4535.297028960516, 4544.409226800561, 4551.453825540956, 4551.840685576055, 5010.624203184776, 5185.196294574347, 5187.0, 5198.818041368534, 5221.765020574083, 6081.0, 6138.386161383915, 6140.723667434976, 6161.630302181883, 6196.459451624813, 1537.0931150620963, 1543.5446543269538, 1552.8524790144918, 1556.3852278350214, 1558.8519090686366, 971.8473581017938, 1006.808706345792, 1007.8460163113194, 1010.8079464901646, 1021.8211812932707, 5238.502342277554, 5249.580033597303, 5275.894482110336, 5278.762455689503, 5281.709505977131, 5465.289512363447, 5499.5976026113885, 5583.441655834384, 5592.468715472024, 5627.296587926509, 4934.827281045146, 5219.869503262449, 5274.92087618686, 5288.735563221823, 5317.41508434072, 2934.8972785952815, 2959.230600044004, 2965.866536005885, 2967.3916847046303, 2992.5361568956846, 5653.971730141323, 5718.228039214736, 5763.596548241583, 5804.622699524517, 5817.185594016841, 5545.251391062155, 5571.609987300931, 5611.663300202001, 5612.239799334456, 5639.351474580394, 5704.973104841169, 5719.28508936383, 5731.942680573225, 5835.416458354215, 5861.9706901465215, 5281.9471805281455, 5515.172724091419, 5539.972300138474, 5565.777368905198, 5583.720813959205, 5331.920021199763, 5387.730613469389, 5432.864178395572, 5507.127576623967, 5520.613557050968, 6158.907616385668, 6335.493160547053, 6527.184101987252, 6527.836804079936, 6531.510136739858, 4442.933355999728, 4455.7994890229365, 4458.308962110878, 4458.799354029012, 4478.664100192434, 6132.2947860996555, 6242.875142497215, 6278.843028924313, 6352.491800656029, 6359.236891573041, 6009.759609615567, 6065.363136870565, 6083.391660833881, 6093.29927058394, 6108.72510737009, 5844.912326315194, 6079.112421599705, 6140.815775526741, 6151.938480615316, 6163.260408750799, 6059.697165109523, 6071.421430428209, 6075.270967483753, 6101.938980610137, 6169.96915015422, 6196.876062478816, 6212.751489940351, 6213.720382582705, 6221.377862213742, 6239.688015599111, 5760.308762948473, 5973.522118230444, 5976.671283079472, 5991.970040149771, 6004.909926351021], "value": 4519.08730831441, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.4194892600717, 831.210350167341, 837.61469723927, 854.94442861214, 928.9117533834284, 16647.00117992921, 16840.74738878918, 16873.578160545978, 16977.0, 16997.660046799072, 16638.251278692456, 16767.580810479743, 16853.157342132876, 16863.747043794323, 16887.831121688778, 870.1820288928387, 873.8252349530088, 880.0187790613484, 885.8006948436615, 900.4732231644496, 880.3705350674267, 881.0880738435688, 883.9071897450772, 885.9822803543925, 890.812929284851, 932.1796818799481, 932.324065052838, 934.0892629686069, 934.9392289501161, 935.036911980661, 924.9815003699888, 927.7309580221728, 928.3130483442238, 929.5956259027345, 930.692871352452, 687.0861753867345, 687.161662771418, 687.5015613680092, 688.6178171115029, 689.3451221339698, 15590.766138507932, 15591.45429909959, 15604.60988475286, 15641.810146579488, 15651.608709782233, 14843.925780371137, 14877.256137193097, 14898.329575169035, 15255.0, 16275.593110172222, 13149.408276627575, 13304.467821287137, 13481.797773033413, 13579.185248885, 13893.930530347385, 4652.534746525354, 4656.4877863434995, 4680.555347242007, 4830.420349558076, 4873.293372460973, 89250.5537472315, 89444.0, 90333.54833225792, 90799.0, 92597.53701231451, 12086.0, 12105.818412723816, 12126.696832579257, 12142.392880355947, 12329.815052774216, 22563.21028764018, 22799.430014249778, 22823.429414264778, 22840.65739013916, 22921.88539057294, 9376.109269619512, 9455.76360590977, 9522.90477095234, 9552.283578731623, 9616.23070154386, 5390.218418329398, 5406.59450541211, 5424.105022671294, 5436.456354364532, 5508.944910550843, 3882.165334453106, 4017.6986725995666, 4027.134166154291, 4039.2729308724124, 4048.1701251244012, 665.0356982375478, 665.6937808608094, 688.1913751342153, 688.3735800421592, 694.4687314204638, 697.7801992372387, 812.9354123808705, 822.9012518497818, 843.5697794125041, 845.8942632170979, 10149.179139908485, 10513.789724205473, 10555.525001374957, 10801.513931873085, 10922.563097476172, 657.9407853293227, 749.3967356278248, 817.9877301840477, 843.3000609494105, 861.9870701939476, 5094.133997220481, 5150.098732721759, 5161.27742116104, 5161.329027226511, 5220.650707181783, 101078.0, 102140.0, 103073.0, 135503.32248338696, 137555.0, 70619.64690176517, 83376.58311708523, 88547.55726221327, 105025.94974050162, 105626.1996161221, 87072.99999999873, 91398.54300728453, 93439.53280233691, 94688.0, 96267.51866240765, 10056.145227655732, 10146.644867429604, 10279.229057820543, 10477.0, 10548.894511054792, 53770.19344709754, 54192.45807541874, 55809.720951394986, 56350.718246408505, 56533.71733141472, 72912.0, 82914.0, 83493.58253208695, 83544.0, 83676.0, 13067.869321307046, 13082.934585327013, 13349.265790381622, 13485.056046076681, 13595.45618175262, 15039.924800375928, 15104.924475377993, 15124.621884452978, 15125.848741512884, 15197.316120774813, 13694.65763355924, 13957.0, 13992.650183745081, 14156.787648185491, 14491.492797752027, 13293.66765830862, 13416.530421435204, 13517.932410337886, 13577.389017494434, 13646.181229126285, 13507.527236546674, 13747.381367838272, 13805.378757956118, 13844.10013349129, 13888.305584720521, 11091.944540277247, 11523.481443334902, 11816.291022538675, 11869.10981676395, 12002.21985570935, 10163.644272450429, 10356.689299321033, 10909.781804364027, 11145.331280123219, 12187.75624487523], "value": 8151.034304055712, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 103.0, 111.0, 113.0, 113.0, 111.0, 111.0, 110.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 142.0, 185.0, 119.0, 147.0, 146.0, 118.0, 180.0, 117.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 166.0, 167.0, 162.0, 162.0, 163.0, 165.0, 163.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 181.0, 76.0, 75.0, 75.0, 75.0, 179.0, 75.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 147.0, 84.0, 83.0, 84.0, 153.0, 84.0, 84.0, 144.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 50.0, 53.0, 52.0, 50.0, 51.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 77.0, 72.0, 73.0, 73.0, 72.0, 72.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 119.0, 127.0, 122.0, 124.0, 120.0, 116.0, 156.0, 134.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 149.0, 151.0, 157.0, 153.0, 151.0, 154.0, 156.0, 148.0, 151.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 64.0, 61.0, 63.0, 61.0, 60.0, 61.0, 62.0], "value": 61.9, "unit": "score"}]}]} 23:23:06 INFO - Return code: 0 23:23:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:23:06 ERROR - # TBPL SUCCESS # 23:23:06 INFO - Running post-action listener: _resource_record_post_action 23:23:06 INFO - [mozharness: 2016-08-25 06:23:06.524853Z] Finished run-tests step (success) 23:23:06 INFO - Running post-run listener: _resource_record_post_run 23:23:06 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328867840; Read time: 12; Write time: 175908 23:23:06 INFO - TinderboxPrint: CPU usage
13.3% 23:23:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:23:06 INFO - TinderboxPrint: I/O write bytes / time
328,867,840 / 175,908 23:23:06 INFO - TinderboxPrint: CPU idle
8,218.5 (86.7%) 23:23:06 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 23:23:06 INFO - TinderboxPrint: Swap in / out
0 / 0 23:23:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77029376; Read time: 0; Write time: 48256 23:23:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249409536; Read time: 12; Write time: 127436 23:23:07 INFO - Running post-run listener: _upload_blobber_files 23:23:07 INFO - Blob upload gear active. 23:23:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:23:07 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 23:23:07 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'] 23:23:07 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 23:23:07 INFO - (blobuploader) - INFO - Open directory for files ... 23:23:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:23:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:08 INFO - (blobuploader) - INFO - Done attempting. 23:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:13 INFO - (blobuploader) - INFO - Done attempting. 23:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:14 INFO - (blobuploader) - INFO - Done attempting. 23:23:14 INFO - (blobuploader) - INFO - Iteration through files over. 23:23:14 INFO - Return code: 0 23:23:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:23:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:23:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74095f8d7c210e739ed49d9a15a9e182b7f63f2bb5ff13e5a5e5732c743221be281f6a7d1ef73a9164449165dcf5acc229387ac5d0c6274b4a9a7e8d5990f530", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a4372b045c6c037e5e538d500993026c65ff10d0727dc39f383b0d8cc913940fe8c5215908fcddd6c50d9d0fb0d7701eaf5f621ae5125cb05893634357f77ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9caafc1faba3f5438059012a0a84c55fd68211cc9b1b1d60281afba4d6a88b85fbb807a6229496eb7840ac152648c23089bbae13a621aad7b82008d7eadd23f1"} 23:23:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:23:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:23:14 INFO - Contents: 23:23:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74095f8d7c210e739ed49d9a15a9e182b7f63f2bb5ff13e5a5e5732c743221be281f6a7d1ef73a9164449165dcf5acc229387ac5d0c6274b4a9a7e8d5990f530", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a4372b045c6c037e5e538d500993026c65ff10d0727dc39f383b0d8cc913940fe8c5215908fcddd6c50d9d0fb0d7701eaf5f621ae5125cb05893634357f77ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9caafc1faba3f5438059012a0a84c55fd68211cc9b1b1d60281afba4d6a88b85fbb807a6229496eb7840ac152648c23089bbae13a621aad7b82008d7eadd23f1"} 23:23:14 INFO - Running post-run listener: copy_logs_to_upload_dir 23:23:14 INFO - Copying logs to upload dir... 23:23:14 INFO - mkdir: /builds/slave/test/build/upload/logs 23:23:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.170220 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-24 23:23:13.906058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:23:13.909703) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 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/74095f8d7c210e739ed49d9a15a9e182b7f63f2bb5ff13e5a5e5732c743221be281f6a7d1ef73a9164449165dcf5acc229387ac5d0c6274b4a9a7e8d5990f530", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a4372b045c6c037e5e538d500993026c65ff10d0727dc39f383b0d8cc913940fe8c5215908fcddd6c50d9d0fb0d7701eaf5f621ae5125cb05893634357f77ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9caafc1faba3f5438059012a0a84c55fd68211cc9b1b1d60281afba4d6a88b85fbb807a6229496eb7840ac152648c23089bbae13a621aad7b82008d7eadd23f1"} build_url:https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/SgsUDC-MSc2iWDIuBjyqwA/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/74095f8d7c210e739ed49d9a15a9e182b7f63f2bb5ff13e5a5e5732c743221be281f6a7d1ef73a9164449165dcf5acc229387ac5d0c6274b4a9a7e8d5990f530", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a4372b045c6c037e5e538d500993026c65ff10d0727dc39f383b0d8cc913940fe8c5215908fcddd6c50d9d0fb0d7701eaf5f621ae5125cb05893634357f77ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9caafc1faba3f5438059012a0a84c55fd68211cc9b1b1d60281afba4d6a88b85fbb807a6229496eb7840ac152648c23089bbae13a621aad7b82008d7eadd23f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:23:13.936649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:23:13.937038) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472104514.839705-337400211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:23:14.020246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:23:14.020752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:23:14.021209) ========= ========= Total master_lag: 0.18 =========