builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1465398205.52 results: success (0) buildid: 20160608073029 builduid: 7f7b72134c2f4cb49e5b5d2d3b3fd8da revision: 5753eb3ec41884030a12d9df006ee8fced481ca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.525706) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.526728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.527425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.582806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.583124) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 08:03:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-06-08 08:03:25 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.718075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.718398) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020784 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.778827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:25.779257) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5753eb3ec41884030a12d9df006ee8fced481ca5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5753eb3ec41884030a12d9df006ee8fced481ca5 --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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 08:03:25,911 truncating revision to first 12 chars 2016-06-08 08:03:25,911 Setting DEBUG logging. 2016-06-08 08:03:25,911 attempt 1/10 2016-06-08 08:03:25,911 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5753eb3ec418?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 08:03:26,499 unpacking tar archive at: fx-team-5753eb3ec418/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943638 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:26.747929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:26.748658) ========= script_repo_revision: 5753eb3ec41884030a12d9df006ee8fced481ca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:26.749641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:26.750381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:03:26.762756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-08 08:03:26.763068) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:26 INFO - MultiFileLogger online at 20160608 08:03:26 in /builds/slave/test 08:03:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:03:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:26 INFO - {'append_to_log': False, 08:03:26 INFO - 'base_work_dir': '/builds/slave/test', 08:03:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:03:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:26 INFO - 'branch': 'Fx-Team-Non-PGO', 08:03:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:26 INFO - 'config_files': ('talos/linux_config.py',), 08:03:26 INFO - 'default_actions': ('clobber', 08:03:26 INFO - 'read-buildbot-config', 08:03:26 INFO - 'download-and-extract', 08:03:26 INFO - 'populate-webroot', 08:03:26 INFO - 'create-virtualenv', 08:03:26 INFO - 'install', 08:03:26 INFO - 'run-tests'), 08:03:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:26 INFO - 'download_minidump_stackwalk': True, 08:03:26 INFO - 'download_symbols': 'ondemand', 08:03:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:26 INFO - 'installer_path': 'installer.exe', 08:03:26 INFO - 'log_level': 'info', 08:03:26 INFO - 'log_name': 'talos', 08:03:26 INFO - 'log_to_console': True, 08:03:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:26 INFO - 'opt_config_files': (), 08:03:26 INFO - 'pip_index': False, 08:03:26 INFO - 'sps_profile': False, 08:03:26 INFO - 'sps_profile_interval': 0, 08:03:26 INFO - 'suite': 'dromaeojs', 08:03:26 INFO - 'system_bits': '32', 08:03:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:26 INFO - 'title': 'talos-linux64-ix-051', 08:03:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:26 INFO - 'use_talos_json': True, 08:03:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:26 INFO - 'work_dir': 'build'} 08:03:26 INFO - ##### 08:03:26 INFO - ##### Running clobber step. 08:03:26 INFO - ##### 08:03:26 INFO - Running pre-action listener: _resource_record_pre_action 08:03:26 INFO - Running main action method: clobber 08:03:26 INFO - rmtree: /builds/slave/test/build 08:03:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:27 INFO - Running post-action listener: _resource_record_post_action 08:03:27 INFO - ##### 08:03:27 INFO - ##### Finished clobber step (success) 08:03:27 INFO - ##### 08:03:27 INFO - ##### 08:03:27 INFO - ##### Running read-buildbot-config step. 08:03:27 INFO - ##### 08:03:27 INFO - Running pre-action listener: _resource_record_pre_action 08:03:27 INFO - Running main action method: read_buildbot_config 08:03:27 INFO - Using buildbot properties: 08:03:27 INFO - { 08:03:27 INFO - "project": "", 08:03:27 INFO - "product": "firefox", 08:03:27 INFO - "script_repo_revision": "production", 08:03:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:03:27 INFO - "repository": "", 08:03:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:03:27 INFO - "buildid": "20160608073029", 08:03:27 INFO - "pgo_build": "False", 08:03:27 INFO - "basedir": "/builds/slave/test", 08:03:27 INFO - "buildnumber": 1832, 08:03:27 INFO - "slavename": "talos-linux64-ix-051", 08:03:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:03:27 INFO - "platform": "ubuntu64_hw", 08:03:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:03:27 INFO - "branch": "fx-team", 08:03:27 INFO - "repo_path": "integration/fx-team", 08:03:27 INFO - "revision": "5753eb3ec41884030a12d9df006ee8fced481ca5", 08:03:27 INFO - "stage_platform": "linux64", 08:03:27 INFO - "builduid": "7f7b72134c2f4cb49e5b5d2d3b3fd8da", 08:03:27 INFO - "slavebuilddir": "test" 08:03:27 INFO - } 08:03:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:03:27 INFO - Running post-action listener: _resource_record_post_action 08:03:27 INFO - ##### 08:03:27 INFO - ##### Finished read-buildbot-config step (success) 08:03:27 INFO - ##### 08:03:27 INFO - ##### 08:03:27 INFO - ##### Running download-and-extract step. 08:03:27 INFO - ##### 08:03:27 INFO - Running pre-action listener: _resource_record_pre_action 08:03:27 INFO - Running main action method: download_and_extract 08:03:27 INFO - mkdir: /builds/slave/test/build/tests 08:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:27 INFO - https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:03:32 INFO - Downloaded 1361 bytes. 08:03:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:32 INFO - Using the following test package requirements: 08:03:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:03:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:03:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'jsshell-linux-x86_64.zip'], 08:03:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:03:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:03:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:03:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:03:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:03:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:03:32 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')]} 08:03:32 INFO - https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:33 INFO - Downloaded 22878228 bytes. 08:03:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:03:34 INFO - Return code: 0 08:03:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:34 INFO - https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:38 INFO - Downloaded 22878228 bytes. 08:03:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:03:39 INFO - Return code: 0 08:03:39 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')]} 08:03:39 INFO - https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:03:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:03:40 INFO - Downloaded 10833369 bytes. 08:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:03:41 INFO - Return code: 0 08:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:41 INFO - https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:03:42 INFO - Downloaded 55336680 bytes. 08:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:03:42 INFO - mkdir: /builds/slave/test/properties 08:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:42 INFO - Contents: 08:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:03:43 INFO - Running post-action listener: _resource_record_post_action 08:03:43 INFO - Running post-action listener: set_extra_try_arguments 08:03:43 INFO - ##### 08:03:43 INFO - ##### Finished download-and-extract step (success) 08:03:43 INFO - ##### 08:03:43 INFO - ##### 08:03:43 INFO - ##### Running populate-webroot step. 08:03:43 INFO - ##### 08:03:43 INFO - Running pre-action listener: _resource_record_pre_action 08:03:43 INFO - Running main action method: populate_webroot 08:03:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:43 INFO - '--tppagecycles', 08:03:43 INFO - '7'], 08:03:43 INFO - 'tests': ['tsvgm']}}, 08:03:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['damp', 'tps']}, 08:03:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'tests': ['damp', 'tps']}, 08:03:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['dromaeo_dom']}, 08:03:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['a11yr', 08:03:43 INFO - 'ts_paint', 08:03:43 INFO - 'tpaint', 08:03:43 INFO - 'sessionrestore', 08:03:43 INFO - 'sessionrestore_no_auto_restore', 08:03:43 INFO - 'tabpaint']}, 08:03:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['tsvgx', 08:03:43 INFO - 'tsvgr_opacity', 08:03:43 INFO - 'tart', 08:03:43 INFO - 'tscrollx', 08:03:43 INFO - 'cart']}, 08:03:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:43 INFO - 'tsvgr_opacity', 08:03:43 INFO - 'tart', 08:03:43 INFO - 'tscrollx', 08:03:43 INFO - 'cart']}, 08:03:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'talos_options': ['--disable-e10s'], 08:03:43 INFO - 'tests': ['tp5o']}, 08:03:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'tests': ['tp5o']}, 08:03:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'talos_options': ['--disable-e10s', 08:03:43 INFO - '--xperf_path', 08:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:43 INFO - 'tests': ['tp5n']}, 08:03:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:43 INFO - 'talos_options': ['--xperf_path', 08:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:43 INFO - 'tests': ['tp5n']}}, 08:03:43 INFO - 'talos.zip': {'path': '', 08:03:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:43 INFO - Running post-action listener: _resource_record_post_action 08:03:43 INFO - ##### 08:03:43 INFO - ##### Finished populate-webroot step (success) 08:03:43 INFO - ##### 08:03:43 INFO - ##### 08:03:43 INFO - ##### Running create-virtualenv step. 08:03:43 INFO - ##### 08:03:43 INFO - Running pre-action listener: _resource_record_pre_action 08:03:43 INFO - Running main action method: create_virtualenv 08:03:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:43 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 08:03:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:43 INFO - Using real prefix '/usr' 08:03:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:45 INFO - Installing pip.................done. 08:03:45 INFO - Return code: 0 08:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:45 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')]} 08:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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')]} 08:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:45 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 08:03:45 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 08:03:45 INFO - Using env: {'DISPLAY': ':0', 08:03:45 INFO - 'HOME': '/home/cltbld', 08:03:45 INFO - 'LANG': 'en_US.UTF-8', 08:03:45 INFO - 'LANGUAGE': 'en_US:en', 08:03:45 INFO - 'LOGNAME': 'cltbld', 08:03:45 INFO - 'MAIL': '/var/mail/cltbld', 08:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:45 INFO - 'MOZ_NO_REMOTE': '1', 08:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:45 INFO - 'NO_EM_RESTART': '1', 08:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:45 INFO - 'PWD': '/builds/slave/test', 08:03:45 INFO - 'SHELL': '/bin/bash', 08:03:45 INFO - 'SHLVL': '1', 08:03:45 INFO - 'TERM': 'linux', 08:03:45 INFO - 'TMOUT': '86400', 08:03:45 INFO - 'USER': 'cltbld', 08:03:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:45 INFO - '_': '/tools/buildbot/bin/python'} 08:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:45 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 08:03:45 INFO - Cleaning up... 08:03:45 INFO - Return code: 0 08:03:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:45 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')]} 08:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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')]} 08:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:45 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 08:03:45 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 08:03:45 INFO - Using env: {'DISPLAY': ':0', 08:03:45 INFO - 'HOME': '/home/cltbld', 08:03:45 INFO - 'LANG': 'en_US.UTF-8', 08:03:45 INFO - 'LANGUAGE': 'en_US:en', 08:03:45 INFO - 'LOGNAME': 'cltbld', 08:03:45 INFO - 'MAIL': '/var/mail/cltbld', 08:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:45 INFO - 'MOZ_NO_REMOTE': '1', 08:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:45 INFO - 'NO_EM_RESTART': '1', 08:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:45 INFO - 'PWD': '/builds/slave/test', 08:03:45 INFO - 'SHELL': '/bin/bash', 08:03:45 INFO - 'SHLVL': '1', 08:03:45 INFO - 'TERM': 'linux', 08:03:45 INFO - 'TMOUT': '86400', 08:03:45 INFO - 'USER': 'cltbld', 08:03:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:45 INFO - '_': '/tools/buildbot/bin/python'} 08:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:46 INFO - Downloading/unpacking psutil>=3.1.1 08:03:46 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 08:03:46 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 08:03:46 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 08:03:46 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 08:03:46 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 08:03:46 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 08:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:48 INFO - Installing collected packages: psutil 08:03:48 INFO - Running setup.py install for psutil 08:03:48 INFO - building 'psutil._psutil_linux' extension 08:03:48 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 08:03:48 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 08:03:48 INFO - building 'psutil._psutil_posix' extension 08:03:48 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 08:03:48 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 08:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:48 INFO - Successfully installed psutil 08:03:48 INFO - Cleaning up... 08:03:48 INFO - Return code: 0 08:03:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:48 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:48 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 08:03:48 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 08:03:48 INFO - Using env: {'DISPLAY': ':0', 08:03:48 INFO - 'HOME': '/home/cltbld', 08:03:48 INFO - 'LANG': 'en_US.UTF-8', 08:03:48 INFO - 'LANGUAGE': 'en_US:en', 08:03:48 INFO - 'LOGNAME': 'cltbld', 08:03:48 INFO - 'MAIL': '/var/mail/cltbld', 08:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:48 INFO - 'MOZ_NO_REMOTE': '1', 08:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:48 INFO - 'NO_EM_RESTART': '1', 08:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:48 INFO - 'PWD': '/builds/slave/test', 08:03:48 INFO - 'SHELL': '/bin/bash', 08:03:48 INFO - 'SHLVL': '1', 08:03:48 INFO - 'TERM': 'linux', 08:03:48 INFO - 'TMOUT': '86400', 08:03:48 INFO - 'USER': 'cltbld', 08:03:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:48 INFO - '_': '/tools/buildbot/bin/python'} 08:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:50 INFO - Installing collected packages: mozsystemmonitor 08:03:50 INFO - Running setup.py install for mozsystemmonitor 08:03:50 INFO - Successfully installed mozsystemmonitor 08:03:50 INFO - Cleaning up... 08:03:51 INFO - Return code: 0 08:03:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:51 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')]} 08:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:51 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')]} 08:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:51 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:51 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 08:03:51 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 08:03:51 INFO - Using env: {'DISPLAY': ':0', 08:03:51 INFO - 'HOME': '/home/cltbld', 08:03:51 INFO - 'LANG': 'en_US.UTF-8', 08:03:51 INFO - 'LANGUAGE': 'en_US:en', 08:03:51 INFO - 'LOGNAME': 'cltbld', 08:03:51 INFO - 'MAIL': '/var/mail/cltbld', 08:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:51 INFO - 'MOZ_NO_REMOTE': '1', 08:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:51 INFO - 'NO_EM_RESTART': '1', 08:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:51 INFO - 'PWD': '/builds/slave/test', 08:03:51 INFO - 'SHELL': '/bin/bash', 08:03:51 INFO - 'SHLVL': '1', 08:03:51 INFO - 'TERM': 'linux', 08:03:51 INFO - 'TMOUT': '86400', 08:03:51 INFO - 'USER': 'cltbld', 08:03:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:51 INFO - '_': '/tools/buildbot/bin/python'} 08:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:53 INFO - warning: no files found matching '*.txt' 08:03:53 INFO - no previously-included directories found matching 'build' 08:03:53 INFO - no previously-included directories found matching 'dist' 08:03:53 INFO - no previously-included directories found matching '.git*' 08:03:53 INFO - Installing collected packages: jsonschema, functools32 08:03:53 INFO - Running setup.py install for functools32 08:03:53 INFO - warning: no files found matching '*.txt' 08:03:53 INFO - no previously-included directories found matching 'build' 08:03:53 INFO - no previously-included directories found matching 'dist' 08:03:53 INFO - no previously-included directories found matching '.git*' 08:03:53 INFO - Successfully installed jsonschema functools32 08:03:53 INFO - Cleaning up... 08:03:53 INFO - Return code: 0 08:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:03:53 INFO - Using env: {'DISPLAY': ':0', 08:03:53 INFO - 'HOME': '/home/cltbld', 08:03:53 INFO - 'LANG': 'en_US.UTF-8', 08:03:53 INFO - 'LANGUAGE': 'en_US:en', 08:03:53 INFO - 'LOGNAME': 'cltbld', 08:03:53 INFO - 'MAIL': '/var/mail/cltbld', 08:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:53 INFO - 'MOZ_NO_REMOTE': '1', 08:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:53 INFO - 'NO_EM_RESTART': '1', 08:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:53 INFO - 'PWD': '/builds/slave/test', 08:03:53 INFO - 'SHELL': '/bin/bash', 08:03:53 INFO - 'SHLVL': '1', 08:03:53 INFO - 'TERM': 'linux', 08:03:53 INFO - 'TMOUT': '86400', 08:03:53 INFO - 'USER': 'cltbld', 08:03:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:53 INFO - '_': '/tools/buildbot/bin/python'} 08:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:53 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 08:03:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:55 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 08:03:55 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 08:03:55 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 08:03:55 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 08:03:55 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 08:03:55 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 08:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03:56 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 08:03:56 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 08:03:56 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 08:03:56 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 08:03:56 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 08:03:56 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 08:03:56 INFO - Downloading docopt-0.6.1.tar.gz 08:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:56 INFO - Running setup.py install for blobuploader 08:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:56 INFO - Running setup.py install for requests 08:03:57 INFO - Running setup.py install for docopt 08:03:57 INFO - Successfully installed blobuploader requests docopt 08:03:57 INFO - Cleaning up... 08:03:57 INFO - Return code: 0 08:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:57 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')]} 08:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:57 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')]} 08:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:57 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:03:57 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 08:03:57 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 08:03:57 INFO - Using env: {'DISPLAY': ':0', 08:03:57 INFO - 'HOME': '/home/cltbld', 08:03:57 INFO - 'LANG': 'en_US.UTF-8', 08:03:57 INFO - 'LANGUAGE': 'en_US:en', 08:03:57 INFO - 'LOGNAME': 'cltbld', 08:03:57 INFO - 'MAIL': '/var/mail/cltbld', 08:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:57 INFO - 'MOZ_NO_REMOTE': '1', 08:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:57 INFO - 'NO_EM_RESTART': '1', 08:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:57 INFO - 'PWD': '/builds/slave/test', 08:03:57 INFO - 'SHELL': '/bin/bash', 08:03:57 INFO - 'SHLVL': '1', 08:03:57 INFO - 'TERM': 'linux', 08:03:57 INFO - 'TMOUT': '86400', 08:03:57 INFO - 'USER': 'cltbld', 08:03:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:57 INFO - '_': '/tools/buildbot/bin/python'} 08:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 INFO - Running setup.py (path:/tmp/pip-THGd2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 INFO - Running setup.py (path:/tmp/pip-mhoo0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 INFO - Running setup.py (path:/tmp/pip-qvMxG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:57 INFO - Running setup.py (path:/tmp/pip-E0HjA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:57 INFO - Running setup.py (path:/tmp/pip-VNeWDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:57 INFO - Running setup.py (path:/tmp/pip-SAkeF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:57 INFO - Running setup.py (path:/tmp/pip-0hgKJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:57 INFO - Running setup.py (path:/tmp/pip-CIYgDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:57 INFO - Running setup.py (path:/tmp/pip-U6icsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:58 INFO - Running setup.py (path:/tmp/pip-BZtPg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 INFO - Running setup.py (path:/tmp/pip-N0SReb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 INFO - Running setup.py (path:/tmp/pip-jNXM1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 INFO - Running setup.py (path:/tmp/pip-xvGOE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:58 INFO - Running setup.py (path:/tmp/pip-GEg7RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:58 INFO - Running setup.py (path:/tmp/pip-UnzZwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:58 INFO - Running setup.py (path:/tmp/pip-HUUCeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:58 INFO - Running setup.py (path:/tmp/pip-8NAloN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:58 INFO - Running setup.py install for manifestparser 08:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Running setup.py install for mozcrash 08:03:58 INFO - Running setup.py install for mozdebug 08:03:58 INFO - Running setup.py install for mozdevice 08:03:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozfile 08:03:59 INFO - Running setup.py install for mozhttpd 08:03:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozinfo 08:03:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozInstall 08:03:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozleak 08:03:59 INFO - Running setup.py install for mozlog 08:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for moznetwork 08:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozprocess 08:03:59 INFO - Running setup.py install for mozprofile 08:03:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Running setup.py install for mozrunner 08:04:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:00 INFO - Running setup.py install for mozscreenshot 08:04:00 INFO - Running setup.py install for moztest 08:04:00 INFO - Running setup.py install for mozversion 08:04:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:00 INFO - Cleaning up... 08:04:00 INFO - Return code: 0 08:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:00 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:04:00 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 08:04:00 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 08:04:00 INFO - Using env: {'DISPLAY': ':0', 08:04:00 INFO - 'HOME': '/home/cltbld', 08:04:00 INFO - 'LANG': 'en_US.UTF-8', 08:04:00 INFO - 'LANGUAGE': 'en_US:en', 08:04:00 INFO - 'LOGNAME': 'cltbld', 08:04:00 INFO - 'MAIL': '/var/mail/cltbld', 08:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:00 INFO - 'MOZ_NO_REMOTE': '1', 08:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:00 INFO - 'NO_EM_RESTART': '1', 08:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:00 INFO - 'PWD': '/builds/slave/test', 08:04:00 INFO - 'SHELL': '/bin/bash', 08:04:00 INFO - 'SHLVL': '1', 08:04:00 INFO - 'TERM': 'linux', 08:04:00 INFO - 'TMOUT': '86400', 08:04:00 INFO - 'USER': 'cltbld', 08:04:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:00 INFO - '_': '/tools/buildbot/bin/python'} 08:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:00 INFO - Running setup.py (path:/tmp/pip-5DIBH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:00 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)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:00 INFO - Running setup.py (path:/tmp/pip-gI6wLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:00 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)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:00 INFO - Running setup.py (path:/tmp/pip-7KsEPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:00 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)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:00 INFO - Running setup.py (path:/tmp/pip-ytDcC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:00 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)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:00 INFO - Running setup.py (path:/tmp/pip-nw7lG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:01 INFO - Running setup.py (path:/tmp/pip-W_MsZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:01 INFO - Running setup.py (path:/tmp/pip-NLZkOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:01 INFO - Running setup.py (path:/tmp/pip-tyA4gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:01 INFO - Running setup.py (path:/tmp/pip-910qqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:01 INFO - Running setup.py (path:/tmp/pip-Mhkark-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:01 INFO - Running setup.py (path:/tmp/pip-2gCVuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:01 INFO - Running setup.py (path:/tmp/pip-GNaF9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:01 INFO - Running setup.py (path:/tmp/pip-Q9lcux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:01 INFO - Running setup.py (path:/tmp/pip-414SPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:01 INFO - Running setup.py (path:/tmp/pip-9TXXJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:01 INFO - Running setup.py (path:/tmp/pip-xVTlzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:01 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)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:01 INFO - Running setup.py (path:/tmp/pip-EsT4Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:01 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)) 08:04:01 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)) 08:04:01 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)) 08:04:01 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)) 08:04:01 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)) 08:04:01 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)) 08:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:01 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 08:04:01 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 08:04:01 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 08:04:01 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 08:04:01 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 08:04:01 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 08:04:03 INFO - Downloading blessings-1.6.tar.gz 08:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:03 INFO - Installing collected packages: blessings 08:04:03 INFO - Running setup.py install for blessings 08:04:03 INFO - Successfully installed blessings 08:04:03 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:04 INFO - Reading from file tmpfile_stdout 08:04:04 INFO - Current package versions: 08:04:04 INFO - argparse == 1.2.1 08:04:04 INFO - blessings == 1.6 08:04:04 INFO - blobuploader == 1.2.4 08:04:04 INFO - docopt == 0.6.1 08:04:04 INFO - functools32 == 3.2.3-2 08:04:04 INFO - jsonschema == 2.5.1 08:04:04 INFO - manifestparser == 1.1 08:04:04 INFO - mozInstall == 1.12 08:04:04 INFO - mozcrash == 0.17 08:04:04 INFO - mozdebug == 0.1 08:04:04 INFO - mozdevice == 0.48 08:04:04 INFO - mozfile == 1.2 08:04:04 INFO - mozhttpd == 0.7 08:04:04 INFO - mozinfo == 0.9 08:04:04 INFO - mozleak == 0.1 08:04:04 INFO - mozlog == 3.2 08:04:04 INFO - moznetwork == 0.27 08:04:04 INFO - mozprocess == 0.22 08:04:04 INFO - mozprofile == 0.28 08:04:04 INFO - mozrunner == 6.11 08:04:04 INFO - mozscreenshot == 0.1 08:04:04 INFO - mozsystemmonitor == 0.3 08:04:04 INFO - moztest == 0.7 08:04:04 INFO - mozversion == 1.4 08:04:04 INFO - psutil == 3.1.1 08:04:04 INFO - requests == 1.2.3 08:04:04 INFO - wsgiref == 0.1.2 08:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:04 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 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:04:04 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 08:04:04 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 08:04:04 INFO - Using env: {'DISPLAY': ':0', 08:04:04 INFO - 'HOME': '/home/cltbld', 08:04:04 INFO - 'LANG': 'en_US.UTF-8', 08:04:04 INFO - 'LANGUAGE': 'en_US:en', 08:04:04 INFO - 'LOGNAME': 'cltbld', 08:04:04 INFO - 'MAIL': '/var/mail/cltbld', 08:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:04 INFO - 'MOZ_NO_REMOTE': '1', 08:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:04 INFO - 'NO_EM_RESTART': '1', 08:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:04 INFO - 'PWD': '/builds/slave/test', 08:04:04 INFO - 'SHELL': '/bin/bash', 08:04:04 INFO - 'SHLVL': '1', 08:04:04 INFO - 'TERM': 'linux', 08:04:04 INFO - 'TMOUT': '86400', 08:04:04 INFO - 'USER': 'cltbld', 08:04:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:04 INFO - '_': '/tools/buildbot/bin/python'} 08:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 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)) 08:04:04 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:04: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'] in /builds/slave/test/build 08:04: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 08:04:04 INFO - Using env: {'DISPLAY': ':0', 08:04:04 INFO - 'HOME': '/home/cltbld', 08:04:04 INFO - 'LANG': 'en_US.UTF-8', 08:04:04 INFO - 'LANGUAGE': 'en_US:en', 08:04:04 INFO - 'LOGNAME': 'cltbld', 08:04:04 INFO - 'MAIL': '/var/mail/cltbld', 08:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:04 INFO - 'MOZ_NO_REMOTE': '1', 08:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:04 INFO - 'NO_EM_RESTART': '1', 08:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:04 INFO - 'PWD': '/builds/slave/test', 08:04:04 INFO - 'SHELL': '/bin/bash', 08:04:04 INFO - 'SHLVL': '1', 08:04:04 INFO - 'TERM': 'linux', 08:04:04 INFO - 'TMOUT': '86400', 08:04:04 INFO - 'USER': 'cltbld', 08:04:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:04 INFO - '_': '/tools/buildbot/bin/python'} 08:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:04 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf6cc99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', '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 08:04: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', 'flake8'] in /builds/slave/test/build 08:04: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 flake8 08:04:04 INFO - Using env: {'DISPLAY': ':0', 08:04:04 INFO - 'HOME': '/home/cltbld', 08:04:04 INFO - 'LANG': 'en_US.UTF-8', 08:04:04 INFO - 'LANGUAGE': 'en_US:en', 08:04:04 INFO - 'LOGNAME': 'cltbld', 08:04:04 INFO - 'MAIL': '/var/mail/cltbld', 08:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:04 INFO - 'MOZ_NO_REMOTE': '1', 08:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:04 INFO - 'NO_EM_RESTART': '1', 08:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:04 INFO - 'PWD': '/builds/slave/test', 08:04:04 INFO - 'SHELL': '/bin/bash', 08:04:04 INFO - 'SHLVL': '1', 08:04:04 INFO - 'TERM': 'linux', 08:04:04 INFO - 'TMOUT': '86400', 08:04:04 INFO - 'USER': 'cltbld', 08:04:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:04 INFO - '_': '/tools/buildbot/bin/python'} 08:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:04 INFO - Downloading/unpacking flake8 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:07 INFO - no previously-included directories found matching 'docs/_build' 08:04:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:07 INFO - Running setup.py install for pep8 08:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:07 INFO - no previously-included directories found matching 'docs/_build' 08:04:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:04:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:07 INFO - Cleaning up... 08:04:07 INFO - Return code: 0 08:04:07 INFO - Running post-action listener: _resource_record_post_action 08:04:07 INFO - Running post-action listener: _start_resource_monitoring 08:04:07 INFO - Starting resource monitoring. 08:04:07 INFO - ##### 08:04:07 INFO - ##### Finished create-virtualenv step (success) 08:04:07 INFO - ##### 08:04:07 INFO - ##### 08:04:07 INFO - ##### Running install step. 08:04:07 INFO - ##### 08:04:07 INFO - Running pre-action listener: _resource_record_pre_action 08:04:07 INFO - Running main action method: install 08:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:07 INFO - Reading from file tmpfile_stdout 08:04:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:08 INFO - Reading from file tmpfile_stdout 08:04:08 INFO - Output received: 08:04:08 INFO - Usage: mozinstall [options] installer 08:04:08 INFO - Options: 08:04:08 INFO - -h, --help show this help message and exit 08:04:08 INFO - -d DEST, --destination=DEST 08:04:08 INFO - Directory to install application into. [default: 08:04:08 INFO - "/builds/slave/test"] 08:04:08 INFO - --app=APP Application being installed. [default: firefox] 08:04:08 INFO - mkdir: /builds/slave/test/build/application 08:04:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:04:24 INFO - Reading from file tmpfile_stdout 08:04:24 INFO - Output received: 08:04:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:24 INFO - Running post-action listener: _resource_record_post_action 08:04:24 INFO - ##### 08:04:24 INFO - ##### Finished install step (success) 08:04:24 INFO - ##### 08:04:24 INFO - ##### 08:04:24 INFO - ##### Running run-tests step. 08:04:24 INFO - ##### 08:04:24 INFO - Running pre-action listener: _resource_record_pre_action 08:04:24 INFO - Running main action method: run_tests 08:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:24 INFO - Python 2.7.3 08:04:24 INFO - Return code: 0 08:04:24 INFO - grabbing minidump binary from tooltool 08:04: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')]} 08:04:24 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 0x2d3f1c0>, '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 0x2d400c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d40550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:24 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 08:04:24 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 08:04:24 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 08:04:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:24 INFO - Return code: 0 08:04:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:04:25 INFO - Return code: 0 08:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:04:25 INFO - Using env: {'DISPLAY': ':0', 08:04:25 INFO - 'HOME': '/home/cltbld', 08:04:25 INFO - 'LANG': 'en_US.UTF-8', 08:04:25 INFO - 'LANGUAGE': 'en_US:en', 08:04:25 INFO - 'LOGNAME': 'cltbld', 08:04:25 INFO - 'MAIL': '/var/mail/cltbld', 08:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:25 INFO - 'MOZ_NO_REMOTE': '1', 08:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:25 INFO - 'NO_EM_RESTART': '1', 08:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:25 INFO - 'PWD': '/builds/slave/test', 08:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:25 INFO - 'SHELL': '/bin/bash', 08:04:25 INFO - 'SHLVL': '1', 08:04:25 INFO - 'TERM': 'linux', 08:04:25 INFO - 'TMOUT': '86400', 08:04:25 INFO - 'USER': 'cltbld', 08:04:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654', 08:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:25 INFO - '_': '/tools/buildbot/bin/python'} 08:04:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:04:25 INFO - mozversion application_buildid: 20160608073029 08:04:25 INFO - mozversion application_changeset: 5753eb3ec41884030a12d9df006ee8fced481ca5 08:04:25 INFO - mozversion application_display_name: Nightly 08:04:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:25 INFO - mozversion application_name: Firefox 08:04:25 INFO - mozversion application_remotingname: firefox 08:04:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:04:25 INFO - mozversion application_vendor: Mozilla 08:04:25 INFO - mozversion application_version: 50.0a1 08:04:25 INFO - mozversion platform_buildid: 20160608073029 08:04:25 INFO - mozversion platform_changeset: 5753eb3ec41884030a12d9df006ee8fced481ca5 08:04:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:04:25 INFO - mozversion platform_version: 50.0a1 08:04:25 INFO - using testdate: 1465398265 08:04:25 INFO - actual date: 1465398265 08:04:25 INFO - starting webserver on 'localhost:46905' 08:04:25 INFO - SUITE-START | Running 2 tests 08:04:25 INFO - TEST-START | dromaeo_css 08:04:25 INFO - operating with platform_type : linux_ 08:04:25 INFO - Initialising browser for dromaeo_css test... 08:04:25 INFO - TEST-INFO | started process 12947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMqLvPl/profile http://localhost:46905/getInfo.html) 08:04:29 INFO - PROCESS | 12947 | __metrics Screen width/height:1600/1200 08:04:29 INFO - PROCESS | 12947 | colorDepth:24 08:04:29 INFO - PROCESS | 12947 | Browser inner width/height: 1024/697 08:04:29 INFO - PROCESS | 12947 | __metrics 08:04:30 ERROR - PROCESS | 12947 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:04:30 INFO - PROCESS | 12947 | console.error: PushService: 08:04:30 INFO - PROCESS | 12947 | stateChangeProcessEnqueue: Error transitioning state 08:04:30 INFO - PROCESS | 12947 | UnknownError 08:04:31 INFO - TEST-INFO | 12947: exit 0 08:04:31 INFO - Browser initialized. 08:04:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:31 INFO - TEST-INFO | started process 13025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMqLvPl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:43 INFO - PROCESS | 13025 | RSS: Main: 158326784 08:04:43 INFO - PROCESS | 13025 | 08:05:34 INFO - PROCESS | 13025 | 1465398334482 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] 08:07:47 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46905/tests/dromaeo/cssquery-ext.html) 08:07:48 INFO - PROCESS | 13025 | RSS: Main: 250556416 08:07:48 INFO - PROCESS | 13025 | 08:10:51 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-ext.html (next: http://localhost:46905/tests/dromaeo/cssquery-jquery.html) 08:10:52 INFO - PROCESS | 13025 | RSS: Main: 249393152 08:10:52 INFO - PROCESS | 13025 | 08:13:54 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46905/tests/dromaeo/cssquery-mootools.html) 08:13:54 INFO - PROCESS | 13025 | RSS: Main: 245669888 08:13:54 INFO - PROCESS | 13025 | 08:16:57 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46905/tests/dromaeo/cssquery-prototype.html) 08:16:57 INFO - PROCESS | 13025 | RSS: Main: 236113920 08:16:57 INFO - PROCESS | 13025 | 08:20:00 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46905/tests/dromaeo/cssquery-yui.html) 08:20:01 INFO - PROCESS | 13025 | RSS: Main: 215429120 08:20:01 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-yui.html (next: http://localhost:46905/tests/dromaeo/cssquery-dojo.html) 08:23:04 INFO - PROCESS | 13025 | RSS: Main: 269721600 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | __start_tp_report 08:23:04 INFO - PROCESS | 13025 | _x_x_mozilla_page_load 08:23:04 INFO - PROCESS | 13025 | _x_x_mozilla_page_load_details 08:23:04 INFO - PROCESS | 13025 | |i|pagename|runs| 08:23:04 INFO - PROCESS | 13025 | |0;dojo.html;2642.7621514063735;2672.1582701449056;2693.717159698232;2719.0619236363445;2721.4148957974044;4562.6121779648765;4642.953570464294;4669.696469729465;4712.104700106982;4808.254720518316;4665.393498845154;4674.275487299474;4675.181843177447;4675.46232183299;4686.55477729616;4075.510938687362;4235.407043013981;4300.483941926973;4353.216421044211;4445.777711114431;4345.891352716191;4364.825406983717;4390.736555806662;4398.868033958986;4425.690201685883;4205.3271476563605;4242.893927651802;4249.192653395876;4249.277622804131;4271.273883439822;4222.809973551198;4300.827966881321;4312.63342615878;4312.978435107804;4360.934585981213;4274.230638485072;4282.164977829325;4297.20501707182;4339.218940590692;4339.891502712458;4484.080763443486;4487.483939346952;4551.908961820778;4575.176468235716;4636.02643444877;5051.545360917498;5059.392872855281;5070.797168113308;5087.79648814047;5095.668781529226;4895.4125504939275;5056.469070747556;5111.488851114896;5121.487851214849;5123.180291153398;4632.467266264389;4664.277037059262;4667.486576476585;4730.172219861579;4731.621470282369;5153.2270159476375;5173.224016397495;5175.818846340435;5182.015417070745;5184.14461613837;4794.2089555223;4963.205887058053;4971.825986090469;4976.278439626234;4977.701337919736;4996.175631020914;5023.6985780853265;5052.873678158002;5108.386993560722;5128.743562821844;5003.649744517848;5008.348914641073;5015.24771284303;5016.423111342242;5059.139946209153;4976.972218095409;5000.049990501866;5006.724630145377;5012.072766538202;5015.523525265094;4128.979355103205;4170.332746760564;4171.3325867860995;4220.78896055196;4222.683298752606;3652.4886515887797;3708.054446116277;3733.0853940784136;3745.400735882246;3749.418840079792;4360.389545463638;4396.274614688605;4400.053988392511;4424.911501769947;4433.778311084433;5037.395512538519;5038.445770965191;5042.243663450512;5046.823361182341;5076.18780995039;4271.508776490681;4385.978070109629;4388.605025547716;4391.121775644884;4424.823007079681;4521.977390113094;4528.7509186994375;4555.703879247904;4605.953940460619;4611.631069514431;4807.855764327076;4828.324034635224;4830.420349558076;4831.371921650163;4894.021195760934;4922.163232250455;4922.286268491121;4994.076095922266;5106.10643137442;5118.667286626357;4699.53004699541;4767.928481072856;4796.496367881462;4797;4838.056578967067;4966.925496117489;4972.477889821516;4973.35346404965;4973.428055773632;5013.724245166551;4908.705477671351;5032.834722781417;5035.420926593342;5055.949440505695;5088.821891233789;4939.975300123477;4952.702837829742;4961.3798275215595;4962.181240095344;4999.225120106389;4907.803687852446;4911.8280860169725;4939.209726443752;4949.257611358325;4970.080535101018;4654.720716757005;4747.620190384692;4770.475247722678;4779.808807647794;4905.852824415273;4883.926741098815;4902.240152776325;4904.068227036852;4938.43208031081;4939.061578300111;4827.131116399082;4828.589569886599;4833.903321933612;4860.684055536379;4873.439554451142 08:23:04 INFO - PROCESS | 13025 | |1;ext.html;543.5649932537972;577.8468705792966;581.5463938128262;583.0991118721574;599.0983569727559;29254.707452925464;42826.14347713044;44872.55127448725;45068.774656126756;45135.774321128345;39435;39516.60483395165;39894.8005259974;40020;40070.79964600173;7415.777526674208;7545.5849928254065;7780.961095194516;7788.649510772;10103.797924041515;9808.50957452128;10180.23648226386;10182.083612474877;10182.745431364201;10183.083522482975;10151.035651613121;10244.795104097913;10246.692599221999;10254.282200245985;10258.743531411737;7407.74072907451;9845.60617575296;10107.090361867431;10182.032706892833;10191.133753630951;9959.15347195482;10046.497675116216;10048.547815348327;10050.64822731201;10053;39352.60647393518;39408.802955985324;39513.604863951565;39603;39650;2934.2370983544433;3187.474066778979;3230.3862266169353;3741.8690345838036;3761.2289480656673;29438.70561294381;29714.702852971408;29858.850705746332;30011.249718756986;30889.691103088906;3261.8858339957987;3265.1673823175174;3267.738580913521;3307.057488615733;3328.7170590499595;254859;255069;256000;256238.71880640663;257233;28755.28111797222;29251.268718281786;55764;56317.43682563204;56485.71757141188;34690.30619387598;34732.82633586816;34774.65225347714;34865.65134348624;34939.65060349415;13225.470981160839;13300.866991329964;13304.13523120994;13320.200787952754;13321.200727956353;9714.077162669535;10831;11026.503807328689;11051.447427628586;11250.49372778227;7753.728619498291;7785.766427007199;7837.568933708587;7839.25527074927;7850.489718168301;3077.3691393264326;3136.670649581761;3161.5099659552807;3169.019362898189;3173.2066983254185;876.4741155306892;909.8453262945316;971.6453494474607;980.8083178937625;1051.51104736298;27167.82657387404;27519.17442476729;28602.284942876595;29317.706822931923;29911;959.8176346494143;981.4847205217176;994.7811481474064;1011.4689787861284;1086.8369744538381;14303.427862885368;14774.704505909822;14890;14958.177300248592;15019.77470337924;376686;384097;384638;385090;385816;49364;49772.50227497679;49778.25332620014;49795.50204497981;49798;1111.8165502692127;1137.419915842926;1198.2391181599573;1220.2251570252777;1262.1165184370977;26468.205953821416;28368;28418.71581284161;29209.269768255963;29403.55894661539;41754.37368439415;42054.52809151665;42501.1499770009;42611;42616.360754589325;311319;313580;313900;314317;314328;22106.33680989573;24684.38289042788;25155.24534263975;25521.361965951;25664.743352566235;41278.38082428706;41698.1660366797;42151.156976859675;42257.366139508544;42874.571254288305;35469;36140.63859361373;36574;36597;36833.44749828701;35217.64782352144;35487;35691.64308356883;36050.819745901106;36138;34935.12662183364;35509.467357990165;35769.46345804763;35852.82073589615;36007.27985440329;28625.856870715514;29776.85111574428;30080.81099786375;30153.246168845955;30174.2456438582;24410.633840492053;24538.50922981566;24947.126850560144;24963.341833057264;24986.81919920418 08:23:04 INFO - PROCESS | 13025 | |2;jquery.html;359.0986623574828;369.55468660264376;370.2945888083201;374.76202611341824;383.31195504070206;15862.444814431497;15981.121038342886;16257.430989915356;17092.743608845863;17447.563810904718;15748.685026299467;16164.75752863708;16763.413280535184;16775.91612041941;16784.160791960414;4935.407751069876;5020.548150666439;5021.949780502185;5088.796448142089;5100;3655.4516822476576;3837.3860182370827;4938.654294199408;5604.215409842625;5892.646441213519;5910.083936989773;5911.556633252501;5952.70236488176;5957.851053723648;5964;5758.3090029196765;5802.245708057946;5831.446012628793;5846.473817356458;5913.2608423947;3300.3729291434793;4739.976300118477;5072.137736584753;5080.034793389244;5205.869853253661;18859.622807543772;19315.4205373839;19341.51646208856;19955.401337959884;19963.80036199634;1845.6031953130007;1850.380122658911;1867.5797945462161;1870.0743132149537;1881.5296175956012;12575;12749.298788566624;12826.486940522367;13045.804312935314;13322.400491977884;1707.1464267866068;1745.7468667043336;1753.3863147898262;1753.544078539576;1802.2971041293774;68968.24127034913;69239.99999999949;69596.6520167401;69622.65188674025;70276.29723702748;9109.726708198765;9211.30915181364;9469.431834089977;9538.189253913357;9753.512324383895;13474.52839150625;13578.864211357957;13583.864161358457;13595.660108497168;13620.863791361959;7015.754448594274;7093.503454758221;7170.92829071713;7181.619212280505;7249;6704.229013663394;6806.931930680729;6880.793576192722;6882.621455819978;6888.724451022003;5991.281046274475;6155.938440615626;6158.261008678897;6171.876562468815;6198.597091189058;1630.478246960961;1703.4719237036559;1767.8320559546823;1776.8933863968202;1783.6967715488397;874.8643960186181;903.7519096843411;1005.3163848583034;1006.9093781559695;1014.4674046125843;16328.591785205464;16643.41748038813;16646.08446535428;16828.411005614744;17075.573110672332;885.4775682347317;886.6719313853915;889.7108439756976;914.2777206007313;917.6100157433065;9162.450252984841;9619.51902404877;9643.228541716646;9669.180733469007;9741.610335586638;374898;375891;376868;381592;388507;66161.6691916547;66866;68206.65896670485;70654.29345706478;70751.64624176847;939.2204470289644;941.1435593609782;961.7162936933761;963.942163470194;970.2480577552312;9429.905700943178;10057.748556285858;14718.116912985255;14766.234610174766;15246.313915874034;31370.843145784125;36641.633583663825;37107.814460927526;37870.62129378781;39564.80217598894;45071.32393014042;47679;48545.5145448541;50532;51629.48370516247;11501.597444089417;11694.356810375171;11793.115516336138;11801.881981180422;11890.524379025088;12634.620961371174;12659.493620255087;12742.745145097231;12911.289879056367;12940.611781646565;10384.951662461654;10469.581216751245;10496.370217786956;10507.900169450184;10571.418571978307;10569.894301056891;10656.724921164074;10982.560697572007;11098.61154859576;11196.272242304223;10615.840762388416;10716.517756701123;10878.891211087788;10886.23796334249;10999.120070394189;11118.888811112109;11592.942035289769;11600.30398176112;11685.240459370114;11780.410979451164;10512.474376281309;10694.946525267324;10721.624743133953;10772.299800512941;10832 08:23:04 INFO - PROCESS | 13025 | |3;mootools.html;1200.3698058519271;1389.4789453954768;1454.0693955868246;1559.407425178432;1735.8871673341223;6782.321767823215;7417.666205020773;7658.6553605087765;7661.4253930955265;7666.808329791751;7428.962855185717;7659.425543084277;7666;7840.294373506384;7842;1845.317232623931;1910.512819231101;1911.2928216559892;2210.4363387336207;2267.183813827021;1908.351160605394;2129.371835308588;2242.854214476054;2244.6969659095976;2260.367097212783;2176.1621775616422;2192.375173075674;2197.505561248722;2198.7251593550805;2199.967000494994;1820.0535721424917;2153.6446486329814;2161.7838216178416;2162.329677799887;2163.210428193706;2115.851890367675;2196.978030219693;2198.1317379634957;2210.281658461007;2211.2150186683657;7634.923650763477;7655.196204398514;7664.540127592307;7679.769606911802;7700.884486732703;4510.548945105496;4637.536246375369;4637.907241855178;4640.373549570832;4647.88380290492;2789.693133755285;2874.3245337345707;2899.1882272963603;2912.0390271210663;2954.0989998050586;915.9587818548181;916.7983043730369;922.3635691372931;940.5485367023798;950.12588418655;10568.735781605445;10850.186236032328;10851.131909447226;10865.130789536817;10898.182636302308;4285.485741711014;4290.227759003409;4387.846425375096;4395.252807022814;4401.207782599163;9322.161005509537;9345.392549484397;9349.252059835197;9356.438613683065;9360.4383736976;4734.786934587883;4736.573708366263;4740.597049250852;4744.288356746516;4744.59670927975;3618.873339433107;3800.4299355096955;3980.960190398117;4075.653569446571;4080.755154690728;3639.5086663300117;3751.549814022335;3805.5813860475328;3826.1964987352967;3831.923361532754;1164.3770582738364;1184.6150001249628;1188.2514016169757;1197.5688752049255;1197.8442802435627;659.2319947261386;769.8960640313599;805.0460204657383;810.4812919731377;815.4699445360563;5259.579913423431;5320.334958130234;5335.62650614461;5507.504324610804;5520.089185284463;408.15104582468393;410.3905700035445;415.0971636690187;423.5214207945002;427.8010725012884;3442.913927151791;3529.1131933697134;3736.252749450121;3745.1198968242443;3763.983724394453;9424.340296179202;9651.71044868655;9748.073932976356;9755.317127800985;9766.218702503782;9606.135447809731;9717.17404020652;9736.513174341255;9750.658726944523;9787.314887957917;7155.141383034069;7168.641567921583;7297.124345078624;7313.524620899624;7318.268173182639;4920.505746213873;5054.4692807254705;5079.92380114306;5114.539691427789;5213.791448342024;8737.956310218407;8855.91144088551;8898.822023559364;9015.14356136166;9020.729378118667;8932.19610235082;8978.191962723386;9107.043760405062;9130.497822619554;9192.448453092837;5867.501262392574;6193.380661933951;6334.8733025338315;6498.772542960974;6553.344665533408;7424.665890035069;7447.702091916262;7461.552306861606;7519.8496030077995;7526.172121066569;6507.381798729113;6681.365270299314;6791.3548212919695;6835.453163746789;6932.688029038604;6702.597844129368;6728.7308507659145;6766.458683305422;6822.420094292041;6886.10480637514;5678.574106942078;5679.659220446786;5744.798932037359;5767.134929760569;5769.278840144982;4479.216137176047;4543.250363689954;4556.2254416748565;4575.450945886515;4645.187092258909;4155.735124357293;4389.4513185851765;4472.932906006347;4546.045330480636;4576.977115114403 08:23:04 INFO - PROCESS | 13025 | |4;prototype.html;295.1587974273321;295.7146353768613;300.75187969924815;302.8909592546683;307.5432982021698;4728.929066064012;4823.638227132961;4830.227163653816;4843.927341089887;4861.6353773467;4751.5010923853015;4755.262934245189;4760.857833829673;4785.234362502;4788.970371370155;3581.3016461790025;3600.6759391654746;3696.7781933083966;3734.9253014939686;3768.3970564709653;3718.1634132320282;3742.9625703743022;3747.2692824899154;3770.5852356240794;3779.1496913194587;3558.8754393596228;3726.049857286388;3732.1602639406187;3749.9437508437395;3753.474513568103;3633.2370202257557;3701.5743189533146;3728.6457786510236;3734.9439758403646;3777.6411240932066;3330.134165117087;3330.533725278463;3342.2647017656077;3352.0614228016193;3353.5351516635255;4523.886902827423;4526.388937493462;4533.773311334453;4540.523245059254;4557.225271703818;4051.6556092732153;4307.440032795748;4309.159713855799;4311.461067366579;4333.9133217335475;4970.4650628179525;4973.477784832613;4984.750762461862;4989.875253118665;4989.954118811306;3624.746267761258;3630.3646861799343;3636.4181730922924;3642.307961487309;3642.597599924048;4946.985867897109;5167.948320516784;5189;5210.218467229908;5214.634975551713;3713.9814300928324;3752.512173417438;3753.5871054184017;3779.111908701453;3807.3717836556657;3856.9228615428096;3860.4209368594934;3870.59358767331;3906.6679332257077;3909.4331321958157;4350.71720338177;4351.369051487517;4358.607725304738;4369.186787483159;4374.518802931675;4808.422989241313;4994.175960966472;4999.925001124986;5002.674826136362;5012.273220383024;1304.5955753716378;1330.4079684540286;1331.4807225182187;1340.611222745393;1342.3355439057534;867.7526904832092;874.2568816505919;898.492351821232;915.81121120522;927.7938679716342;4421.513633500313;4430.847979525347;4441.911161776747;4459.821607135678;4466.151431228056;5075.3402057732255;5080.526647272323;5097.337346145052;5112.565431938253;5130.9738052389675;4200;4361.542038086019;4377.781110944504;4419.071994881111;4446.866594002185;2675.331167208198;2684.302081458835;2686.1672881406826;2693.5151672699103;2710.0108460412202;4780.11567859947;4788.449328327287;4788.640851936049;4794.5924596409695;4807.18277892759;4989.525995030466;5136.794528218904;5159.380874295109;5169.751158246175;5294;4895.363602731622;4911.45973942866;4913.975430122827;4915.729634869974;4929.802807887716;5171.586273098218;5178.275041494269;5179.948200517946;5182.352205974254;5192.221166825007;4847.636427267898;5064.518870707277;5069.138246498031;5075.213341932006;5100.974495127501;4843.176659967884;4906.337644417958;4907.5828554571835;4914.827981020647;4918.4343800461975;3625.528681271418;3634.7637403569743;3635.636436356343;3645.8906232813056;3663.7435379523176;4931.876703082452;5188.58491320701;5189.92215116766;5258.605604579749;5262.500062494057;5011.123053465702;5029;5029.396472423333;5056.165732654071;5060.139776238122;5030.723310217827;5033;5055.949440505695;5060.443351231435;5060.721660308571;4819.3012013258585;4931.926021109614;4933.827316044065;4944.085344211332;4969.304297398295;4806.951930480651;4868.245421959602;5038.848834534823;5047.217681259411;5057.721825299644;4926.359573255454;4943.8516844494725;4969.353983982204;4974.204127339608;4976.875578110431 08:23:04 INFO - PROCESS | 13025 | |5;yui.html;640.5548144039892;687.7352219395533;723.6598798564676;735.819724167579;736.5433431272612;11980.700482487931;12395.070369722273;12496.250224986507;12520.311382873939;12523.624291271253;12020.939895300533;13093.54172603959;13094.148880322773;13109.344532773372;13120.6719832004;616.6454288783945;762.9656665450068;783.5690370296343;795.3080819686852;796.3867821777228;797.696875187428;801.519088546873;805.1505661527086;805.4200975297776;805.5649949027518;838.3083955736512;839.9832003359929;840.5965136734371;841.0118111219293;841.2218697704599;655.9048937904001;671.8958561422987;672.4385138409409;673.9696713647849;837.4472847920374;587.0988033368801;601.4346514276566;605.503487140545;605.5549171359047;607.7568972411071;12997.415116319788;13064.542741004114;13067.607971760863;13092;13093.345332733325;12436.316002619853;12855.74288514234;12897.2906490143;13047.54333598329;13065.331649587957;11345;11381.317120972686;11445.370504622242;11585.18903676743;11730.472128754227;4157.584241575849;4177.3316269397055;4231.724937879058;4356.43366362374;4364.629006534448;56060.439395606336;56274.15588766172;56397;56492.435075649126;56764;10126.898731012743;10307.84538231927;10315.484225788681;10608.893911060944;10843.1867609928;19068.427947161606;19177.904110479358;19184.80815191858;19204.423867284004;19207.32774352891;6595.505337099737;6636.402723754885;6739.056532085512;6772.187337519431;6787.864242715118;3553.093961039918;3615.5661320641166;3656.926861462756;3757;3772.1512659651908;2772.334639686501;2867.498187817165;2871.5692646102834;2877.0649538899943;2877.453283876057;512.3825789923134;512.6360284198261;519.1952473665802;522.0472637436693;524.520064141314;441.12436812926313;470.3109943932088;485.3496314938;523.5419008367678;532.3736727835101;7628.656710448043;7629.7329593463965;7691.769246922601;7723.150453450116;7858.292753652085;417.67212738000524;460;465.734531317146;520.10541867987;526.2211926349025;3603.85584576614;3645.981770091186;3694.0395497170393;3717.8512859485318;3770.359038963383;83618;84563;88021.55989220012;89245;89805.55097224603;50265;71877.64061179661;80126;80303.59848200722;80366;45556.54443455589;52210.477895221324;71590;71708;72165;6676.455605166131;6863.176418829772;6969.612489545678;6994.160700715946;7025.2272250053475;43068.28552156509;43395.56604434041;44066;44341.77829110834;45339.31991020071;58030.4196958025;61118;61278.693606531684;61623.383766161765;61874.38125618686;9059.456432614064;9225.07749225072;9425.151736343762;9501.144896959308;9648.614055437985;9082.619727243968;9492.95253523728;9581.137697607248;9614.9038509614;9691.563879625293;7753.961230193813;8047.718329858427;9174.075121985003;9270.53647317645;9713.805723885624;10719.839202412126;11208.719782005515;11250.268732532359;11472.541098356307;11474.368909709712;9991.800163996824;10279.691609251735;10516.68449946503;10635.308704934154;10874;9330.346875718635;9442.52787360643;9515.857262141211;9633.470159141314;10073.244506661884;8964.462132272085;9182.540872956459;9346.719598412059;9538.332316737762;9712.9028709712 08:23:04 INFO - PROCESS | 13025 | __end_tp_report 08:23:04 INFO - PROCESS | 13025 | __start_cc_report 08:23:04 INFO - PROCESS | 13025 | _x_x_mozilla_cycle_collect,938 08:23:04 INFO - PROCESS | 13025 | __end_cc_report 08:23:04 INFO - PROCESS | 13025 | __startTimestamp1465399384784__endTimestamp 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | ------- Summary: start ------- 08:23:04 INFO - PROCESS | 13025 | Number of tests: 6 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#0] dojo.html Cycles:165 Average:4650.87 Median:4797.00 stddev:487.81 (10.2%) stddev-sans-first:463.17 08:23:04 INFO - PROCESS | 13025 | Values: 2642.8 2672.2 2693.7 2719.1 2721.4 4562.6 4643.0 4669.7 4712.1 4808.3 4665.4 4674.3 4675.2 4675.5 4686.6 4075.5 4235.4 4300.5 4353.2 4445.8 4345.9 4364.8 4390.7 4398.9 4425.7 4205.3 4242.9 4249.2 4249.3 4271.3 4222.8 4300.8 4312.6 4313.0 4360.9 4274.2 4282.2 4297.2 4339.2 4339.9 4484.1 4487.5 4551.9 4575.2 4636.0 5051.5 5059.4 5070.8 5087.8 5095.7 4895.4 5056.5 5111.5 5121.5 5123.2 4632.5 4664.3 4667.5 4730.2 4731.6 5153.2 5173.2 5175.8 5182.0 5184.1 4794.2 4963.2 4971.8 4976.3 4977.7 4996.2 5023.7 5052.9 5108.4 5128.7 5003.6 5008.3 5015.2 5016.4 5059.1 4977.0 5000.0 5006.7 5012.1 5015.5 4129.0 4170.3 4171.3 4220.8 4222.7 3652.5 3708.1 3733.1 3745.4 3749.4 4360.4 4396.3 4400.1 4424.9 4433.8 5037.4 5038.4 5042.2 5046.8 5076.2 4271.5 4386.0 4388.6 4391.1 4424.8 4522.0 4528.8 4555.7 4606.0 4611.6 4807.9 4828.3 4830.4 4831.4 4894.0 4922.2 4922.3 4994.1 5106.1 5118.7 4699.5 4767.9 4796.5 4797.0 4838.1 4966.9 4972.5 4973.4 4973.4 5013.7 4908.7 5032.8 5035.4 5055.9 5088.8 4940.0 4952.7 4961.4 4962.2 4999.2 4907.8 4911.8 4939.2 4949.3 4970.1 4654.7 4747.6 4770.5 4779.8 4905.9 4883.9 4902.2 4904.1 4938.4 4939.1 4827.1 4828.6 4833.9 4860.7 4873.4 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#1] ext.html Cycles:180 Average:46373.65 Median:3263.53 stddev:84756.01 (2597.1%) stddev-sans-first:84923.92 08:23:04 INFO - PROCESS | 13025 | Values: 543.6 577.8 581.5 583.1 599.1 29254.7 42826.1 44872.6 45068.8 45135.8 39435.0 39516.6 39894.8 40020.0 40070.8 7415.8 7545.6 7781.0 7788.6 10103.8 9808.5 10180.2 10182.1 10182.7 10183.1 10151.0 10244.8 10246.7 10254.3 10258.7 7407.7 9845.6 10107.1 10182.0 10191.1 9959.2 10046.5 10048.5 10050.6 10053.0 39352.6 39408.8 39513.6 39603.0 39650.0 2934.2 3187.5 3230.4 3741.9 3761.2 29438.7 29714.7 29858.9 30011.2 30889.7 3261.9 3265.2 3267.7 3307.1 3328.7 254859.0 255069.0 256000.0 256238.7 257233.0 28755.3 29251.3 55764.0 56317.4 56485.7 34690.3 34732.8 34774.7 34865.7 34939.7 13225.5 13300.9 13304.1 13320.2 13321.2 9714.1 10831.0 11026.5 11051.4 11250.5 7753.7 7785.8 7837.6 7839.3 7850.5 3077.4 3136.7 3161.5 3169.0 3173.2 876.5 909.8 971.6 980.8 1051.5 27167.8 27519.2 28602.3 29317.7 29911.0 959.8 981.5 994.8 1011.5 1086.8 14303.4 14774.7 14890.0 14958.2 15019.8 376686.0 384097.0 384638.0 385090.0 385816.0 49364.0 49772.5 49778.3 49795.5 49798.0 1111.8 1137.4 1198.2 1220.2 1262.1 26468.2 28368.0 28418.7 29209.3 29403.6 41754.4 42054.5 42501.1 42611.0 42616.4 311319.0 313580.0 313900.0 314317.0 314328.0 22106.3 24684.4 25155.2 25521.4 25664.7 41278.4 41698.2 42151.2 42257.4 42874.6 35469.0 36140.6 36574.0 36597.0 36833.4 35217.6 35487.0 35691.6 36050.8 36138.0 34935.1 35509.5 35769.5 35852.8 36007.3 28625.9 29776.9 30080.8 30153.2 30174.2 24410.6 24538.5 24947.1 24963.3 24986.8 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#2] jquery.html Cycles:180 Average:24005.19 Median:20148.54 stddev:62463.71 (310.0%) stddev-sans-first:62613.71 08:23:04 INFO - PROCESS | 13025 | Values: 359.1 369.6 370.3 374.8 383.3 15862.4 15981.1 16257.4 17092.7 17447.6 15748.7 16164.8 16763.4 16775.9 16784.2 4935.4 5020.5 5021.9 5088.8 5100.0 3655.5 3837.4 4938.7 5604.2 5892.6 5910.1 5911.6 5952.7 5957.9 5964.0 5758.3 5802.2 5831.4 5846.5 5913.3 3300.4 4740.0 5072.1 5080.0 5205.9 18859.6 19315.4 19341.5 19955.4 19963.8 1845.6 1850.4 1867.6 1870.1 1881.5 12575.0 12749.3 12826.5 13045.8 13322.4 1707.1 1745.7 1753.4 1753.5 1802.3 68968.2 69240.0 69596.7 69622.7 70276.3 9109.7 9211.3 9469.4 9538.2 9753.5 13474.5 13578.9 13583.9 13595.7 13620.9 7015.8 7093.5 7170.9 7181.6 7249.0 6704.2 6806.9 6880.8 6882.6 6888.7 5991.3 6155.9 6158.3 6171.9 6198.6 1630.5 1703.5 1767.8 1776.9 1783.7 874.9 903.8 1005.3 1006.9 1014.5 16328.6 16643.4 16646.1 16828.4 17075.6 885.5 886.7 889.7 914.3 917.6 9162.5 9619.5 9643.2 9669.2 9741.6 374898.0 375891.0 376868.0 381592.0 388507.0 66161.7 66866.0 68206.7 70654.3 70751.6 939.2 941.1 961.7 963.9 970.2 9429.9 10057.7 14718.1 14766.2 15246.3 31370.8 36641.6 37107.8 37870.6 39564.8 45071.3 47679.0 48545.5 50532.0 51629.5 11501.6 11694.4 11793.1 11801.9 11890.5 12634.6 12659.5 12742.7 12911.3 12940.6 10385.0 10469.6 10496.4 10507.9 10571.4 10569.9 10656.7 10982.6 11098.6 11196.3 10615.8 10716.5 10878.9 10886.2 10999.1 11118.9 11592.9 11600.3 11685.2 11780.4 10512.5 10694.9 10721.6 10772.3 10832.0 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#3] mootools.html Cycles:180 Average:5094.02 Median:4987.49 stddev:2906.94 (58.3%) stddev-sans-first:2900.37 08:23:04 INFO - PROCESS | 13025 | Values: 1200.4 1389.5 1454.1 1559.4 1735.9 6782.3 7417.7 7658.7 7661.4 7666.8 7429.0 7659.4 7666.0 7840.3 7842.0 1845.3 1910.5 1911.3 2210.4 2267.2 1908.4 2129.4 2242.9 2244.7 2260.4 2176.2 2192.4 2197.5 2198.7 2200.0 1820.1 2153.6 2161.8 2162.3 2163.2 2115.9 2197.0 2198.1 2210.3 2211.2 7634.9 7655.2 7664.5 7679.8 7700.9 4510.5 4637.5 4637.9 4640.4 4647.9 2789.7 2874.3 2899.2 2912.0 2954.1 916.0 916.8 922.4 940.5 950.1 10568.7 10850.2 10851.1 10865.1 10898.2 4285.5 4290.2 4387.8 4395.3 4401.2 9322.2 9345.4 9349.3 9356.4 9360.4 4734.8 4736.6 4740.6 4744.3 4744.6 3618.9 3800.4 3981.0 4075.7 4080.8 3639.5 3751.5 3805.6 3826.2 3831.9 1164.4 1184.6 1188.3 1197.6 1197.8 659.2 769.9 805.0 810.5 815.5 5259.6 5320.3 5335.6 5507.5 5520.1 408.2 410.4 415.1 423.5 427.8 3442.9 3529.1 3736.3 3745.1 3764.0 9424.3 9651.7 9748.1 9755.3 9766.2 9606.1 9717.2 9736.5 9750.7 9787.3 7155.1 7168.6 7297.1 7313.5 7318.3 4920.5 5054.5 5079.9 5114.5 5213.8 8738.0 8855.9 8898.8 9015.1 9020.7 8932.2 8978.2 9107.0 9130.5 9192.4 5867.5 6193.4 6334.9 6498.8 6553.3 7424.7 7447.7 7461.6 7519.8 7526.2 6507.4 6681.4 6791.4 6835.5 6932.7 6702.6 6728.7 6766.5 6822.4 6886.1 5678.6 5679.7 5744.8 5767.1 5769.3 4479.2 4543.3 4556.2 4575.5 4645.2 4155.7 4389.5 4472.9 4546.0 4577.0 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#4] prototype.html Cycles:180 Average:4170.13 Median:4786.84 stddev:1194.58 (25.0%) stddev-sans-first:1161.99 08:23:04 INFO - PROCESS | 13025 | Values: 295.2 295.7 300.8 302.9 307.5 4728.9 4823.6 4830.2 4843.9 4861.6 4751.5 4755.3 4760.9 4785.2 4789.0 3581.3 3600.7 3696.8 3734.9 3768.4 3718.2 3743.0 3747.3 3770.6 3779.1 3558.9 3726.0 3732.2 3749.9 3753.5 3633.2 3701.6 3728.6 3734.9 3777.6 3330.1 3330.5 3342.3 3352.1 3353.5 4523.9 4526.4 4533.8 4540.5 4557.2 4051.7 4307.4 4309.2 4311.5 4333.9 4970.5 4973.5 4984.8 4989.9 4990.0 3624.7 3630.4 3636.4 3642.3 3642.6 4947.0 5167.9 5189.0 5210.2 5214.6 3714.0 3752.5 3753.6 3779.1 3807.4 3856.9 3860.4 3870.6 3906.7 3909.4 4350.7 4351.4 4358.6 4369.2 4374.5 4808.4 4994.2 4999.9 5002.7 5012.3 1304.6 1330.4 1331.5 1340.6 1342.3 867.8 874.3 898.5 915.8 927.8 4421.5 4430.8 4441.9 4459.8 4466.2 5075.3 5080.5 5097.3 5112.6 5131.0 4200.0 4361.5 4377.8 4419.1 4446.9 2675.3 2684.3 2686.2 2693.5 2710.0 4780.1 4788.4 4788.6 4794.6 4807.2 4989.5 5136.8 5159.4 5169.8 5294.0 4895.4 4911.5 4914.0 4915.7 4929.8 5171.6 5178.3 5179.9 5182.4 5192.2 4847.6 5064.5 5069.1 5075.2 5101.0 4843.2 4906.3 4907.6 4914.8 4918.4 3625.5 3634.8 3635.6 3645.9 3663.7 4931.9 5188.6 5189.9 5258.6 5262.5 5011.1 5029.0 5029.4 5056.2 5060.1 5030.7 5033.0 5055.9 5060.4 5060.7 4819.3 4931.9 4933.8 4944.1 4969.3 4807.0 4868.2 5038.8 5047.2 5057.7 4926.4 4943.9 4969.4 4974.2 4976.9 08:23:04 INFO - PROCESS | 13025 | 08:23:04 INFO - PROCESS | 13025 | [#5] yui.html Cycles:180 Average:16271.53 Median:56444.72 stddev:22716.93 (40.2%) stddev-sans-first:22750.34 08:23:04 INFO - PROCESS | 13025 | Values: 640.6 687.7 723.7 735.8 736.5 11980.7 12395.1 12496.3 12520.3 12523.6 12020.9 13093.5 13094.1 13109.3 13120.7 616.6 763.0 783.6 795.3 796.4 797.7 801.5 805.2 805.4 805.6 838.3 840.0 840.6 841.0 841.2 655.9 671.9 672.4 674.0 837.4 587.1 601.4 605.5 605.6 607.8 12997.4 13064.5 13067.6 13092.0 13093.3 12436.3 12855.7 12897.3 13047.5 13065.3 11345.0 11381.3 11445.4 11585.2 11730.5 4157.6 4177.3 4231.7 4356.4 4364.6 56060.4 56274.2 56397.0 56492.4 56764.0 10126.9 10307.8 10315.5 10608.9 10843.2 19068.4 19177.9 19184.8 19204.4 19207.3 6595.5 6636.4 6739.1 6772.2 6787.9 3553.1 3615.6 3656.9 3757.0 3772.2 2772.3 2867.5 2871.6 2877.1 2877.5 512.4 512.6 519.2 522.0 524.5 441.1 470.3 485.3 523.5 532.4 7628.7 7629.7 7691.8 7723.2 7858.3 417.7 460.0 465.7 520.1 526.2 3603.9 3646.0 3694.0 3717.9 3770.4 83618.0 84563.0 88021.6 89245.0 89805.6 50265.0 71877.6 80126.0 80303.6 80366.0 45556.5 52210.5 71590.0 71708.0 72165.0 6676.5 6863.2 6969.6 6994.2 7025.2 43068.3 43395.6 44066.0 44341.8 45339.3 58030.4 61118.0 61278.7 61623.4 61874.4 9059.5 9225.1 9425.2 9501.1 9648.6 9082.6 9493.0 9581.1 9614.9 9691.6 7754.0 8047.7 9174.1 9270.5 9713.8 10719.8 11208.7 11250.3 11472.5 11474.4 9991.8 10279.7 10516.7 10635.3 10874.0 9330.3 9442.5 9515.9 9633.5 10073.2 8964.5 9182.5 9346.7 9538.3 9712.9 08:23:04 INFO - PROCESS | 13025 | -------- Summary: end -------- 08:23:04 INFO - PROCESS | 13025 | 08:23:05 INFO - TEST-INFO | 13025: exit 0 08:23:05 INFO - TEST-OK | dromaeo_css | took 1120388ms 08:23:05 INFO - TEST-START | kraken 08:23:05 INFO - operating with platform_type : linux_ 08:23:05 INFO - Initialising browser for kraken test... 08:23:05 INFO - TEST-INFO | started process 13202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgh9Whg/profile http://localhost:46905/getInfo.html) 08:23:09 INFO - PROCESS | 13202 | __metrics Screen width/height:1600/1200 08:23:09 INFO - PROCESS | 13202 | colorDepth:24 08:23:09 INFO - PROCESS | 13202 | Browser inner width/height: 1024/697 08:23:09 INFO - PROCESS | 13202 | __metrics 08:23:10 ERROR - PROCESS | 13202 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:23:10 INFO - PROCESS | 13202 | console.error: PushService: 08:23:10 INFO - PROCESS | 13202 | stateChangeProcessEnqueue: Error transitioning state 08:23:10 INFO - PROCESS | 13202 | UnknownError 08:23:11 INFO - TEST-INFO | 13202: exit 0 08:23:11 INFO - Browser initialized. 08:23:11 INFO - Running cycle 1/1 for kraken test... 08:23:11 INFO - TEST-INFO | started process 13281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgh9Whg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:23 INFO - PROCESS | 13281 | RSS: Main: 157716480 08:23:23 INFO - PROCESS | 13281 | 08:23:26 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:27 INFO - PROCESS | 13281 | RSS: Main: 215703552 08:23:27 INFO - PROCESS | 13281 | 08:23:30 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-dft) 08:23:30 INFO - PROCESS | 13281 | RSS: Main: 202285056 08:23:30 INFO - PROCESS | 13281 | 08:23:33 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-fft) 08:23:34 INFO - PROCESS | 13281 | RSS: Main: 270073856 08:23:34 INFO - PROCESS | 13281 | 08:23:36 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-oscillator) 08:23:37 INFO - PROCESS | 13281 | RSS: Main: 180461568 08:23:37 INFO - PROCESS | 13281 | 08:23:39 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:40 INFO - PROCESS | 13281 | RSS: Main: 183955456 08:23:40 INFO - PROCESS | 13281 | 08:23:43 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:43 INFO - PROCESS | 13281 | RSS: Main: 220647424 08:23:43 INFO - PROCESS | 13281 | 08:23:47 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:48 INFO - PROCESS | 13281 | RSS: Main: 216403968 08:23:48 INFO - PROCESS | 13281 | 08:23:50 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46905/tests/kraken/driver.html?testName=json-parse-financial) 08:23:51 INFO - PROCESS | 13281 | RSS: Main: 219332608 08:23:51 INFO - PROCESS | 13281 | 08:23:53 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:53 INFO - PROCESS | 13281 | RSS: Main: 209211392 08:23:53 INFO - PROCESS | 13281 | 08:23:55 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:56 INFO - PROCESS | 13281 | RSS: Main: 208171008 08:23:56 INFO - PROCESS | 13281 | 08:23:58 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:59 INFO - PROCESS | 13281 | RSS: Main: 216829952 08:23:59 INFO - PROCESS | 13281 | 08:24:02 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:02 INFO - PROCESS | 13281 | RSS: Main: 221392896 08:24:02 INFO - PROCESS | 13281 | 08:24:05 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:06 INFO - PROCESS | 13281 | RSS: Main: 220782592 08:24:06 INFO - PROCESS | 13281 | 08:24:07 INFO - PROCESS | 13281 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46905/tests/kraken/driver.html?testName=ai-astar) 08:24:08 INFO - PROCESS | 13281 | RSS: Main: 263450624 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | __start_tp_report 08:24:08 INFO - PROCESS | 13281 | _x_x_mozilla_page_load 08:24:08 INFO - PROCESS | 13281 | _x_x_mozilla_page_load_details 08:24:08 INFO - PROCESS | 13281 | |i|pagename|runs| 08:24:08 INFO - PROCESS | 13281 | |0;ai-astar;113;109;115;115;112;115;113;113;113;112 08:24:08 INFO - PROCESS | 13281 | |1;audio-beat-detection;159;134;135;204;130;131;159;134;186;132 08:24:08 INFO - PROCESS | 13281 | |2;audio-dft;162;162;160;161;162;164;163;161;161;160 08:24:08 INFO - PROCESS | 13281 | |3;audio-fft;74;75;76;114;77;77;75;82;101;76 08:24:08 INFO - PROCESS | 13281 | |4;audio-oscillator;86;86;115;86;86;87;123;86;85;129 08:24:08 INFO - PROCESS | 13281 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;117 08:24:08 INFO - PROCESS | 13281 | |6;imaging-darkroom;146;146;147;146;146;146;148;147;147;146 08:24:08 INFO - PROCESS | 13281 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 08:24:08 INFO - PROCESS | 13281 | |8;json-parse-financial;63;61;62;63;62;61;61;62;63;64 08:24:08 INFO - PROCESS | 13281 | |9;json-stringify-tinderbox;64;65;64;66;65;64;64;66;65;64 08:24:08 INFO - PROCESS | 13281 | |10;stanford-crypto-aes;85;85;85;83;85;85;85;90;124;90 08:24:08 INFO - PROCESS | 13281 | |11;stanford-crypto-ccm;134;139;136;131;133;131;130;144;138;132 08:24:08 INFO - PROCESS | 13281 | |12;stanford-crypto-pbkdf2;168;168;170;167;167;166;175;167;170;164 08:24:08 INFO - PROCESS | 13281 | |13;stanford-crypto-sha256-iterative;67;69;70;69;67;66;67;66;65;67 08:24:08 INFO - PROCESS | 13281 | __end_tp_report 08:24:08 INFO - PROCESS | 13281 | __start_cc_report 08:24:08 INFO - PROCESS | 13281 | _x_x_mozilla_cycle_collect,1859 08:24:08 INFO - PROCESS | 13281 | __end_cc_report 08:24:08 INFO - PROCESS | 13281 | __startTimestamp1465399448210__endTimestamp 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | ------- Summary: start ------- 08:24:08 INFO - PROCESS | 13281 | Number of tests: 14 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.83 (1.6%) stddev-sans-first:1.94 08:24:08 INFO - PROCESS | 13281 | Values: 113.0 109.0 115.0 115.0 112.0 115.0 113.0 113.0 113.0 112.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:147.00 stddev:26.23 (17.8%) stddev-sans-first:27.64 08:24:08 INFO - PROCESS | 13281 | Values: 159.0 134.0 135.0 204.0 130.0 131.0 159.0 134.0 186.0 132.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 08:24:08 INFO - PROCESS | 13281 | Values: 162.0 162.0 160.0 161.0 162.0 164.0 163.0 161.0 161.0 160.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.60 (17.9%) stddev-sans-first:14.05 08:24:08 INFO - PROCESS | 13281 | Values: 74.0 75.0 76.0 114.0 77.0 77.0 75.0 82.0 101.0 76.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:86.00 stddev:17.87 (20.8%) stddev-sans-first:18.51 08:24:08 INFO - PROCESS | 13281 | Values: 86.0 86.0 115.0 86.0 86.0 87.0 123.0 86.0 85.0 129.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:24:08 INFO - PROCESS | 13281 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:24:08 INFO - PROCESS | 13281 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 148.0 147.0 147.0 146.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:24:08 INFO - PROCESS | 13281 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 08:24:08 INFO - PROCESS | 13281 | Values: 63.0 61.0 62.0 63.0 62.0 61.0 61.0 62.0 63.0 64.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 08:24:08 INFO - PROCESS | 13281 | Values: 64.0 65.0 64.0 66.0 65.0 64.0 64.0 66.0 65.0 64.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:85.00 stddev:12.27 (14.4%) stddev-sans-first:12.89 08:24:08 INFO - PROCESS | 13281 | Values: 85.0 85.0 85.0 83.0 85.0 85.0 85.0 90.0 124.0 90.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:135.00 stddev:4.44 (3.3%) stddev-sans-first:4.70 08:24:08 INFO - PROCESS | 13281 | Values: 134.0 139.0 136.0 131.0 133.0 131.0 130.0 144.0 138.0 132.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.00 stddev:2.97 (1.8%) stddev-sans-first:3.15 08:24:08 INFO - PROCESS | 13281 | Values: 168.0 168.0 170.0 167.0 167.0 166.0 175.0 167.0 170.0 164.0 08:24:08 INFO - PROCESS | 13281 | 08:24:08 INFO - PROCESS | 13281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 08:24:08 INFO - PROCESS | 13281 | Values: 67.0 69.0 70.0 69.0 67.0 66.0 67.0 66.0 65.0 67.0 08:24:08 INFO - PROCESS | 13281 | -------- Summary: end -------- 08:24:08 INFO - PROCESS | 13281 | 08:24:09 INFO - TEST-INFO | 13281: exit 0 08:24:09 INFO - TEST-OK | kraken | took 63645ms 08:24:09 INFO - SUITE-END | took 1184s 08:24:09 INFO - Completed test suite (00:19:44) 08:24:09 INFO - javascript benchmark 08:24:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.7621514063735, 2672.1582701449056, 2693.717159698232, 2719.0619236363445, 2721.4148957974044, 4562.6121779648765, 4642.953570464294, 4669.696469729465, 4712.104700106982, 4808.254720518316, 4665.393498845154, 4674.275487299474, 4675.181843177447, 4675.46232183299, 4686.55477729616, 4075.510938687362, 4235.407043013981, 4300.483941926973, 4353.216421044211, 4445.777711114431, 4345.891352716191, 4364.825406983717, 4390.736555806662, 4398.868033958986, 4425.690201685883, 4205.3271476563605, 4242.893927651802, 4249.192653395876, 4249.277622804131, 4271.273883439822, 4222.809973551198, 4300.827966881321, 4312.63342615878, 4312.978435107804, 4360.934585981213, 4274.230638485072, 4282.164977829325, 4297.20501707182, 4339.218940590692, 4339.891502712458, 4484.080763443486, 4487.483939346952, 4551.908961820778, 4575.176468235716, 4636.02643444877, 5051.545360917498, 5059.392872855281, 5070.797168113308, 5087.79648814047, 5095.668781529226, 4895.4125504939275, 5056.469070747556, 5111.488851114896, 5121.487851214849, 5123.180291153398, 4632.467266264389, 4664.277037059262, 4667.486576476585, 4730.172219861579, 4731.621470282369, 5153.2270159476375, 5173.224016397495, 5175.818846340435, 5182.015417070745, 5184.14461613837, 4794.2089555223, 4963.205887058053, 4971.825986090469, 4976.278439626234, 4977.701337919736, 4996.175631020914, 5023.6985780853265, 5052.873678158002, 5108.386993560722, 5128.743562821844, 5003.649744517848, 5008.348914641073, 5015.24771284303, 5016.423111342242, 5059.139946209153, 4976.972218095409, 5000.049990501866, 5006.724630145377, 5012.072766538202, 5015.523525265094, 4128.979355103205, 4170.332746760564, 4171.3325867860995, 4220.78896055196, 4222.683298752606, 3652.4886515887797, 3708.054446116277, 3733.0853940784136, 3745.400735882246, 3749.418840079792, 4360.389545463638, 4396.274614688605, 4400.053988392511, 4424.911501769947, 4433.778311084433, 5037.395512538519, 5038.445770965191, 5042.243663450512, 5046.823361182341, 5076.18780995039, 4271.508776490681, 4385.978070109629, 4388.605025547716, 4391.121775644884, 4424.823007079681, 4521.977390113094, 4528.7509186994375, 4555.703879247904, 4605.953940460619, 4611.631069514431, 4807.855764327076, 4828.324034635224, 4830.420349558076, 4831.371921650163, 4894.021195760934, 4922.163232250455, 4922.286268491121, 4994.076095922266, 5106.10643137442, 5118.667286626357, 4699.53004699541, 4767.928481072856, 4796.496367881462, 4797.0, 4838.056578967067, 4966.925496117489, 4972.477889821516, 4973.35346404965, 4973.428055773632, 5013.724245166551, 4908.705477671351, 5032.834722781417, 5035.420926593342, 5055.949440505695, 5088.821891233789, 4939.975300123477, 4952.702837829742, 4961.3798275215595, 4962.181240095344, 4999.225120106389, 4907.803687852446, 4911.8280860169725, 4939.209726443752, 4949.257611358325, 4970.080535101018, 4654.720716757005, 4747.620190384692, 4770.475247722678, 4779.808807647794, 4905.852824415273, 4883.926741098815, 4902.240152776325, 4904.068227036852, 4938.43208031081, 4939.061578300111, 4827.131116399082, 4828.589569886599, 4833.903321933612, 4860.684055536379, 4873.439554451142], "value": 4620.2912494520215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5649932537972, 577.8468705792966, 581.5463938128262, 583.0991118721574, 599.0983569727559, 29254.707452925464, 42826.14347713044, 44872.55127448725, 45068.774656126756, 45135.774321128345, 39435.0, 39516.60483395165, 39894.8005259974, 40020.0, 40070.79964600173, 7415.777526674208, 7545.5849928254065, 7780.961095194516, 7788.649510772, 10103.797924041515, 9808.50957452128, 10180.23648226386, 10182.083612474877, 10182.745431364201, 10183.083522482975, 10151.035651613121, 10244.795104097913, 10246.692599221999, 10254.282200245985, 10258.743531411737, 7407.74072907451, 9845.60617575296, 10107.090361867431, 10182.032706892833, 10191.133753630951, 9959.15347195482, 10046.497675116216, 10048.547815348327, 10050.64822731201, 10053.0, 39352.60647393518, 39408.802955985324, 39513.604863951565, 39603.0, 39650.0, 2934.2370983544433, 3187.474066778979, 3230.3862266169353, 3741.8690345838036, 3761.2289480656673, 29438.70561294381, 29714.702852971408, 29858.850705746332, 30011.249718756986, 30889.691103088906, 3261.8858339957987, 3265.1673823175174, 3267.738580913521, 3307.057488615733, 3328.7170590499595, 254859.0, 255069.0, 256000.0, 256238.71880640663, 257233.0, 28755.28111797222, 29251.268718281786, 55764.0, 56317.43682563204, 56485.71757141188, 34690.30619387598, 34732.82633586816, 34774.65225347714, 34865.65134348624, 34939.65060349415, 13225.470981160839, 13300.866991329964, 13304.13523120994, 13320.200787952754, 13321.200727956353, 9714.077162669535, 10831.0, 11026.503807328689, 11051.447427628586, 11250.49372778227, 7753.728619498291, 7785.766427007199, 7837.568933708587, 7839.25527074927, 7850.489718168301, 3077.3691393264326, 3136.670649581761, 3161.5099659552807, 3169.019362898189, 3173.2066983254185, 876.4741155306892, 909.8453262945316, 971.6453494474607, 980.8083178937625, 1051.51104736298, 27167.82657387404, 27519.17442476729, 28602.284942876595, 29317.706822931923, 29911.0, 959.8176346494143, 981.4847205217176, 994.7811481474064, 1011.4689787861284, 1086.8369744538381, 14303.427862885368, 14774.704505909822, 14890.0, 14958.177300248592, 15019.77470337924, 376686.0, 384097.0, 384638.0, 385090.0, 385816.0, 49364.0, 49772.50227497679, 49778.25332620014, 49795.50204497981, 49798.0, 1111.8165502692127, 1137.419915842926, 1198.2391181599573, 1220.2251570252777, 1262.1165184370977, 26468.205953821416, 28368.0, 28418.71581284161, 29209.269768255963, 29403.55894661539, 41754.37368439415, 42054.52809151665, 42501.1499770009, 42611.0, 42616.360754589325, 311319.0, 313580.0, 313900.0, 314317.0, 314328.0, 22106.33680989573, 24684.38289042788, 25155.24534263975, 25521.361965951, 25664.743352566235, 41278.38082428706, 41698.1660366797, 42151.156976859675, 42257.366139508544, 42874.571254288305, 35469.0, 36140.63859361373, 36574.0, 36597.0, 36833.44749828701, 35217.64782352144, 35487.0, 35691.64308356883, 36050.819745901106, 36138.0, 34935.12662183364, 35509.467357990165, 35769.46345804763, 35852.82073589615, 36007.27985440329, 28625.856870715514, 29776.85111574428, 30080.81099786375, 30153.246168845955, 30174.2456438582, 24410.633840492053, 24538.50922981566, 24947.126850560144, 24963.341833057264, 24986.81919920418], "value": 16941.642996583592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.0986623574828, 369.55468660264376, 370.2945888083201, 374.76202611341824, 383.31195504070206, 15862.444814431497, 15981.121038342886, 16257.430989915356, 17092.743608845863, 17447.563810904718, 15748.685026299467, 16164.75752863708, 16763.413280535184, 16775.91612041941, 16784.160791960414, 4935.407751069876, 5020.548150666439, 5021.949780502185, 5088.796448142089, 5100.0, 3655.4516822476576, 3837.3860182370827, 4938.654294199408, 5604.215409842625, 5892.646441213519, 5910.083936989773, 5911.556633252501, 5952.70236488176, 5957.851053723648, 5964.0, 5758.3090029196765, 5802.245708057946, 5831.446012628793, 5846.473817356458, 5913.2608423947, 3300.3729291434793, 4739.976300118477, 5072.137736584753, 5080.034793389244, 5205.869853253661, 18859.622807543772, 19315.4205373839, 19341.51646208856, 19955.401337959884, 19963.80036199634, 1845.6031953130007, 1850.380122658911, 1867.5797945462161, 1870.0743132149537, 1881.5296175956012, 12575.0, 12749.298788566624, 12826.486940522367, 13045.804312935314, 13322.400491977884, 1707.1464267866068, 1745.7468667043336, 1753.3863147898262, 1753.544078539576, 1802.2971041293774, 68968.24127034913, 69239.99999999949, 69596.6520167401, 69622.65188674025, 70276.29723702748, 9109.726708198765, 9211.30915181364, 9469.431834089977, 9538.189253913357, 9753.512324383895, 13474.52839150625, 13578.864211357957, 13583.864161358457, 13595.660108497168, 13620.863791361959, 7015.754448594274, 7093.503454758221, 7170.92829071713, 7181.619212280505, 7249.0, 6704.229013663394, 6806.931930680729, 6880.793576192722, 6882.621455819978, 6888.724451022003, 5991.281046274475, 6155.938440615626, 6158.261008678897, 6171.876562468815, 6198.597091189058, 1630.478246960961, 1703.4719237036559, 1767.8320559546823, 1776.8933863968202, 1783.6967715488397, 874.8643960186181, 903.7519096843411, 1005.3163848583034, 1006.9093781559695, 1014.4674046125843, 16328.591785205464, 16643.41748038813, 16646.08446535428, 16828.411005614744, 17075.573110672332, 885.4775682347317, 886.6719313853915, 889.7108439756976, 914.2777206007313, 917.6100157433065, 9162.450252984841, 9619.51902404877, 9643.228541716646, 9669.180733469007, 9741.610335586638, 374898.0, 375891.0, 376868.0, 381592.0, 388507.0, 66161.6691916547, 66866.0, 68206.65896670485, 70654.29345706478, 70751.64624176847, 939.2204470289644, 941.1435593609782, 961.7162936933761, 963.942163470194, 970.2480577552312, 9429.905700943178, 10057.748556285858, 14718.116912985255, 14766.234610174766, 15246.313915874034, 31370.843145784125, 36641.633583663825, 37107.814460927526, 37870.62129378781, 39564.80217598894, 45071.32393014042, 47679.0, 48545.5145448541, 50532.0, 51629.48370516247, 11501.597444089417, 11694.356810375171, 11793.115516336138, 11801.881981180422, 11890.524379025088, 12634.620961371174, 12659.493620255087, 12742.745145097231, 12911.289879056367, 12940.611781646565, 10384.951662461654, 10469.581216751245, 10496.370217786956, 10507.900169450184, 10571.418571978307, 10569.894301056891, 10656.724921164074, 10982.560697572007, 11098.61154859576, 11196.272242304223, 10615.840762388416, 10716.517756701123, 10878.891211087788, 10886.23796334249, 10999.120070394189, 11118.888811112109, 11592.942035289769, 11600.30398176112, 11685.240459370114, 11780.410979451164, 10512.474376281309, 10694.946525267324, 10721.624743133953, 10772.299800512941, 10832.0], "value": 8484.621524993714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.3698058519271, 1389.4789453954768, 1454.0693955868246, 1559.407425178432, 1735.8871673341223, 6782.321767823215, 7417.666205020773, 7658.6553605087765, 7661.4253930955265, 7666.808329791751, 7428.962855185717, 7659.425543084277, 7666.0, 7840.294373506384, 7842.0, 1845.317232623931, 1910.512819231101, 1911.2928216559892, 2210.4363387336207, 2267.183813827021, 1908.351160605394, 2129.371835308588, 2242.854214476054, 2244.6969659095976, 2260.367097212783, 2176.1621775616422, 2192.375173075674, 2197.505561248722, 2198.7251593550805, 2199.967000494994, 1820.0535721424917, 2153.6446486329814, 2161.7838216178416, 2162.329677799887, 2163.210428193706, 2115.851890367675, 2196.978030219693, 2198.1317379634957, 2210.281658461007, 2211.2150186683657, 7634.923650763477, 7655.196204398514, 7664.540127592307, 7679.769606911802, 7700.884486732703, 4510.548945105496, 4637.536246375369, 4637.907241855178, 4640.373549570832, 4647.88380290492, 2789.693133755285, 2874.3245337345707, 2899.1882272963603, 2912.0390271210663, 2954.0989998050586, 915.9587818548181, 916.7983043730369, 922.3635691372931, 940.5485367023798, 950.12588418655, 10568.735781605445, 10850.186236032328, 10851.131909447226, 10865.130789536817, 10898.182636302308, 4285.485741711014, 4290.227759003409, 4387.846425375096, 4395.252807022814, 4401.207782599163, 9322.161005509537, 9345.392549484397, 9349.252059835197, 9356.438613683065, 9360.4383736976, 4734.786934587883, 4736.573708366263, 4740.597049250852, 4744.288356746516, 4744.59670927975, 3618.873339433107, 3800.4299355096955, 3980.960190398117, 4075.653569446571, 4080.755154690728, 3639.5086663300117, 3751.549814022335, 3805.5813860475328, 3826.1964987352967, 3831.923361532754, 1164.3770582738364, 1184.6150001249628, 1188.2514016169757, 1197.5688752049255, 1197.8442802435627, 659.2319947261386, 769.8960640313599, 805.0460204657383, 810.4812919731377, 815.4699445360563, 5259.579913423431, 5320.334958130234, 5335.62650614461, 5507.504324610804, 5520.089185284463, 408.15104582468393, 410.3905700035445, 415.0971636690187, 423.5214207945002, 427.8010725012884, 3442.913927151791, 3529.1131933697134, 3736.252749450121, 3745.1198968242443, 3763.983724394453, 9424.340296179202, 9651.71044868655, 9748.073932976356, 9755.317127800985, 9766.218702503782, 9606.135447809731, 9717.17404020652, 9736.513174341255, 9750.658726944523, 9787.314887957917, 7155.141383034069, 7168.641567921583, 7297.124345078624, 7313.524620899624, 7318.268173182639, 4920.505746213873, 5054.4692807254705, 5079.92380114306, 5114.539691427789, 5213.791448342024, 8737.956310218407, 8855.91144088551, 8898.822023559364, 9015.14356136166, 9020.729378118667, 8932.19610235082, 8978.191962723386, 9107.043760405062, 9130.497822619554, 9192.448453092837, 5867.501262392574, 6193.380661933951, 6334.8733025338315, 6498.772542960974, 6553.344665533408, 7424.665890035069, 7447.702091916262, 7461.552306861606, 7519.8496030077995, 7526.172121066569, 6507.381798729113, 6681.365270299314, 6791.3548212919695, 6835.453163746789, 6932.688029038604, 6702.597844129368, 6728.7308507659145, 6766.458683305422, 6822.420094292041, 6886.10480637514, 5678.574106942078, 5679.659220446786, 5744.798932037359, 5767.134929760569, 5769.278840144982, 4479.216137176047, 4543.250363689954, 4556.2254416748565, 4575.450945886515, 4645.187092258909, 4155.735124357293, 4389.4513185851765, 4472.932906006347, 4546.045330480636, 4576.977115114403], "value": 4019.5172670146903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1587974273321, 295.7146353768613, 300.75187969924815, 302.8909592546683, 307.5432982021698, 4728.929066064012, 4823.638227132961, 4830.227163653816, 4843.927341089887, 4861.6353773467, 4751.5010923853015, 4755.262934245189, 4760.857833829673, 4785.234362502, 4788.970371370155, 3581.3016461790025, 3600.6759391654746, 3696.7781933083966, 3734.9253014939686, 3768.3970564709653, 3718.1634132320282, 3742.9625703743022, 3747.2692824899154, 3770.5852356240794, 3779.1496913194587, 3558.8754393596228, 3726.049857286388, 3732.1602639406187, 3749.9437508437395, 3753.474513568103, 3633.2370202257557, 3701.5743189533146, 3728.6457786510236, 3734.9439758403646, 3777.6411240932066, 3330.134165117087, 3330.533725278463, 3342.2647017656077, 3352.0614228016193, 3353.5351516635255, 4523.886902827423, 4526.388937493462, 4533.773311334453, 4540.523245059254, 4557.225271703818, 4051.6556092732153, 4307.440032795748, 4309.159713855799, 4311.461067366579, 4333.9133217335475, 4970.4650628179525, 4973.477784832613, 4984.750762461862, 4989.875253118665, 4989.954118811306, 3624.746267761258, 3630.3646861799343, 3636.4181730922924, 3642.307961487309, 3642.597599924048, 4946.985867897109, 5167.948320516784, 5189.0, 5210.218467229908, 5214.634975551713, 3713.9814300928324, 3752.512173417438, 3753.5871054184017, 3779.111908701453, 3807.3717836556657, 3856.9228615428096, 3860.4209368594934, 3870.59358767331, 3906.6679332257077, 3909.4331321958157, 4350.71720338177, 4351.369051487517, 4358.607725304738, 4369.186787483159, 4374.518802931675, 4808.422989241313, 4994.175960966472, 4999.925001124986, 5002.674826136362, 5012.273220383024, 1304.5955753716378, 1330.4079684540286, 1331.4807225182187, 1340.611222745393, 1342.3355439057534, 867.7526904832092, 874.2568816505919, 898.492351821232, 915.81121120522, 927.7938679716342, 4421.513633500313, 4430.847979525347, 4441.911161776747, 4459.821607135678, 4466.151431228056, 5075.3402057732255, 5080.526647272323, 5097.337346145052, 5112.565431938253, 5130.9738052389675, 4200.0, 4361.542038086019, 4377.781110944504, 4419.071994881111, 4446.866594002185, 2675.331167208198, 2684.302081458835, 2686.1672881406826, 2693.5151672699103, 2710.0108460412202, 4780.11567859947, 4788.449328327287, 4788.640851936049, 4794.5924596409695, 4807.18277892759, 4989.525995030466, 5136.794528218904, 5159.380874295109, 5169.751158246175, 5294.0, 4895.363602731622, 4911.45973942866, 4913.975430122827, 4915.729634869974, 4929.802807887716, 5171.586273098218, 5178.275041494269, 5179.948200517946, 5182.352205974254, 5192.221166825007, 4847.636427267898, 5064.518870707277, 5069.138246498031, 5075.213341932006, 5100.974495127501, 4843.176659967884, 4906.337644417958, 4907.5828554571835, 4914.827981020647, 4918.4343800461975, 3625.528681271418, 3634.7637403569743, 3635.636436356343, 3645.8906232813056, 3663.7435379523176, 4931.876703082452, 5188.58491320701, 5189.92215116766, 5258.605604579749, 5262.500062494057, 5011.123053465702, 5029.0, 5029.396472423333, 5056.165732654071, 5060.139776238122, 5030.723310217827, 5033.0, 5055.949440505695, 5060.443351231435, 5060.721660308571, 4819.3012013258585, 4931.926021109614, 4933.827316044065, 4944.085344211332, 4969.304297398295, 4806.951930480651, 4868.245421959602, 5038.848834534823, 5047.217681259411, 5057.721825299644, 4926.359573255454, 4943.8516844494725, 4969.353983982204, 4974.204127339608, 4976.875578110431], "value": 3795.0278408496265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.5548144039892, 687.7352219395533, 723.6598798564676, 735.819724167579, 736.5433431272612, 11980.700482487931, 12395.070369722273, 12496.250224986507, 12520.311382873939, 12523.624291271253, 12020.939895300533, 13093.54172603959, 13094.148880322773, 13109.344532773372, 13120.6719832004, 616.6454288783945, 762.9656665450068, 783.5690370296343, 795.3080819686852, 796.3867821777228, 797.696875187428, 801.519088546873, 805.1505661527086, 805.4200975297776, 805.5649949027518, 838.3083955736512, 839.9832003359929, 840.5965136734371, 841.0118111219293, 841.2218697704599, 655.9048937904001, 671.8958561422987, 672.4385138409409, 673.9696713647849, 837.4472847920374, 587.0988033368801, 601.4346514276566, 605.503487140545, 605.5549171359047, 607.7568972411071, 12997.415116319788, 13064.542741004114, 13067.607971760863, 13092.0, 13093.345332733325, 12436.316002619853, 12855.74288514234, 12897.2906490143, 13047.54333598329, 13065.331649587957, 11345.0, 11381.317120972686, 11445.370504622242, 11585.18903676743, 11730.472128754227, 4157.584241575849, 4177.3316269397055, 4231.724937879058, 4356.43366362374, 4364.629006534448, 56060.439395606336, 56274.15588766172, 56397.0, 56492.435075649126, 56764.0, 10126.898731012743, 10307.84538231927, 10315.484225788681, 10608.893911060944, 10843.1867609928, 19068.427947161606, 19177.904110479358, 19184.80815191858, 19204.423867284004, 19207.32774352891, 6595.505337099737, 6636.402723754885, 6739.056532085512, 6772.187337519431, 6787.864242715118, 3553.093961039918, 3615.5661320641166, 3656.926861462756, 3757.0, 3772.1512659651908, 2772.334639686501, 2867.498187817165, 2871.5692646102834, 2877.0649538899943, 2877.453283876057, 512.3825789923134, 512.6360284198261, 519.1952473665802, 522.0472637436693, 524.520064141314, 441.12436812926313, 470.3109943932088, 485.3496314938, 523.5419008367678, 532.3736727835101, 7628.656710448043, 7629.7329593463965, 7691.769246922601, 7723.150453450116, 7858.292753652085, 417.67212738000524, 460.0, 465.734531317146, 520.10541867987, 526.2211926349025, 3603.85584576614, 3645.981770091186, 3694.0395497170393, 3717.8512859485318, 3770.359038963383, 83618.0, 84563.0, 88021.55989220012, 89245.0, 89805.55097224603, 50265.0, 71877.64061179661, 80126.0, 80303.59848200722, 80366.0, 45556.54443455589, 52210.477895221324, 71590.0, 71708.0, 72165.0, 6676.455605166131, 6863.176418829772, 6969.612489545678, 6994.160700715946, 7025.2272250053475, 43068.28552156509, 43395.56604434041, 44066.0, 44341.77829110834, 45339.31991020071, 58030.4196958025, 61118.0, 61278.693606531684, 61623.383766161765, 61874.38125618686, 9059.456432614064, 9225.07749225072, 9425.151736343762, 9501.144896959308, 9648.614055437985, 9082.619727243968, 9492.95253523728, 9581.137697607248, 9614.9038509614, 9691.563879625293, 7753.961230193813, 8047.718329858427, 9174.075121985003, 9270.53647317645, 9713.805723885624, 10719.839202412126, 11208.719782005515, 11250.268732532359, 11472.541098356307, 11474.368909709712, 9991.800163996824, 10279.691609251735, 10516.68449946503, 10635.308704934154, 10874.0, 9330.346875718635, 9442.52787360643, 9515.857262141211, 9633.470159141314, 10073.244506661884, 8964.462132272085, 9182.540872956459, 9346.719598412059, 9538.332316737762, 9712.9028709712], "value": 6197.260835334879, "unit": "score"}], "name": "dromaeo_css", "value": 6304.480994972343, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 115.0, 112.0, 115.0, 113.0, 113.0, 113.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 135.0, 204.0, 130.0, 131.0, 159.0, 134.0, 186.0, 132.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 162.0, 164.0, 163.0, 161.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 77.0, 77.0, 75.0, 82.0, 101.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 86.0, 86.0, 87.0, 123.0, 86.0, 85.0, 129.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0, 63.0, 64.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 66.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 83.0, 85.0, 85.0, 85.0, 90.0, 124.0, 90.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 136.0, 131.0, 133.0, 131.0, 130.0, 144.0, 138.0, 132.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 170.0, 167.0, 167.0, 166.0, 175.0, 167.0, 170.0, 164.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 69.0, 67.0, 66.0, 67.0, 66.0, 65.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1549.6000000000001, "alertThreshold": 2.0}]} 08:24:09 INFO - Return code: 0 08:24:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:09 ERROR - # TBPL SUCCESS # 08:24:09 INFO - Running post-action listener: _resource_record_post_action 08:24:09 INFO - ##### 08:24:09 INFO - ##### Finished run-tests step (success) 08:24:09 INFO - ##### 08:24:09 INFO - Running post-run listener: _resource_record_post_run 08:24:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 524853248; Read time: 88; Write time: 386208 08:24:09 INFO - TinderboxPrint: CPU usage
13.1% 08:24:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 08:24:09 INFO - TinderboxPrint: I/O write bytes / time
524,853,248 / 386,208 08:24:09 INFO - TinderboxPrint: CPU idle
8,332.8 (86.9%) 08:24:09 INFO - TinderboxPrint: CPU user
1,212.4 (12.6%) 08:24:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237883392; Read time: 0; Write time: 182176 08:24:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286969856; Read time: 88; Write time: 204032 08:24:10 INFO - Running post-run listener: _upload_blobber_files 08:24:10 INFO - Blob upload gear active. 08:24:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:10 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 08:24:10 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:10 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:11 INFO - (blobuploader) - INFO - Done attempting. 08:24:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:12 INFO - (blobuploader) - INFO - Done attempting. 08:24:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:16 INFO - (blobuploader) - INFO - Done attempting. 08:24:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:16 INFO - Return code: 0 08:24:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5294636620fe8e4840814010de6d5f8c560878c198b6b32420dacd906b9d0f5f6578847f3b16e0656f7b9e0965264f55045fe4e6ec37ea3620887c0095402ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/305911d9f80be7bbfbe4f57f5f9a27bda94f22e93c4206fb936660b45d7f924e7140f453fa4059040aa581869b59b2798552f750719b36a91fe98594dedf504c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96298ce7af45333cd0fdc427fec583b4f63d171e1b41901154eb2eda30164096258972341e623ca0d2bf7e706618bf42396f3bfddaadbdcd0a80cc42297489fa"} 08:24:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:16 INFO - Contents: 08:24:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5294636620fe8e4840814010de6d5f8c560878c198b6b32420dacd906b9d0f5f6578847f3b16e0656f7b9e0965264f55045fe4e6ec37ea3620887c0095402ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/305911d9f80be7bbfbe4f57f5f9a27bda94f22e93c4206fb936660b45d7f924e7140f453fa4059040aa581869b59b2798552f750719b36a91fe98594dedf504c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96298ce7af45333cd0fdc427fec583b4f63d171e1b41901154eb2eda30164096258972341e623ca0d2bf7e706618bf42396f3bfddaadbdcd0a80cc42297489fa"} 08:24:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:16 INFO - Copying logs to upload dir... 08:24:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.882423 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-08 08:24:16.668393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 08:24:16.672001) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5294636620fe8e4840814010de6d5f8c560878c198b6b32420dacd906b9d0f5f6578847f3b16e0656f7b9e0965264f55045fe4e6ec37ea3620887c0095402ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/305911d9f80be7bbfbe4f57f5f9a27bda94f22e93c4206fb936660b45d7f924e7140f453fa4059040aa581869b59b2798552f750719b36a91fe98594dedf504c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96298ce7af45333cd0fdc427fec583b4f63d171e1b41901154eb2eda30164096258972341e623ca0d2bf7e706618bf42396f3bfddaadbdcd0a80cc42297489fa"} build_url:https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/YtxyNPKvQQy93TeyJwwJlw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5294636620fe8e4840814010de6d5f8c560878c198b6b32420dacd906b9d0f5f6578847f3b16e0656f7b9e0965264f55045fe4e6ec37ea3620887c0095402ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/305911d9f80be7bbfbe4f57f5f9a27bda94f22e93c4206fb936660b45d7f924e7140f453fa4059040aa581869b59b2798552f750719b36a91fe98594dedf504c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96298ce7af45333cd0fdc427fec583b4f63d171e1b41901154eb2eda30164096258972341e623ca0d2bf7e706618bf42396f3bfddaadbdcd0a80cc42297489fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 08:24:16.697901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:24:16.698252) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465397592.484840-547417654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:24:16.784941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 08:24:16.785787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 08:24:16.786834) ========= ========= Total master_lag: 0.21 =========