builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1465386128.09 results: success (0) buildid: 20160608031630 builduid: 9df1d66eec014e0ca44e938bc0662ec6 revision: 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.087168) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.087601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.087871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.108425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.108800) ========= 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=4300f881736b422476174874000001bc-1465386127.545686-852107915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 04:42:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-08 04:42:08 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.218274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.221448) ========= 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=4300f881736b422476174874000001bc-1465386127.545686-852107915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.271095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:08.271446) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a --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 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a --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=4300f881736b422476174874000001bc-1465386127.545686-852107915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 04:42:08,702 truncating revision to first 12 chars 2016-06-08 04:42:08,702 Setting DEBUG logging. 2016-06-08 04:42:08,702 attempt 1/10 2016-06-08 04:42:08,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81f4cc3f6f4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 04:42:09,186 unpacking tar archive at: fx-team-81f4cc3f6f4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:09.159823) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:09.160601) ========= script_repo_revision: 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:09.161401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:09.165729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:42:09.176026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-08 04:42:09.176313) ========= /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=4300f881736b422476174874000001bc-1465386127.545686-852107915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:42:09 INFO - MultiFileLogger online at 20160608 04:42:09 in /builds/slave/test 04:42:09 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 04:42:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:09 INFO - {'append_to_log': False, 04:42:09 INFO - 'base_work_dir': '/builds/slave/test', 04:42:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:42:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:09 INFO - 'branch': 'Fx-Team-Non-PGO', 04:42:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:09 INFO - 'config_files': ('talos/linux_config.py',), 04:42:09 INFO - 'default_actions': ('clobber', 04:42:09 INFO - 'read-buildbot-config', 04:42:09 INFO - 'download-and-extract', 04:42:09 INFO - 'populate-webroot', 04:42:09 INFO - 'create-virtualenv', 04:42:09 INFO - 'install', 04:42:09 INFO - 'run-tests'), 04:42:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:09 INFO - 'download_minidump_stackwalk': True, 04:42:09 INFO - 'download_symbols': 'ondemand', 04:42:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:09 INFO - 'installer_path': 'installer.exe', 04:42:09 INFO - 'log_level': 'info', 04:42:09 INFO - 'log_name': 'talos', 04:42:09 INFO - 'log_to_console': True, 04:42:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:42:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:42:09 INFO - 'opt_config_files': (), 04:42:09 INFO - 'pip_index': False, 04:42:09 INFO - 'sps_profile': False, 04:42:09 INFO - 'sps_profile_interval': 0, 04:42:09 INFO - 'suite': 'dromaeojs', 04:42:09 INFO - 'system_bits': '32', 04:42:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:09 INFO - 'title': 'talos-linux64-ix-045', 04:42:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:09 INFO - 'use_talos_json': True, 04:42:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:09 INFO - 'work_dir': 'build'} 04:42:09 INFO - ##### 04:42:09 INFO - ##### Running clobber step. 04:42:09 INFO - ##### 04:42:09 INFO - Running pre-action listener: _resource_record_pre_action 04:42:09 INFO - Running main action method: clobber 04:42:09 INFO - rmtree: /builds/slave/test/build 04:42:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:10 INFO - Running post-action listener: _resource_record_post_action 04:42:10 INFO - ##### 04:42:10 INFO - ##### Finished clobber step (success) 04:42:10 INFO - ##### 04:42:10 INFO - ##### 04:42:10 INFO - ##### Running read-buildbot-config step. 04:42:10 INFO - ##### 04:42:10 INFO - Running pre-action listener: _resource_record_pre_action 04:42:10 INFO - Running main action method: read_buildbot_config 04:42:10 INFO - Using buildbot properties: 04:42:10 INFO - { 04:42:10 INFO - "project": "", 04:42:10 INFO - "product": "firefox", 04:42:10 INFO - "script_repo_revision": "production", 04:42:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:42:10 INFO - "repository": "", 04:42:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:42:10 INFO - "buildid": "20160608031630", 04:42:10 INFO - "pgo_build": "False", 04:42:10 INFO - "basedir": "/builds/slave/test", 04:42:10 INFO - "buildnumber": 3059, 04:42:10 INFO - "slavename": "talos-linux64-ix-045", 04:42:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:42:10 INFO - "platform": "ubuntu64_hw", 04:42:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:42:10 INFO - "branch": "fx-team", 04:42:10 INFO - "repo_path": "integration/fx-team", 04:42:10 INFO - "revision": "81f4cc3f6f4c21758b63605d69b47fa6cb3c142a", 04:42:10 INFO - "stage_platform": "linux64", 04:42:10 INFO - "builduid": "9df1d66eec014e0ca44e938bc0662ec6", 04:42:10 INFO - "slavebuilddir": "test" 04:42:10 INFO - } 04:42:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:42:10 INFO - Running post-action listener: _resource_record_post_action 04:42:10 INFO - ##### 04:42:10 INFO - ##### Finished read-buildbot-config step (success) 04:42:10 INFO - ##### 04:42:10 INFO - ##### 04:42:10 INFO - ##### Running download-and-extract step. 04:42:10 INFO - ##### 04:42:10 INFO - Running pre-action listener: _resource_record_pre_action 04:42:10 INFO - Running main action method: download_and_extract 04:42:10 INFO - mkdir: /builds/slave/test/build/tests 04:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:10 INFO - https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:11 INFO - Downloaded 1361 bytes. 04:42:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:42:11 INFO - Using the following test package requirements: 04:42:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:42:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:42:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:42:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'jsshell-linux-x86_64.zip'], 04:42:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:42:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:42:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:42:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:42:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:42:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:42:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:42:11 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')]} 04:42:11 INFO - https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:12 INFO - Downloaded 22878197 bytes. 04:42:12 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'] 04:42:12 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 04:42:13 INFO - Return code: 0 04:42:13 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 04:42:13 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')]} 04:42:13 INFO - https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:15 INFO - Downloaded 22878197 bytes. 04:42:15 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'] 04:42:15 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 04:42:16 INFO - Return code: 0 04:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:16 INFO - https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:17 INFO - Downloaded 10833369 bytes. 04:42:17 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'] 04:42:17 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 04:42:17 INFO - Return code: 0 04:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:17 INFO - https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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 04:42:19 INFO - Downloaded 55302443 bytes. 04:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:42:19 INFO - mkdir: /builds/slave/test/properties 04:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:19 INFO - Contents: 04:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:42:20 INFO - Running post-action listener: _resource_record_post_action 04:42:20 INFO - Running post-action listener: set_extra_try_arguments 04:42:20 INFO - ##### 04:42:20 INFO - ##### Finished download-and-extract step (success) 04:42:20 INFO - ##### 04:42:20 INFO - ##### 04:42:20 INFO - ##### Running populate-webroot step. 04:42:20 INFO - ##### 04:42:20 INFO - Running pre-action listener: _resource_record_pre_action 04:42:20 INFO - Running main action method: populate_webroot 04:42:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:20 INFO - '--tppagecycles', 04:42:20 INFO - '7'], 04:42:20 INFO - 'tests': ['tsvgm']}}, 04:42:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['damp', 'tps']}, 04:42:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'tests': ['damp', 'tps']}, 04:42:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['dromaeo_dom']}, 04:42:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['a11yr', 04:42:20 INFO - 'ts_paint', 04:42:20 INFO - 'tpaint', 04:42:20 INFO - 'sessionrestore', 04:42:20 INFO - 'sessionrestore_no_auto_restore', 04:42:20 INFO - 'tabpaint']}, 04:42:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['tsvgx', 04:42:20 INFO - 'tsvgr_opacity', 04:42:20 INFO - 'tart', 04:42:20 INFO - 'tscrollx', 04:42:20 INFO - 'cart']}, 04:42:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:20 INFO - 'tsvgr_opacity', 04:42:20 INFO - 'tart', 04:42:20 INFO - 'tscrollx', 04:42:20 INFO - 'cart']}, 04:42:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'talos_options': ['--disable-e10s'], 04:42:20 INFO - 'tests': ['tp5o']}, 04:42:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'tests': ['tp5o']}, 04:42:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'talos_options': ['--disable-e10s', 04:42:20 INFO - '--xperf_path', 04:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:20 INFO - 'tests': ['tp5n']}, 04:42:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:20 INFO - 'talos_options': ['--xperf_path', 04:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:20 INFO - 'tests': ['tp5n']}}, 04:42:20 INFO - 'talos.zip': {'path': '', 04:42:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:20 INFO - Running post-action listener: _resource_record_post_action 04:42:20 INFO - ##### 04:42:20 INFO - ##### Finished populate-webroot step (success) 04:42:20 INFO - ##### 04:42:20 INFO - ##### 04:42:20 INFO - ##### Running create-virtualenv step. 04:42:20 INFO - ##### 04:42:20 INFO - Running pre-action listener: _resource_record_pre_action 04:42:20 INFO - Running main action method: create_virtualenv 04:42:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:20 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 04:42:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:20 INFO - Using real prefix '/usr' 04:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:22 INFO - Installing pip.................done. 04:42:22 INFO - Return code: 0 04:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:22 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')]} 04:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 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')]} 04:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:22 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 04:42:22 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 04:42:22 INFO - Using env: {'DISPLAY': ':0', 04:42:22 INFO - 'HOME': '/home/cltbld', 04:42:22 INFO - 'LANG': 'en_US.UTF-8', 04:42:22 INFO - 'LANGUAGE': 'en_US:en', 04:42:22 INFO - 'LOGNAME': 'cltbld', 04:42:22 INFO - 'MAIL': '/var/mail/cltbld', 04:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:22 INFO - 'MOZ_NO_REMOTE': '1', 04:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:22 INFO - 'NO_EM_RESTART': '1', 04:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:22 INFO - 'PWD': '/builds/slave/test', 04:42:22 INFO - 'SHELL': '/bin/bash', 04:42:22 INFO - 'SHLVL': '1', 04:42:22 INFO - 'TERM': 'linux', 04:42:22 INFO - 'TMOUT': '86400', 04:42:22 INFO - 'USER': 'cltbld', 04:42:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:22 INFO - '_': '/tools/buildbot/bin/python'} 04:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:22 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 04:42:22 INFO - Cleaning up... 04:42:23 INFO - Return code: 0 04:42:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:23 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:23 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 04:42:23 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 04:42:23 INFO - Using env: {'DISPLAY': ':0', 04:42:23 INFO - 'HOME': '/home/cltbld', 04:42:23 INFO - 'LANG': 'en_US.UTF-8', 04:42:23 INFO - 'LANGUAGE': 'en_US:en', 04:42:23 INFO - 'LOGNAME': 'cltbld', 04:42:23 INFO - 'MAIL': '/var/mail/cltbld', 04:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:23 INFO - 'MOZ_NO_REMOTE': '1', 04:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:23 INFO - 'NO_EM_RESTART': '1', 04:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:23 INFO - 'PWD': '/builds/slave/test', 04:42:23 INFO - 'SHELL': '/bin/bash', 04:42:23 INFO - 'SHLVL': '1', 04:42:23 INFO - 'TERM': 'linux', 04:42:23 INFO - 'TMOUT': '86400', 04:42:23 INFO - 'USER': 'cltbld', 04:42:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:23 INFO - '_': '/tools/buildbot/bin/python'} 04:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:23 INFO - Downloading/unpacking psutil>=3.1.1 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 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 04:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:25 INFO - Installing collected packages: psutil 04:42:25 INFO - Running setup.py install for psutil 04:42:25 INFO - building 'psutil._psutil_linux' extension 04:42:25 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 04:42:25 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 04:42:25 INFO - building 'psutil._psutil_posix' extension 04:42:25 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 04:42:25 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 04:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:25 INFO - Successfully installed psutil 04:42:25 INFO - Cleaning up... 04:42:25 INFO - Return code: 0 04:42:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:25 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')]} 04:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:25 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')]} 04:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:25 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:25 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 04:42:25 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 04:42:25 INFO - Using env: {'DISPLAY': ':0', 04:42:25 INFO - 'HOME': '/home/cltbld', 04:42:25 INFO - 'LANG': 'en_US.UTF-8', 04:42:25 INFO - 'LANGUAGE': 'en_US:en', 04:42:25 INFO - 'LOGNAME': 'cltbld', 04:42:25 INFO - 'MAIL': '/var/mail/cltbld', 04:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:25 INFO - 'MOZ_NO_REMOTE': '1', 04:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:25 INFO - 'NO_EM_RESTART': '1', 04:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:25 INFO - 'PWD': '/builds/slave/test', 04:42:25 INFO - 'SHELL': '/bin/bash', 04:42:25 INFO - 'SHLVL': '1', 04:42:25 INFO - 'TERM': 'linux', 04:42:25 INFO - 'TMOUT': '86400', 04:42:25 INFO - 'USER': 'cltbld', 04:42:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:25 INFO - '_': '/tools/buildbot/bin/python'} 04:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:25 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 04:42:25 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 04:42:25 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 04:42:25 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 04:42:25 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 04:42:25 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 04:42:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:27 INFO - Installing collected packages: mozsystemmonitor 04:42:27 INFO - Running setup.py install for mozsystemmonitor 04:42:28 INFO - Successfully installed mozsystemmonitor 04:42:28 INFO - Cleaning up... 04:42:28 INFO - Return code: 0 04:42:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:28 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')]} 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 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')]} 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:28 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 04:42:28 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 04:42:28 INFO - Using env: {'DISPLAY': ':0', 04:42:28 INFO - 'HOME': '/home/cltbld', 04:42:28 INFO - 'LANG': 'en_US.UTF-8', 04:42:28 INFO - 'LANGUAGE': 'en_US:en', 04:42:28 INFO - 'LOGNAME': 'cltbld', 04:42:28 INFO - 'MAIL': '/var/mail/cltbld', 04:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:28 INFO - 'MOZ_NO_REMOTE': '1', 04:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:28 INFO - 'NO_EM_RESTART': '1', 04:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:28 INFO - 'PWD': '/builds/slave/test', 04:42:28 INFO - 'SHELL': '/bin/bash', 04:42:28 INFO - 'SHLVL': '1', 04:42:28 INFO - 'TERM': 'linux', 04:42:28 INFO - 'TMOUT': '86400', 04:42:28 INFO - 'USER': 'cltbld', 04:42:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:28 INFO - '_': '/tools/buildbot/bin/python'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:28 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 04:42:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:30 INFO - warning: no files found matching '*.txt' 04:42:30 INFO - no previously-included directories found matching 'build' 04:42:30 INFO - no previously-included directories found matching 'dist' 04:42:30 INFO - no previously-included directories found matching '.git*' 04:42:30 INFO - Installing collected packages: jsonschema, functools32 04:42:30 INFO - Running setup.py install for functools32 04:42:30 INFO - warning: no files found matching '*.txt' 04:42:30 INFO - no previously-included directories found matching 'build' 04:42:30 INFO - no previously-included directories found matching 'dist' 04:42:30 INFO - no previously-included directories found matching '.git*' 04:42:30 INFO - Successfully installed jsonschema functools32 04:42:30 INFO - Cleaning up... 04:42:30 INFO - Return code: 0 04:42:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:30 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')]} 04:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:30 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')]} 04:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:30 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:30 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 04:42:30 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 04:42:30 INFO - Using env: {'DISPLAY': ':0', 04:42:30 INFO - 'HOME': '/home/cltbld', 04:42:30 INFO - 'LANG': 'en_US.UTF-8', 04:42:30 INFO - 'LANGUAGE': 'en_US:en', 04:42:30 INFO - 'LOGNAME': 'cltbld', 04:42:30 INFO - 'MAIL': '/var/mail/cltbld', 04:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:30 INFO - 'MOZ_NO_REMOTE': '1', 04:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:30 INFO - 'NO_EM_RESTART': '1', 04:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:30 INFO - 'PWD': '/builds/slave/test', 04:42:30 INFO - 'SHELL': '/bin/bash', 04:42:30 INFO - 'SHLVL': '1', 04:42:30 INFO - 'TERM': 'linux', 04:42:30 INFO - 'TMOUT': '86400', 04:42:30 INFO - 'USER': 'cltbld', 04:42:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:30 INFO - '_': '/tools/buildbot/bin/python'} 04:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:30 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 04:42:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 INFO - Downloading docopt-0.6.1.tar.gz 04:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:33 INFO - Running setup.py install for blobuploader 04:42:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:33 INFO - Running setup.py install for requests 04:42:33 INFO - Running setup.py install for docopt 04:42:34 INFO - Successfully installed blobuploader requests docopt 04:42:34 INFO - Cleaning up... 04:42:34 INFO - Return code: 0 04:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:34 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:34 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 04:42:34 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 04:42:34 INFO - Using env: {'DISPLAY': ':0', 04:42:34 INFO - 'HOME': '/home/cltbld', 04:42:34 INFO - 'LANG': 'en_US.UTF-8', 04:42:34 INFO - 'LANGUAGE': 'en_US:en', 04:42:34 INFO - 'LOGNAME': 'cltbld', 04:42:34 INFO - 'MAIL': '/var/mail/cltbld', 04:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:34 INFO - 'MOZ_NO_REMOTE': '1', 04:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:34 INFO - 'NO_EM_RESTART': '1', 04:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:34 INFO - 'PWD': '/builds/slave/test', 04:42:34 INFO - 'SHELL': '/bin/bash', 04:42:34 INFO - 'SHLVL': '1', 04:42:34 INFO - 'TERM': 'linux', 04:42:34 INFO - 'TMOUT': '86400', 04:42:34 INFO - 'USER': 'cltbld', 04:42:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:34 INFO - '_': '/tools/buildbot/bin/python'} 04:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:34 INFO - Running setup.py (path:/tmp/pip-0iXrD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:34 INFO - Running setup.py (path:/tmp/pip-WAEh8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:34 INFO - Running setup.py (path:/tmp/pip-eq6DOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:34 INFO - Running setup.py (path:/tmp/pip-VPuxQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:34 INFO - Running setup.py (path:/tmp/pip-5K3SRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:34 INFO - Running setup.py (path:/tmp/pip-fA6eUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:34 INFO - Running setup.py (path:/tmp/pip-u1zYpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:34 INFO - Running setup.py (path:/tmp/pip-gtjV27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:34 INFO - Running setup.py (path:/tmp/pip-dfniYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:34 INFO - Running setup.py (path:/tmp/pip-6EfaOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:35 INFO - Running setup.py (path:/tmp/pip-OKNwer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:35 INFO - Running setup.py (path:/tmp/pip-_QyA3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:35 INFO - Running setup.py (path:/tmp/pip-SlJLgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:35 INFO - Running setup.py (path:/tmp/pip-IO8JX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:35 INFO - Running setup.py (path:/tmp/pip-TUXu18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:35 INFO - Running setup.py (path:/tmp/pip-PWX_IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:35 INFO - Running setup.py (path:/tmp/pip-FVFFCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:35 INFO - Running setup.py install for manifestparser 04:42:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:35 INFO - Running setup.py install for mozcrash 04:42:35 INFO - Running setup.py install for mozdebug 04:42:35 INFO - Running setup.py install for mozdevice 04:42:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:35 INFO - Running setup.py install for mozfile 04:42:36 INFO - Running setup.py install for mozhttpd 04:42:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for mozinfo 04:42:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for mozInstall 04:42:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for mozleak 04:42:36 INFO - Running setup.py install for mozlog 04:42:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for moznetwork 04:42:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for mozprocess 04:42:36 INFO - Running setup.py install for mozprofile 04:42:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:36 INFO - Running setup.py install for mozrunner 04:42:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:37 INFO - Running setup.py install for mozscreenshot 04:42:37 INFO - Running setup.py install for moztest 04:42:37 INFO - Running setup.py install for mozversion 04:42:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:37 INFO - Cleaning up... 04:42:37 INFO - Return code: 0 04:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:37 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:37 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 04:42:37 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 04:42:37 INFO - Using env: {'DISPLAY': ':0', 04:42:37 INFO - 'HOME': '/home/cltbld', 04:42:37 INFO - 'LANG': 'en_US.UTF-8', 04:42:37 INFO - 'LANGUAGE': 'en_US:en', 04:42:37 INFO - 'LOGNAME': 'cltbld', 04:42:37 INFO - 'MAIL': '/var/mail/cltbld', 04:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:37 INFO - 'MOZ_NO_REMOTE': '1', 04:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:37 INFO - 'NO_EM_RESTART': '1', 04:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:37 INFO - 'PWD': '/builds/slave/test', 04:42:37 INFO - 'SHELL': '/bin/bash', 04:42:37 INFO - 'SHLVL': '1', 04:42:37 INFO - 'TERM': 'linux', 04:42:37 INFO - 'TMOUT': '86400', 04:42:37 INFO - 'USER': 'cltbld', 04:42:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:37 INFO - '_': '/tools/buildbot/bin/python'} 04:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:37 INFO - Running setup.py (path:/tmp/pip-yLSlfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:37 INFO - Running setup.py (path:/tmp/pip-ZvJak9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:37 INFO - Running setup.py (path:/tmp/pip-KGXr30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:37 INFO - Running setup.py (path:/tmp/pip-eTaK_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:37 INFO - Running setup.py (path:/tmp/pip-Oeu8Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:37 INFO - Running setup.py (path:/tmp/pip-mBvprd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:37 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)) 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:37 INFO - Running setup.py (path:/tmp/pip-Kku_8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:38 INFO - Running setup.py (path:/tmp/pip-WaDt04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:38 INFO - Running setup.py (path:/tmp/pip-A_eIvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:38 INFO - Running setup.py (path:/tmp/pip-7DC0rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:38 INFO - Running setup.py (path:/tmp/pip-JI9oFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:38 INFO - Running setup.py (path:/tmp/pip-hpFbvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:38 INFO - Running setup.py (path:/tmp/pip-NoW_Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:38 INFO - Running setup.py (path:/tmp/pip-w7aaQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:38 INFO - Running setup.py (path:/tmp/pip-tA29IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:38 INFO - Running setup.py (path:/tmp/pip-XHH3b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:38 INFO - Running setup.py (path:/tmp/pip-BJLVWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:38 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)) 04:42:38 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)) 04:42:38 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)) 04:42:38 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)) 04:42:38 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)) 04:42:38 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)) 04:42:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:40 INFO - Downloading blessings-1.6.tar.gz 04:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:40 INFO - Installing collected packages: blessings 04:42:40 INFO - Running setup.py install for blessings 04:42:40 INFO - Successfully installed blessings 04:42:40 INFO - Cleaning up... 04:42:40 INFO - Return code: 0 04:42:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:41 INFO - Reading from file tmpfile_stdout 04:42:41 INFO - Current package versions: 04:42:41 INFO - argparse == 1.2.1 04:42:41 INFO - blessings == 1.6 04:42:41 INFO - blobuploader == 1.2.4 04:42:41 INFO - docopt == 0.6.1 04:42:41 INFO - functools32 == 3.2.3-2 04:42:41 INFO - jsonschema == 2.5.1 04:42:41 INFO - manifestparser == 1.1 04:42:41 INFO - mozInstall == 1.12 04:42:41 INFO - mozcrash == 0.17 04:42:41 INFO - mozdebug == 0.1 04:42:41 INFO - mozdevice == 0.48 04:42:41 INFO - mozfile == 1.2 04:42:41 INFO - mozhttpd == 0.7 04:42:41 INFO - mozinfo == 0.9 04:42:41 INFO - mozleak == 0.1 04:42:41 INFO - mozlog == 3.2 04:42:41 INFO - moznetwork == 0.27 04:42:41 INFO - mozprocess == 0.22 04:42:41 INFO - mozprofile == 0.28 04:42:41 INFO - mozrunner == 6.11 04:42:41 INFO - mozscreenshot == 0.1 04:42:41 INFO - mozsystemmonitor == 0.3 04:42:41 INFO - moztest == 0.7 04:42:41 INFO - mozversion == 1.4 04:42:41 INFO - psutil == 3.1.1 04:42:41 INFO - requests == 1.2.3 04:42:41 INFO - wsgiref == 0.1.2 04:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:41 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 04:42:41 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 04:42:41 INFO - Using env: {'DISPLAY': ':0', 04:42:41 INFO - 'HOME': '/home/cltbld', 04:42:41 INFO - 'LANG': 'en_US.UTF-8', 04:42:41 INFO - 'LANGUAGE': 'en_US:en', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MAIL': '/var/mail/cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SHLVL': '1', 04:42:41 INFO - 'TERM': 'linux', 04:42:41 INFO - 'TMOUT': '86400', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - '_': '/tools/buildbot/bin/python'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 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)) 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:41 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 04:42:41 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 04:42:41 INFO - Using env: {'DISPLAY': ':0', 04:42:41 INFO - 'HOME': '/home/cltbld', 04:42:41 INFO - 'LANG': 'en_US.UTF-8', 04:42:41 INFO - 'LANGUAGE': 'en_US:en', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MAIL': '/var/mail/cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SHLVL': '1', 04:42:41 INFO - 'TERM': 'linux', 04:42:41 INFO - 'TMOUT': '86400', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - '_': '/tools/buildbot/bin/python'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 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 0x7f5a6fae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, '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': '4300f881736b422476174874000001bc-1465386127.545686-852107915', '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 04:42:41 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 04:42:41 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 04:42:41 INFO - Using env: {'DISPLAY': ':0', 04:42:41 INFO - 'HOME': '/home/cltbld', 04:42:41 INFO - 'LANG': 'en_US.UTF-8', 04:42:41 INFO - 'LANGUAGE': 'en_US:en', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MAIL': '/var/mail/cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SHLVL': '1', 04:42:41 INFO - 'TERM': 'linux', 04:42:41 INFO - 'TMOUT': '86400', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - '_': '/tools/buildbot/bin/python'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Downloading/unpacking flake8 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:41 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 04:42:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:44 INFO - no previously-included directories found matching 'docs/_build' 04:42:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:44 INFO - Running setup.py install for pep8 04:42:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:44 INFO - no previously-included directories found matching 'docs/_build' 04:42:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:44 INFO - Cleaning up... 04:42:44 INFO - Return code: 0 04:42:44 INFO - Running post-action listener: _resource_record_post_action 04:42:44 INFO - Running post-action listener: _start_resource_monitoring 04:42:44 INFO - Starting resource monitoring. 04:42:44 INFO - ##### 04:42:44 INFO - ##### Finished create-virtualenv step (success) 04:42:44 INFO - ##### 04:42:44 INFO - ##### 04:42:44 INFO - ##### Running install step. 04:42:44 INFO - ##### 04:42:44 INFO - Running pre-action listener: _resource_record_pre_action 04:42:44 INFO - Running main action method: install 04:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:44 INFO - Reading from file tmpfile_stdout 04:42:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:45 INFO - Reading from file tmpfile_stdout 04:42:45 INFO - Output received: 04:42:45 INFO - Usage: mozinstall [options] installer 04:42:45 INFO - Options: 04:42:45 INFO - -h, --help show this help message and exit 04:42:45 INFO - -d DEST, --destination=DEST 04:42:45 INFO - Directory to install application into. [default: 04:42:45 INFO - "/builds/slave/test"] 04:42:45 INFO - --app=APP Application being installed. [default: firefox] 04:42:45 INFO - mkdir: /builds/slave/test/build/application 04:42:45 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'] 04:42:45 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 04:43:00 INFO - Reading from file tmpfile_stdout 04:43:00 INFO - Output received: 04:43:00 INFO - /builds/slave/test/build/application/firefox/firefox 04:43:00 INFO - Running post-action listener: _resource_record_post_action 04:43:00 INFO - ##### 04:43:00 INFO - ##### Finished install step (success) 04:43:00 INFO - ##### 04:43:00 INFO - ##### 04:43:00 INFO - ##### Running run-tests step. 04:43:00 INFO - ##### 04:43:00 INFO - Running pre-action listener: _resource_record_pre_action 04:43:00 INFO - Running main action method: run_tests 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:01 INFO - Python 2.7.3 04:43:01 INFO - Return code: 0 04:43:01 INFO - grabbing minidump binary from tooltool 04:43:01 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')]} 04:43:01 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 0xeb21c0>, '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 0xeb30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:01 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 04:43:01 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 04:43:01 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 04:43:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:01 INFO - Return code: 0 04:43:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:43:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:43:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:43:02 INFO - Return code: 0 04:43:02 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/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:43:02 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/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 04:43:02 INFO - Using env: {'DISPLAY': ':0', 04:43:02 INFO - 'HOME': '/home/cltbld', 04:43:02 INFO - 'LANG': 'en_US.UTF-8', 04:43:02 INFO - 'LANGUAGE': 'en_US:en', 04:43:02 INFO - 'LOGNAME': 'cltbld', 04:43:02 INFO - 'MAIL': '/var/mail/cltbld', 04:43:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:02 INFO - 'MOZ_NO_REMOTE': '1', 04:43:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:02 INFO - 'NO_EM_RESTART': '1', 04:43:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:02 INFO - 'PWD': '/builds/slave/test', 04:43:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:02 INFO - 'SHELL': '/bin/bash', 04:43:02 INFO - 'SHLVL': '1', 04:43:02 INFO - 'TERM': 'linux', 04:43:02 INFO - 'TMOUT': '86400', 04:43:02 INFO - 'USER': 'cltbld', 04:43:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465386127.545686-852107915', 04:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:02 INFO - '_': '/tools/buildbot/bin/python'} 04:43:02 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/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:43:02 INFO - mozversion application_buildid: 20160608031630 04:43:02 INFO - mozversion application_changeset: 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a 04:43:02 INFO - mozversion application_display_name: Nightly 04:43:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:02 INFO - mozversion application_name: Firefox 04:43:02 INFO - mozversion application_remotingname: firefox 04:43:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:43:02 INFO - mozversion application_vendor: Mozilla 04:43:02 INFO - mozversion application_version: 50.0a1 04:43:02 INFO - mozversion platform_buildid: 20160608031630 04:43:02 INFO - mozversion platform_changeset: 81f4cc3f6f4c21758b63605d69b47fa6cb3c142a 04:43:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:43:02 INFO - mozversion platform_version: 50.0a1 04:43:02 INFO - using testdate: 1465386182 04:43:02 INFO - actual date: 1465386182 04:43:02 INFO - starting webserver on 'localhost:48311' 04:43:02 INFO - SUITE-START | Running 2 tests 04:43:02 INFO - TEST-START | dromaeo_css 04:43:02 INFO - operating with platform_type : linux_ 04:43:02 INFO - Initialising browser for dromaeo_css test... 04:43:02 INFO - TEST-INFO | started process 300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJgFNEP/profile http://localhost:48311/getInfo.html) 04:43:06 INFO - PROCESS | 300 | __metrics Screen width/height:1600/1200 04:43:06 INFO - PROCESS | 300 | colorDepth:24 04:43:06 INFO - PROCESS | 300 | Browser inner width/height: 1024/697 04:43:06 INFO - PROCESS | 300 | __metrics 04:43:07 ERROR - PROCESS | 300 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:43:07 INFO - PROCESS | 300 | console.error: PushService: 04:43:07 INFO - PROCESS | 300 | stateChangeProcessEnqueue: Error transitioning state 04:43:07 INFO - PROCESS | 300 | UnknownError 04:43:08 INFO - TEST-INFO | 300: exit 0 04:43:08 INFO - Browser initialized. 04:43:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:08 INFO - TEST-INFO | started process 383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJgFNEP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:20 INFO - PROCESS | 383 | RSS: Main: 157954048 04:43:20 INFO - PROCESS | 383 | 04:44:11 INFO - PROCESS | 383 | 1465386251859 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] 04:46:24 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48311/tests/dromaeo/cssquery-ext.html) 04:46:25 INFO - PROCESS | 383 | RSS: Main: 236568576 04:46:25 INFO - PROCESS | 383 | 04:49:28 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-ext.html (next: http://localhost:48311/tests/dromaeo/cssquery-jquery.html) 04:49:29 INFO - PROCESS | 383 | RSS: Main: 241045504 04:49:29 INFO - PROCESS | 383 | 04:52:31 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48311/tests/dromaeo/cssquery-mootools.html) 04:52:32 INFO - PROCESS | 383 | RSS: Main: 243425280 04:52:32 INFO - PROCESS | 383 | 04:55:34 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48311/tests/dromaeo/cssquery-prototype.html) 04:55:34 INFO - PROCESS | 383 | RSS: Main: 234909696 04:55:34 INFO - PROCESS | 383 | 04:58:37 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48311/tests/dromaeo/cssquery-yui.html) 04:58:38 INFO - PROCESS | 383 | RSS: Main: 204849152 04:58:38 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | Cycle 1(1): loaded http://localhost:48311/tests/dromaeo/cssquery-yui.html (next: http://localhost:48311/tests/dromaeo/cssquery-dojo.html) 05:01:41 INFO - PROCESS | 383 | RSS: Main: 255160320 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | __start_tp_report 05:01:41 INFO - PROCESS | 383 | _x_x_mozilla_page_load 05:01:41 INFO - PROCESS | 383 | _x_x_mozilla_page_load_details 05:01:41 INFO - PROCESS | 383 | |i|pagename|runs| 05:01:41 INFO - PROCESS | 383 | |0;dojo.html;2663.5871439926814;2674.9866250668742;2711.5525938220194;2729.454109178165;2734.958975615365;4531.36560881476;4606.170889239936;4660.533946605342;4723.7165770053825;4765.785539650716;4628.768561571925;4685.718856868591;4687.859364219071;4701;4719.362886010396;4128.153728485669;4292.785360731967;4375.912481750363;4414.139242847646;4456.309272062836;4360.956390436087;4382.824687012531;4426.822927082912;4439.933400998988;4464.6651501137385;4214.494260688706;4267.039916018902;4277.636400905895;4298.591633794785;4322.654187664979;4279.40088387626;4304.978475107636;4323.11376167888;4329.718568293082;4348.5216626171095;4300.6344460720875;4308.80610372534;4326.329418940069;4353.064091220371;4371.082072764723;4400.405945197389;4524.140413321458;4626.653001024903;4627.583517483409;4644.187267228222;5086.92369614456;5094.668846525001;5104.336436263262;5105.846824595268;5106.719130447824;5086.949130508721;5119.129747942859;5119.462456442057;5120.871978200537;5124.948750512484;4497.460304763449;4652.464966528825;4703.976480117578;4707.576318131385;4722.1028004679;5177.456367081478;5193.428722840485;5195.532402083831;5254.894902102013;5259.579233661298;4743.383360163157;4966.8758281043265;5024.598032157419;5034.270030845581;5035.967626636604;4994.575461085776;5062.544371006627;5066.316047333563;5079.822206222764;5137.717425541631;5013.774380152902;5026.648134630541;5028.296038554532;5043.142665746832;5074.314967479343;4784.521547845187;4981.601471882241;4986.052649996489;4988.102141614544;4997.550220480174;4179.26862799009;4221.155768846243;4235.639970602471;4250.74495530263;4262.531121576624;3692.2800053989213;3702.9074273143387;3716.5168528091176;3743.2700623378178;3751.118487155516;4211.368294755811;4309.655227581786;4324.329728892027;4373.540778218305;4379.233634114081;4987.376577927759;5032.018756342478;5042.142835717937;5053.1157047516535;5054.393472783216;4333.58830911063;4334.696571239983;4338.042753168673;4338.436003319548;4358.738475691469;4374.5625437456;4483.417155769729;4521.570450807168;4538.1377538267625;4557.680962332671;4766.809327626856;4776.164171270083;4784.138855006132;4787.0904528139545;4822.204336284473;5010.398752149766;5074.82238121664;5076.441591424867;5077.796888124433;5082.288479612931;4625.398698169217;4697.647676424213;4711.2933060039895;4751.6436267279405;4807.495213002724;4959.380077490314;4971.453140154653;4974.676646017997;4986.227134794112;5027.974860125676;5019.974900125476;5050.04049230645;5055.090083784954;5056.797728090835;5075.644704870771;4759;4861.392325959255;4898.902021959612;4917.6311776616185;4950.257461380822;4908.067467181224;4930.334404855299;4930.359053323045;4945.950540494549;4984.601231901367;4853.6602437830425;4862.027594481188;4920.40955085392;4930.531599498042;4932.186189278729;4797.376341075638;4877.707337559757;4918.606511479002;4936.580390666833;4946.08497427977;4816.181249187576;4820.927686084641;4829.975850120867;4835.516448355277;4875.439324477588 05:01:41 INFO - PROCESS | 383 | |1;ext.html;555.5207887047316;579.7680927628948;586.4985437450979;588.5438784941672;589.7523040323064;27503;28279.151625451243;39930.8003459983;40503.79748101259;41689;37864.43203351945;38436.80781596095;38570;42317.57682423175;42457.36313955286;7684.769456916288;7869.095054068798;7870.842583148334;7876.960615196916;7880.802979925519;7401.222871598486;9881;10185.796284074315;10195.13341365981;10489.10842578378;10061.295709300352;10166.694999150037;10172.745681357952;10180.032896874785;10180.745481362952;10044.89955100447;10092.747681307952;10135.64525241613;10143.949280253626;10151.390916544993;9829.3610915291;9917.90082099177;9935.80128397428;9956.352837065568;9956.352837065568;39199.60800391988;39452.80273598642;39513.80243098795;39584.40623390651;39585.604143958764;2866.140157952627;2873.540233562641;2894.8407837568925;3086.24387025178;3632.3824949758605;29490.410191796043;29784.40431191364;29886.252843678863;30320.84839575788;31320.21699457509;3389.372966001273;3409.6760807723226;3481.582210134775;3490.912727181815;3507.4037413639744;252924;253562;253611;253736.73131634408;253846;56161;57230.14154787682;57411.71294143503;57483;57585;59696.40303596909;59897.40102599005;59978.400215998154;59987;60042.39957600455;15054.096754194783;15640;15662.451814186677;15668.728034435171;15668.764968525482;10753.408562528979;11618.360990145455;12048.87951120495;12054.15620906528;12115.454804533818;18355.81644183568;18487.352942647212;18550.814491855177;18612.627747444974;18674.626507469773;6867.484938629623;7045.26024767392;7095.82260443493;7108.436144048301;7123.857522849514;768.9577073261024;854.2354592639552;927.3137877970254;944.5230158769915;980.7302991677345;27360.58959115615;28192;28212.576811347848;28594;28908.566371504443;954.4893481987103;955.4060725131163;1016.9949150254349;1031.242037102729;1096.550414330121;14473.85526144725;14856.480023199136;14921;15015.774763378558;15244.23778811055;372815;374589;377315;377748;379238;50569;51352.74323628358;51448;51457;51620.74189629028;1094.3051162511704;1187.1867770577182;1204.795184818583;1228.8341073954903;1235.6787235318702;28025.579616305364;29270.7072929268;29407.411851762416;29525;29987.550186747652;41421.585784142975;41528.58471415368;42042.57957420387;42062.1587568253;42067.7896610515;295473;296054;297129;297250;298161;21639.13443462244;22951.770482294964;23891.283261502183;25289.367765806;25290.36774080589;42636.78681606572;42693.35959960541;42842.78578607087;43340;43847;36060;36216.27567448689;36241.27517449689;36775.632243678294;37395.43906841345;34687.306253875286;36391.27217455583;36425.45361819522;36777.264454711294;36808.44787328139;36581.45127823138;36890.63109368872;37197.628023719415;37396.81301593475;37442.812785935894;32063.35873282568;33675.83162084272;33677;33710;33771.3245735079;25224.747752522973;25266.36834079163;25479.61780573256;25599.50047821291;26157.73842261629 05:01:41 INFO - PROCESS | 383 | |2;jquery.html;368.9963100368996;369.94635777812226;376.2456275168289;384.3159176665536;385.2353079137911;15802.683946321082;17174.3130274789;17383.82616173841;17653.382131625396;17856.196471158797;16281.104539250337;16660.75008874868;17176;17181.140942952865;17218;4896.55930966213;5023.874403139914;5029.647924645276;5075.213341932006;5083.84748457545;3676.5036720042854;3862.903427414309;4973.701577905319;5421.918671219935;5787.13193021046;5782.363939966622;5784.652920824764;5805.883882322351;5813.273340832396;5821.18503409523;5682.573806964473;5690.7439165237665;5769.336526299467;5777.19119323295;5859;3342.5153352763714;4767.094252092092;5072.898542029176;5083.237514372837;5155.510226528474;19643.214271429126;20140.697889531668;20168.79831201684;20786.37640870776;20788;1955.3938279133515;1959.9706004409945;1997.6304383688919;2201.3726088064823;2498.537770512461;12422.937885310606;12533;12554.497820087185;12683.112182147253;12962.805557916545;1705.7356109803;1745.3978377459755;1756.6223261998732;1762.3391228289393;1798.505411011969;63166;64106.35893641051;65017.67491162561;65353.67323163401;65740.67129664369;9194.90805091954;9353.953230233805;9359.78322818043;9413.388129771543;9612.51937403127;12681.429335679917;12728.745425091447;12822.974162067012;12829.486820527074;12860.099793014399;7220.097487814023;7292.781216563511;7297.781066568012;7385.335319821242;7419.369353604896;7068.469864760164;7073;7074;7235.819104522324;7282.927170728331;5875.941240587539;5881.823545293648;5931.525477961753;5948.940510594839;6011.158437818709;1579.9447019354268;1654.0985163086148;1700.4388551777884;1739.3390511605762;1762.4712586224082;792.4334101117729;861.7931696392945;875.3434923807145;886.1537231943479;895.3598177303129;16645;16830.518652327522;17149.91425042892;17296.308147673953;17601.471955841345;865.9781457879762;874.191372979991;882.7572417585216;900.2392977933636;924.8982611912819;6736.629485378351;10029.749256268651;10118.54466549007;10200.3369780964;10209.132223760915;352454;395339;396556;396989;397272;53031;71089.93365099527;79351.60324198457;81687.591562043;82165;921.424109931293;957.2342126298932;962.3888830592624;981.4847205217318;1006.4565134827111;15483.922580387027;15745.44890928812;15778.842211577738;15847.920760396586;16248.67502649964;31890.52164217585;33155.33689326248;33943.66056339405;34555.30889382148;35195.47206791849;40445.59554404536;43526.34710479282;44920.32619510775;48322;50273.74863125661;7355.8161045974275;7562.962185189039;7652.464327497022;7679.884801727867;7795.259450352208;10957.616483423042;11278.210525263154;11568.595099171825;11622.07023438106;11780.175387722777;9556.187724043533;9577.808443831223;10002.799944000933;10018;10347;10048.547815348473;10111.191104711459;10275.537600807833;10352.637657681946;10416.583336666448;9884.703458896245;9949.801003980025;10170.08469237772;10205.38767673942;10378.948105259426;7691.230876912264;7723.961380193063;7751.612419379121;7854.057513098464;7925.643346049557;9002.864957025518;9543;9716.125548700651;9741.61033558678;9886.752831179278 05:01:41 INFO - PROCESS | 383 | |3;mootools.html;1231.2673958994394;1361.6323592629988;1447.3125265498888;1514.7197768412846;1760.5158581390124;6425;7379.557226566403;7652.120006199289;7655.425843061772;7661.9616901915415;7475.663595138219;7514.66184021719;7616.581088040156;7800.960995195031;7814.570198639072;2085.7392825896763;2124.2883633982633;2124.872507649546;2131.6163090643677;2133.0614529607;2071.4200023993308;2103.6949642301856;2161.91352345906;2164.6428339323993;2169.1648715244664;2094.3193462124796;2098.1397626972944;2100.548382097849;2115.7672656007903;2128.9041993110345;2082.7084208210863;2108.230495869012;2113.9682904756364;2117.1108134583433;2119.533702585444;2039.6940458931278;2086.3636590839787;2087.7077209190725;2088.6658134698528;2089.2687559354104;7454.2173071827765;7502.024736784183;7513.060867391576;7517;7576.166621671612;4489.25927222008;4633.9536604634195;4648.651351148677;4651.790669419885;4654.953450465519;2774.819636723627;2883.942321153565;2917.766578673701;2933.9266518337;2934.1784300395925;912.6030176873081;920.9447433154032;938.0525669074216;949.349695458613;953.2564599612314;10324.483775811255;10573.154147668169;10603.204759643058;10625.043746062815;10627;4096.426500289962;4162.875113746592;4241;4249.97875010623;4259.0204253021975;9048;9090.59092340833;9096.727098187064;9110.498922559324;9128.361014728906;4693.27254275581;4713.481517033124;4716.080364328992;4718.339432479455;4729.5743383095;3558.964410355915;3687.9262414751556;4146.91706165875;4223.366495025771;4237.300845360481;3600.7839529628304;3633.6548027937833;3656.6160553142067;3730.2539492101687;3829.3872980323013;1124.2523721725124;1130.4460814201148;1169.5497233564968;1172.7185475485821;1176.0650283025016;814.4543156085437;821.2731732416854;824.4970567953544;828.4904783558069;841.5665932045001;5079.6952182869145;5091.87270318245;5134.666246693953;5411.810586629528;5455.645383050089;851.0850835352021;912.5710915869531;913.4930113786912;922.7047344849584;952.0099096939244;3313.3207692422993;3366.646502117291;3381.594208694972;3409.880654177092;3475.270193259393;9255.167034966886;9647.903520964841;9652.662156824477;9729.70810875675;9733.172680322252;9471.052894710612;9570.090841370058;9585.856212156823;9601.47191904438;9602.90397096034;7060.470464715167;7338.082739657543;7350.96324518374;7372.078490188726;7491.06361704776;5059.727345789587;5205.271262023244;5253.947460525499;5263.736813159403;5271.841844744664;8808.471491710518;8888.64445422176;8940.105989401009;8996.955015224881;9017.233535149586;8581.141885811368;8964.641414343354;8980.191782739585;8993.460392376479;8995.82008359816;5753.626014309057;6537.836554086186;6633;6634.402903738686;6644.136262285871;7323.12122545298;7366.079240094989;7400.407967362706;7426.368758655575;7426.5915374654915;6759.662016899037;6827.590344579341;6953.895691564731;6978.057962175244;7028;6847.794566163023;6857.108575885103;6873.518853680194;6945.270746571739;6965.5124141309625;5837.3870743571315;6019.939800601938;6049.304330002106;6181.567290289637;6211;4202.2646036944025;4289.077848262638;4371.519132895442;4380.3210502372185;4405.867823965286;4341.652667786507;4453.04259584178;4458.531854155397;4532.4334458192725;4575.9771201143785 05:01:41 INFO - PROCESS | 383 | |4;prototype.html;285.12040355503274;285.5360039935105;289.4616014213563;293.370719806016;294.2100460264192;4774.283857421384;4794.928076078853;4798.592119669824;4812.157872372339;4828.52729917375;4727.05458908218;4732.621390288778;4743.244999350245;4746.21687421575;4756.738379389132;3541.2917416516734;3557.719221080409;3669.7522842233634;3686.594474607791;3703.5370578677666;3662.4323229899273;3674.614165512623;3691.7046636269033;3710.3506886294927;3711.6845068169237;3489.5867173794654;3677.7977211253506;3680.11677197472;3691.3724666806706;3703.037210325308;3520.0495866116007;3541.5041894134843;3614.837332320026;3619.69232615228;3659.963400366002;3222.5649537312397;3236.336551007038;3238.983805080983;3242.837858107085;3245.2698142917657;4565.5206203348835;4579.793909274091;4580.381648477446;4582.747948862811;4603.7698115094445;3957.2085582883537;4128.174365126986;4135.462389889295;4166.333386658151;4171.353440216772;4894.975525122387;4920.646822123908;4923.261510773377;4925.3350797642215;4926.261060840867;3486.599041110254;3489.8604055837736;3492.4412094065083;3497.2863296984547;3508.4912687660403;5055.51972562606;5183.211791931778;5197.636165468419;5213.7393130343335;5260.948230190229;3546.1843775931166;3547.5742910850863;3549.307884962459;3552.4493703476;3565.607783143852;3594.6699721102837;3625.510556074949;3626.2384899170943;3628.3106209820576;3630.4009838376373;4155.522114956758;4162.646175075092;4163.375493675972;4172.436721042681;4189;4678.877069503363;4953.6037117030555;4961.404631444249;4980.2778597103215;4988.6507944444265;1211.3216598704753;1219.737756382382;1221.6274036418977;1223.6023292429995;1224.8101544260653;757.7575175943755;782.9882551761729;786.2137862137862;789.9802504937422;792.2354927494995;4024.4768180136393;4266.168097221012;4287.97856010718;4419.359192917009;4424.358468022183;5146.665466744725;5151.2273159026445;5151.6136289778415;5159.380874295033;5168.638195326366;4406.162829062468;4422.226110430662;4428.645708343325;4451.710638808467;4455.888602784891;2614.5293847107323;2696.61349705512;2706;2732.53546897028;2743.684476285253;4805.207140821725;4805.879853003633;4816.229403295526;4847.5394837490385;4866.31871537985;5231.529162375328;5234.581233501311;5244.842654720364;5263.473652634706;5279.551238144724;4585.495595484494;4813.9037219255415;4841.8379588899115;4852.398708426141;4864.197407427806;5130.230465430215;5149.510796474329;5168.457311982338;5170.681476223539;5172.508611681884;5058.241263810458;5067.645264831426;5086.389633243886;5138.100832354397;5157.355330583677;4657.487676355666;4819.421669399694;4837.201861692922;4848.539388758062;4855.441624213119;3446.327966046697;3462.688358047788;3466.86132554695;3492.5285086514014;3494;5181.766820493162;5187.559057480005;5203;5219.921701174561;5229;4836.758162091952;4993.450720420678;5004.199328107486;5011.498850115106;5070.492950705047;4970.652054356305;4976.676516026447;4983.754061484628;4995.425526064404;4997.475265097112;4940.6788558743565;4941.678790878582;4945.653804233669;4998.6750861193905;5003.899922001467;4759.286107083965;4794.472608013186;4815.494373090775;4991.625628077836;5045.9243111352625;4880.194767863263;4899.877503062452;4909.0672772173175;4916.459189489082;4922.409310882717 05:01:41 INFO - PROCESS | 383 | |5;yui.html;585.1895125251526;623.5479277523796;624.1044101714041;668.9230738465078;737.963101844908;12612.684682882933;12644.431000604973;12874.871251287495;12976.416061277241;13420.530281440151;13244.271565063918;13279.070465067425;13412.189354437172;13433.865661343383;13439.126456780303;627.8273474794422;757.9507332023414;785.2540086917451;804.8792681097852;817.435969181266;794.9364050875917;802.4543310548825;803.2088392932985;803.9276465118138;805.8670319397293;846.3652260804397;850.3919697416346;850.740524140137;851.1701091435863;851.2253848997414;657.3426573426574;807.5397023696466;824.4558591329753;834.0408530190269;837.539353355652;614.3518587889774;614.62200746541;614.6895817612077;614.9631022138686;615.6152404747033;13815.309234538232;13855.722885542333;13894.58316250504;13920.234387108705;13958.371873265727;12812.167209131376;12997.610071697864;13136.6715832104;13260.668483287898;13584.184948903;11864.940675296655;11916.34460104694;11998.820017699742;12045.518179272818;12046.457909394097;4104.384342348641;4117.8970525736795;4144.958550414487;4166.458360413158;4202.873913782591;55456.44543554553;55542.722286388715;55574.72212638951;55588.72205638946;56245.71877140629;10174.796504069876;10340.844887326695;10374.27380083402;10624.575016999388;10743.731406714895;18475.445736627924;19120.52198695016;19142.521436964187;20282.087306071262;20309.18763249483;7065.222825489295;7080.327368899946;7131.536450130725;7142.857142857218;7280.453965952574;3555.982220088883;3662.047867554402;3676.117731744362;3683.244934788362;3710.406334986443;2959.1270575180374;3024.758019358446;3067.2791893904914;3072.877084916623;3074.4158609864053;521.7260938007577;523.1786095829511;531.0971348707213;537.712323906708;546.4535464535464;428.6892003297647;512.397932429394;542.9728513574305;554.2655980825423;566.7761234312424;7925.207479252144;8186.2632363087605;8267.255946964802;8308.587570057576;8352.290055345364;424.9758083019907;499.2635862103441;513.186599240201;556.7772890843614;624.5752888036179;3785.167263202091;3831.616838316146;3868.477755502971;3985.501812273466;4033.6974726895014;86036.5698171505;86064.56967715247;88155.55922220348;89195.55402222948;90562;49086.509134908905;60988;62212.37787622066;78678.6066069666;79702;68339;69254.65372673105;69374.65312673405;69817;70011.29988700048;7739.535627862347;7804.375649948104;7939.166387529457;8027.478213916077;8168.959155204186;41799.79100104602;43294.78352608217;43933.340999884385;44346.778266108464;44364.11271774611;57668.423315767985;58844;58873.70563147157;59404.40595594161;59677.70161149166;10669.626563070255;10716.73208169802;10881.78236435251;10940.945295273472;11331.150163737588;11280.09759219277;11573.652790416301;11957.103217258566;12013.399330033639;12149.210301330739;9125.589348479201;9364.297677674338;9879.456629885426;9888.258380621339;9934.602615895572;9678.89771153587;9842.11420972116;9880.505974701093;9937.25470589723;9993.500324983866;10169.084782369326;10502.317349372266;10710;10723.94638026805;11005.394703291076;9687.370320929118;9922.851157232502;9932.25508086882;9940.701778946643;10245.590176392861;9726.270529710158;10011.749706257111;10071.414765659563;10217.284790064625;10227.59089636436 05:01:41 INFO - PROCESS | 383 | __end_tp_report 05:01:41 INFO - PROCESS | 383 | __start_cc_report 05:01:41 INFO - PROCESS | 383 | _x_x_mozilla_cycle_collect,1002 05:01:41 INFO - PROCESS | 383 | __end_cc_report 05:01:41 INFO - PROCESS | 383 | __startTimestamp1465387301508__endTimestamp 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | ------- Summary: start ------- 05:01:41 INFO - PROCESS | 383 | Number of tests: 6 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#0] dojo.html Cycles:165 Average:4653.88 Median:4776.16 stddev:488.30 (10.2%) stddev-sans-first:464.16 05:01:41 INFO - PROCESS | 383 | Values: 2663.6 2675.0 2711.6 2729.5 2735.0 4531.4 4606.2 4660.5 4723.7 4765.8 4628.8 4685.7 4687.9 4701.0 4719.4 4128.2 4292.8 4375.9 4414.1 4456.3 4361.0 4382.8 4426.8 4439.9 4464.7 4214.5 4267.0 4277.6 4298.6 4322.7 4279.4 4305.0 4323.1 4329.7 4348.5 4300.6 4308.8 4326.3 4353.1 4371.1 4400.4 4524.1 4626.7 4627.6 4644.2 5086.9 5094.7 5104.3 5105.8 5106.7 5086.9 5119.1 5119.5 5120.9 5124.9 4497.5 4652.5 4704.0 4707.6 4722.1 5177.5 5193.4 5195.5 5254.9 5259.6 4743.4 4966.9 5024.6 5034.3 5036.0 4994.6 5062.5 5066.3 5079.8 5137.7 5013.8 5026.6 5028.3 5043.1 5074.3 4784.5 4981.6 4986.1 4988.1 4997.6 4179.3 4221.2 4235.6 4250.7 4262.5 3692.3 3702.9 3716.5 3743.3 3751.1 4211.4 4309.7 4324.3 4373.5 4379.2 4987.4 5032.0 5042.1 5053.1 5054.4 4333.6 4334.7 4338.0 4338.4 4358.7 4374.6 4483.4 4521.6 4538.1 4557.7 4766.8 4776.2 4784.1 4787.1 4822.2 5010.4 5074.8 5076.4 5077.8 5082.3 4625.4 4697.6 4711.3 4751.6 4807.5 4959.4 4971.5 4974.7 4986.2 5028.0 5020.0 5050.0 5055.1 5056.8 5075.6 4759.0 4861.4 4898.9 4917.6 4950.3 4908.1 4930.3 4930.4 4946.0 4984.6 4853.7 4862.0 4920.4 4930.5 4932.2 4797.4 4877.7 4918.6 4936.6 4946.1 4816.2 4820.9 4830.0 4835.5 4875.4 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#1] ext.html Cycles:180 Average:47244.42 Median:3486.25 stddev:82154.12 (2356.5%) stddev-sans-first:82309.79 05:01:41 INFO - PROCESS | 383 | Values: 555.5 579.8 586.5 588.5 589.8 27503.0 28279.2 39930.8 40503.8 41689.0 37864.4 38436.8 38570.0 42317.6 42457.4 7684.8 7869.1 7870.8 7877.0 7880.8 7401.2 9881.0 10185.8 10195.1 10489.1 10061.3 10166.7 10172.7 10180.0 10180.7 10044.9 10092.7 10135.6 10143.9 10151.4 9829.4 9917.9 9935.8 9956.4 9956.4 39199.6 39452.8 39513.8 39584.4 39585.6 2866.1 2873.5 2894.8 3086.2 3632.4 29490.4 29784.4 29886.3 30320.8 31320.2 3389.4 3409.7 3481.6 3490.9 3507.4 252924.0 253562.0 253611.0 253736.7 253846.0 56161.0 57230.1 57411.7 57483.0 57585.0 59696.4 59897.4 59978.4 59987.0 60042.4 15054.1 15640.0 15662.5 15668.7 15668.8 10753.4 11618.4 12048.9 12054.2 12115.5 18355.8 18487.4 18550.8 18612.6 18674.6 6867.5 7045.3 7095.8 7108.4 7123.9 769.0 854.2 927.3 944.5 980.7 27360.6 28192.0 28212.6 28594.0 28908.6 954.5 955.4 1017.0 1031.2 1096.6 14473.9 14856.5 14921.0 15015.8 15244.2 372815.0 374589.0 377315.0 377748.0 379238.0 50569.0 51352.7 51448.0 51457.0 51620.7 1094.3 1187.2 1204.8 1228.8 1235.7 28025.6 29270.7 29407.4 29525.0 29987.6 41421.6 41528.6 42042.6 42062.2 42067.8 295473.0 296054.0 297129.0 297250.0 298161.0 21639.1 22951.8 23891.3 25289.4 25290.4 42636.8 42693.4 42842.8 43340.0 43847.0 36060.0 36216.3 36241.3 36775.6 37395.4 34687.3 36391.3 36425.5 36777.3 36808.4 36581.5 36890.6 37197.6 37396.8 37442.8 32063.4 33675.8 33677.0 33710.0 33771.3 25224.7 25266.4 25479.6 25599.5 26157.7 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#2] jquery.html Cycles:180 Average:23845.07 Median:44223.34 stddev:63876.43 (144.4%) stddev-sans-first:64031.30 05:01:41 INFO - PROCESS | 383 | Values: 369.0 369.9 376.2 384.3 385.2 15802.7 17174.3 17383.8 17653.4 17856.2 16281.1 16660.8 17176.0 17181.1 17218.0 4896.6 5023.9 5029.6 5075.2 5083.8 3676.5 3862.9 4973.7 5421.9 5787.1 5782.4 5784.7 5805.9 5813.3 5821.2 5682.6 5690.7 5769.3 5777.2 5859.0 3342.5 4767.1 5072.9 5083.2 5155.5 19643.2 20140.7 20168.8 20786.4 20788.0 1955.4 1960.0 1997.6 2201.4 2498.5 12422.9 12533.0 12554.5 12683.1 12962.8 1705.7 1745.4 1756.6 1762.3 1798.5 63166.0 64106.4 65017.7 65353.7 65740.7 9194.9 9354.0 9359.8 9413.4 9612.5 12681.4 12728.7 12823.0 12829.5 12860.1 7220.1 7292.8 7297.8 7385.3 7419.4 7068.5 7073.0 7074.0 7235.8 7282.9 5875.9 5881.8 5931.5 5948.9 6011.2 1579.9 1654.1 1700.4 1739.3 1762.5 792.4 861.8 875.3 886.2 895.4 16645.0 16830.5 17149.9 17296.3 17601.5 866.0 874.2 882.8 900.2 924.9 6736.6 10029.7 10118.5 10200.3 10209.1 352454.0 395339.0 396556.0 396989.0 397272.0 53031.0 71089.9 79351.6 81687.6 82165.0 921.4 957.2 962.4 981.5 1006.5 15483.9 15745.4 15778.8 15847.9 16248.7 31890.5 33155.3 33943.7 34555.3 35195.5 40445.6 43526.3 44920.3 48322.0 50273.7 7355.8 7563.0 7652.5 7679.9 7795.3 10957.6 11278.2 11568.6 11622.1 11780.2 9556.2 9577.8 10002.8 10018.0 10347.0 10048.5 10111.2 10275.5 10352.6 10416.6 9884.7 9949.8 10170.1 10205.4 10378.9 7691.2 7724.0 7751.6 7854.1 7925.6 9002.9 9543.0 9716.1 9741.6 9886.8 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#3] mootools.html Cycles:180 Average:5075.98 Median:5258.84 stddev:2858.08 (54.3%) stddev-sans-first:2851.49 05:01:41 INFO - PROCESS | 383 | Values: 1231.3 1361.6 1447.3 1514.7 1760.5 6425.0 7379.6 7652.1 7655.4 7662.0 7475.7 7514.7 7616.6 7801.0 7814.6 2085.7 2124.3 2124.9 2131.6 2133.1 2071.4 2103.7 2161.9 2164.6 2169.2 2094.3 2098.1 2100.5 2115.8 2128.9 2082.7 2108.2 2114.0 2117.1 2119.5 2039.7 2086.4 2087.7 2088.7 2089.3 7454.2 7502.0 7513.1 7517.0 7576.2 4489.3 4634.0 4648.7 4651.8 4655.0 2774.8 2883.9 2917.8 2933.9 2934.2 912.6 920.9 938.1 949.3 953.3 10324.5 10573.2 10603.2 10625.0 10627.0 4096.4 4162.9 4241.0 4250.0 4259.0 9048.0 9090.6 9096.7 9110.5 9128.4 4693.3 4713.5 4716.1 4718.3 4729.6 3559.0 3687.9 4146.9 4223.4 4237.3 3600.8 3633.7 3656.6 3730.3 3829.4 1124.3 1130.4 1169.5 1172.7 1176.1 814.5 821.3 824.5 828.5 841.6 5079.7 5091.9 5134.7 5411.8 5455.6 851.1 912.6 913.5 922.7 952.0 3313.3 3366.6 3381.6 3409.9 3475.3 9255.2 9647.9 9652.7 9729.7 9733.2 9471.1 9570.1 9585.9 9601.5 9602.9 7060.5 7338.1 7351.0 7372.1 7491.1 5059.7 5205.3 5253.9 5263.7 5271.8 8808.5 8888.6 8940.1 8997.0 9017.2 8581.1 8964.6 8980.2 8993.5 8995.8 5753.6 6537.8 6633.0 6634.4 6644.1 7323.1 7366.1 7400.4 7426.4 7426.6 6759.7 6827.6 6953.9 6978.1 7028.0 6847.8 6857.1 6873.5 6945.3 6965.5 5837.4 6019.9 6049.3 6181.6 6211.0 4202.3 4289.1 4371.5 4380.3 4405.9 4341.7 4453.0 4458.5 4532.4 4576.0 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#4] prototype.html Cycles:180 Average:4113.35 Median:4744.73 stddev:1221.46 (25.7%) stddev-sans-first:1190.61 05:01:41 INFO - PROCESS | 383 | Values: 285.1 285.5 289.5 293.4 294.2 4774.3 4794.9 4798.6 4812.2 4828.5 4727.1 4732.6 4743.2 4746.2 4756.7 3541.3 3557.7 3669.8 3686.6 3703.5 3662.4 3674.6 3691.7 3710.4 3711.7 3489.6 3677.8 3680.1 3691.4 3703.0 3520.0 3541.5 3614.8 3619.7 3660.0 3222.6 3236.3 3239.0 3242.8 3245.3 4565.5 4579.8 4580.4 4582.7 4603.8 3957.2 4128.2 4135.5 4166.3 4171.4 4895.0 4920.6 4923.3 4925.3 4926.3 3486.6 3489.9 3492.4 3497.3 3508.5 5055.5 5183.2 5197.6 5213.7 5260.9 3546.2 3547.6 3549.3 3552.4 3565.6 3594.7 3625.5 3626.2 3628.3 3630.4 4155.5 4162.6 4163.4 4172.4 4189.0 4678.9 4953.6 4961.4 4980.3 4988.7 1211.3 1219.7 1221.6 1223.6 1224.8 757.8 783.0 786.2 790.0 792.2 4024.5 4266.2 4288.0 4419.4 4424.4 5146.7 5151.2 5151.6 5159.4 5168.6 4406.2 4422.2 4428.6 4451.7 4455.9 2614.5 2696.6 2706.0 2732.5 2743.7 4805.2 4805.9 4816.2 4847.5 4866.3 5231.5 5234.6 5244.8 5263.5 5279.6 4585.5 4813.9 4841.8 4852.4 4864.2 5130.2 5149.5 5168.5 5170.7 5172.5 5058.2 5067.6 5086.4 5138.1 5157.4 4657.5 4819.4 4837.2 4848.5 4855.4 3446.3 3462.7 3466.9 3492.5 3494.0 5181.8 5187.6 5203.0 5219.9 5229.0 4836.8 4993.5 5004.2 5011.5 5070.5 4970.7 4976.7 4983.8 4995.4 4997.5 4940.7 4941.7 4945.7 4998.7 5003.9 4759.3 4794.5 4815.5 4991.6 5045.9 4880.2 4899.9 4909.1 4916.5 4922.4 05:01:41 INFO - PROCESS | 383 | 05:01:41 INFO - PROCESS | 383 | [#5] yui.html Cycles:180 Average:16492.32 Median:544.71 stddev:22477.55 (4126.5%) stddev-sans-first:22508.87 05:01:41 INFO - PROCESS | 383 | Values: 585.2 623.5 624.1 668.9 738.0 12612.7 12644.4 12874.9 12976.4 13420.5 13244.3 13279.1 13412.2 13433.9 13439.1 627.8 758.0 785.3 804.9 817.4 794.9 802.5 803.2 803.9 805.9 846.4 850.4 850.7 851.2 851.2 657.3 807.5 824.5 834.0 837.5 614.4 614.6 614.7 615.0 615.6 13815.3 13855.7 13894.6 13920.2 13958.4 12812.2 12997.6 13136.7 13260.7 13584.2 11864.9 11916.3 11998.8 12045.5 12046.5 4104.4 4117.9 4145.0 4166.5 4202.9 55456.4 55542.7 55574.7 55588.7 56245.7 10174.8 10340.8 10374.3 10624.6 10743.7 18475.4 19120.5 19142.5 20282.1 20309.2 7065.2 7080.3 7131.5 7142.9 7280.5 3556.0 3662.0 3676.1 3683.2 3710.4 2959.1 3024.8 3067.3 3072.9 3074.4 521.7 523.2 531.1 537.7 546.5 428.7 512.4 543.0 554.3 566.8 7925.2 8186.3 8267.3 8308.6 8352.3 425.0 499.3 513.2 556.8 624.6 3785.2 3831.6 3868.5 3985.5 4033.7 86036.6 86064.6 88155.6 89195.6 90562.0 49086.5 60988.0 62212.4 78678.6 79702.0 68339.0 69254.7 69374.7 69817.0 70011.3 7739.5 7804.4 7939.2 8027.5 8169.0 41799.8 43294.8 43933.3 44346.8 44364.1 57668.4 58844.0 58873.7 59404.4 59677.7 10669.6 10716.7 10881.8 10940.9 11331.2 11280.1 11573.7 11957.1 12013.4 12149.2 9125.6 9364.3 9879.5 9888.3 9934.6 9678.9 9842.1 9880.5 9937.3 9993.5 10169.1 10502.3 10710.0 10723.9 11005.4 9687.4 9922.9 9932.3 9940.7 10245.6 9726.3 10011.7 10071.4 10217.3 10227.6 05:01:41 INFO - PROCESS | 383 | -------- Summary: end -------- 05:01:41 INFO - PROCESS | 383 | 05:01:42 INFO - TEST-INFO | 383: exit 0 05:01:42 INFO - TEST-OK | dromaeo_css | took 1120066ms 05:01:42 INFO - TEST-START | kraken 05:01:42 INFO - operating with platform_type : linux_ 05:01:42 INFO - Initialising browser for kraken test... 05:01:42 INFO - TEST-INFO | started process 563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz36LmJ/profile http://localhost:48311/getInfo.html) 05:01:46 INFO - PROCESS | 563 | __metrics Screen width/height:1600/1200 05:01:46 INFO - PROCESS | 563 | colorDepth:24 05:01:46 INFO - PROCESS | 563 | Browser inner width/height: 1024/697 05:01:46 INFO - PROCESS | 563 | __metrics 05:01:47 ERROR - PROCESS | 563 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:01:47 INFO - PROCESS | 563 | console.error: PushService: 05:01:47 INFO - PROCESS | 563 | stateChangeProcessEnqueue: Error transitioning state 05:01:47 INFO - PROCESS | 563 | UnknownError 05:01:48 INFO - TEST-INFO | 563: exit 0 05:01:48 INFO - Browser initialized. 05:01:48 INFO - Running cycle 1/1 for kraken test... 05:01:48 INFO - TEST-INFO | started process 646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz36LmJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:00 INFO - PROCESS | 646 | RSS: Main: 157061120 05:02:00 INFO - PROCESS | 646 | 05:02:03 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48311/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:04 INFO - PROCESS | 646 | RSS: Main: 215302144 05:02:04 INFO - PROCESS | 646 | 05:02:07 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48311/tests/kraken/driver.html?testName=audio-dft) 05:02:07 INFO - PROCESS | 646 | RSS: Main: 203079680 05:02:07 INFO - PROCESS | 646 | 05:02:10 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48311/tests/kraken/driver.html?testName=audio-fft) 05:02:11 INFO - PROCESS | 646 | RSS: Main: 269946880 05:02:11 INFO - PROCESS | 646 | 05:02:13 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48311/tests/kraken/driver.html?testName=audio-oscillator) 05:02:14 INFO - PROCESS | 646 | RSS: Main: 180195328 05:02:14 INFO - PROCESS | 646 | 05:02:16 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:17 INFO - PROCESS | 646 | RSS: Main: 184016896 05:02:17 INFO - PROCESS | 646 | 05:02:20 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48311/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:20 INFO - PROCESS | 646 | RSS: Main: 220352512 05:02:20 INFO - PROCESS | 646 | 05:02:24 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48311/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:25 INFO - PROCESS | 646 | RSS: Main: 216285184 05:02:25 INFO - PROCESS | 646 | 05:02:27 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48311/tests/kraken/driver.html?testName=json-parse-financial) 05:02:28 INFO - PROCESS | 646 | RSS: Main: 219099136 05:02:28 INFO - PROCESS | 646 | 05:02:30 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:30 INFO - PROCESS | 646 | RSS: Main: 209334272 05:02:30 INFO - PROCESS | 646 | 05:02:32 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:33 INFO - PROCESS | 646 | RSS: Main: 210558976 05:02:33 INFO - PROCESS | 646 | 05:02:35 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:36 INFO - PROCESS | 646 | RSS: Main: 216944640 05:02:36 INFO - PROCESS | 646 | 05:02:39 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:39 INFO - PROCESS | 646 | RSS: Main: 222257152 05:02:39 INFO - PROCESS | 646 | 05:02:42 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:43 INFO - PROCESS | 646 | RSS: Main: 222924800 05:02:43 INFO - PROCESS | 646 | 05:02:44 INFO - PROCESS | 646 | Cycle 1(1): loaded http://localhost:48311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48311/tests/kraken/driver.html?testName=ai-astar) 05:02:45 INFO - PROCESS | 646 | RSS: Main: 265367552 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | __start_tp_report 05:02:45 INFO - PROCESS | 646 | _x_x_mozilla_page_load 05:02:45 INFO - PROCESS | 646 | _x_x_mozilla_page_load_details 05:02:45 INFO - PROCESS | 646 | |i|pagename|runs| 05:02:45 INFO - PROCESS | 646 | |0;ai-astar;113;109;114;115;114;113;113;113;113;113 05:02:45 INFO - PROCESS | 646 | |1;audio-beat-detection;170;132;132;190;148;131;149;131;168;134 05:02:45 INFO - PROCESS | 646 | |2;audio-dft;162;160;161;162;162;162;161;161;161;162 05:02:45 INFO - PROCESS | 646 | |3;audio-fft;74;76;76;120;75;78;76;74;99;76 05:02:45 INFO - PROCESS | 646 | |4;audio-oscillator;86;87;113;85;85;87;120;87;87;124 05:02:45 INFO - PROCESS | 646 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 05:02:45 INFO - PROCESS | 646 | |6;imaging-darkroom;146;146;146;148;146;146;148;146;146;147 05:02:45 INFO - PROCESS | 646 | |7;imaging-desaturate;95;96;95;95;95;96;95;94;95;95 05:02:45 INFO - PROCESS | 646 | |8;json-parse-financial;62;62;62;64;63;63;63;63;64;63 05:02:45 INFO - PROCESS | 646 | |9;json-stringify-tinderbox;64;70;64;65;64;65;64;65;65;66 05:02:45 INFO - PROCESS | 646 | |10;stanford-crypto-aes;84;85;84;84;87;84;86;85;119;84 05:02:45 INFO - PROCESS | 646 | |11;stanford-crypto-ccm;137;133;142;150;139;139;131;140;136;142 05:02:45 INFO - PROCESS | 646 | |12;stanford-crypto-pbkdf2;171;175;167;169;170;172;166;167;171;170 05:02:45 INFO - PROCESS | 646 | |13;stanford-crypto-sha256-iterative;70;67;68;67;67;71;67;67;69;66 05:02:45 INFO - PROCESS | 646 | __end_tp_report 05:02:45 INFO - PROCESS | 646 | __start_cc_report 05:02:45 INFO - PROCESS | 646 | _x_x_mozilla_cycle_collect,1902 05:02:45 INFO - PROCESS | 646 | __end_cc_report 05:02:45 INFO - PROCESS | 646 | __startTimestamp1465387365213__endTimestamp 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | ------- Summary: start ------- 05:02:45 INFO - PROCESS | 646 | Number of tests: 14 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.56 (1.4%) stddev-sans-first:1.66 05:02:45 INFO - PROCESS | 646 | Values: 113.0 109.0 114.0 115.0 114.0 113.0 113.0 113.0 113.0 113.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:148.50 stddev:20.90 (14.1%) stddev-sans-first:20.67 05:02:45 INFO - PROCESS | 646 | Values: 170.0 132.0 132.0 190.0 148.0 131.0 149.0 131.0 168.0 134.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 05:02:45 INFO - PROCESS | 646 | Values: 162.0 160.0 161.0 162.0 162.0 162.0 161.0 161.0 161.0 162.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:15.16 (19.9%) stddev-sans-first:15.77 05:02:45 INFO - PROCESS | 646 | Values: 74.0 76.0 76.0 120.0 75.0 78.0 76.0 74.0 99.0 76.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:86.50 stddev:16.04 (18.5%) stddev-sans-first:16.59 05:02:45 INFO - PROCESS | 646 | Values: 86.0 87.0 113.0 85.0 85.0 87.0 120.0 87.0 87.0 124.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:02:45 INFO - PROCESS | 646 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:02:45 INFO - PROCESS | 646 | Values: 146.0 146.0 146.0 148.0 146.0 146.0 148.0 146.0 146.0 147.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:02:45 INFO - PROCESS | 646 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 05:02:45 INFO - PROCESS | 646 | Values: 62.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.81 (2.8%) stddev-sans-first:1.87 05:02:45 INFO - PROCESS | 646 | Values: 64.0 70.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 66.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.50 stddev:10.87 (12.9%) stddev-sans-first:11.42 05:02:45 INFO - PROCESS | 646 | Values: 84.0 85.0 84.0 84.0 87.0 84.0 86.0 85.0 119.0 84.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.50 stddev:5.30 (3.8%) stddev-sans-first:5.58 05:02:45 INFO - PROCESS | 646 | Values: 137.0 133.0 142.0 150.0 139.0 139.0 131.0 140.0 136.0 142.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.50 stddev:2.70 (1.6%) stddev-sans-first:2.83 05:02:45 INFO - PROCESS | 646 | Values: 171.0 175.0 167.0 169.0 170.0 172.0 166.0 167.0 171.0 170.0 05:02:45 INFO - PROCESS | 646 | 05:02:45 INFO - PROCESS | 646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.60 (2.4%) stddev-sans-first:1.50 05:02:45 INFO - PROCESS | 646 | Values: 70.0 67.0 68.0 67.0 67.0 71.0 67.0 67.0 69.0 66.0 05:02:45 INFO - PROCESS | 646 | -------- Summary: end -------- 05:02:45 INFO - PROCESS | 646 | 05:02:46 INFO - TEST-INFO | 646: exit 0 05:02:46 INFO - TEST-OK | kraken | took 64132ms 05:02:46 INFO - SUITE-END | took 1184s 05:02:46 INFO - Completed test suite (00:19:44) 05:02:46 INFO - javascript benchmark 05:02:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.5871439926814, 2674.9866250668742, 2711.5525938220194, 2729.454109178165, 2734.958975615365, 4531.36560881476, 4606.170889239936, 4660.533946605342, 4723.7165770053825, 4765.785539650716, 4628.768561571925, 4685.718856868591, 4687.859364219071, 4701.0, 4719.362886010396, 4128.153728485669, 4292.785360731967, 4375.912481750363, 4414.139242847646, 4456.309272062836, 4360.956390436087, 4382.824687012531, 4426.822927082912, 4439.933400998988, 4464.6651501137385, 4214.494260688706, 4267.039916018902, 4277.636400905895, 4298.591633794785, 4322.654187664979, 4279.40088387626, 4304.978475107636, 4323.11376167888, 4329.718568293082, 4348.5216626171095, 4300.6344460720875, 4308.80610372534, 4326.329418940069, 4353.064091220371, 4371.082072764723, 4400.405945197389, 4524.140413321458, 4626.653001024903, 4627.583517483409, 4644.187267228222, 5086.92369614456, 5094.668846525001, 5104.336436263262, 5105.846824595268, 5106.719130447824, 5086.949130508721, 5119.129747942859, 5119.462456442057, 5120.871978200537, 5124.948750512484, 4497.460304763449, 4652.464966528825, 4703.976480117578, 4707.576318131385, 4722.1028004679, 5177.456367081478, 5193.428722840485, 5195.532402083831, 5254.894902102013, 5259.579233661298, 4743.383360163157, 4966.8758281043265, 5024.598032157419, 5034.270030845581, 5035.967626636604, 4994.575461085776, 5062.544371006627, 5066.316047333563, 5079.822206222764, 5137.717425541631, 5013.774380152902, 5026.648134630541, 5028.296038554532, 5043.142665746832, 5074.314967479343, 4784.521547845187, 4981.601471882241, 4986.052649996489, 4988.102141614544, 4997.550220480174, 4179.26862799009, 4221.155768846243, 4235.639970602471, 4250.74495530263, 4262.531121576624, 3692.2800053989213, 3702.9074273143387, 3716.5168528091176, 3743.2700623378178, 3751.118487155516, 4211.368294755811, 4309.655227581786, 4324.329728892027, 4373.540778218305, 4379.233634114081, 4987.376577927759, 5032.018756342478, 5042.142835717937, 5053.1157047516535, 5054.393472783216, 4333.58830911063, 4334.696571239983, 4338.042753168673, 4338.436003319548, 4358.738475691469, 4374.5625437456, 4483.417155769729, 4521.570450807168, 4538.1377538267625, 4557.680962332671, 4766.809327626856, 4776.164171270083, 4784.138855006132, 4787.0904528139545, 4822.204336284473, 5010.398752149766, 5074.82238121664, 5076.441591424867, 5077.796888124433, 5082.288479612931, 4625.398698169217, 4697.647676424213, 4711.2933060039895, 4751.6436267279405, 4807.495213002724, 4959.380077490314, 4971.453140154653, 4974.676646017997, 4986.227134794112, 5027.974860125676, 5019.974900125476, 5050.04049230645, 5055.090083784954, 5056.797728090835, 5075.644704870771, 4759.0, 4861.392325959255, 4898.902021959612, 4917.6311776616185, 4950.257461380822, 4908.067467181224, 4930.334404855299, 4930.359053323045, 4945.950540494549, 4984.601231901367, 4853.6602437830425, 4862.027594481188, 4920.40955085392, 4930.531599498042, 4932.186189278729, 4797.376341075638, 4877.707337559757, 4918.606511479002, 4936.580390666833, 4946.08497427977, 4816.181249187576, 4820.927686084641, 4829.975850120867, 4835.516448355277, 4875.439324477588], "value": 4623.467508228847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5207887047316, 579.7680927628948, 586.4985437450979, 588.5438784941672, 589.7523040323064, 27503.0, 28279.151625451243, 39930.8003459983, 40503.79748101259, 41689.0, 37864.43203351945, 38436.80781596095, 38570.0, 42317.57682423175, 42457.36313955286, 7684.769456916288, 7869.095054068798, 7870.842583148334, 7876.960615196916, 7880.802979925519, 7401.222871598486, 9881.0, 10185.796284074315, 10195.13341365981, 10489.10842578378, 10061.295709300352, 10166.694999150037, 10172.745681357952, 10180.032896874785, 10180.745481362952, 10044.89955100447, 10092.747681307952, 10135.64525241613, 10143.949280253626, 10151.390916544993, 9829.3610915291, 9917.90082099177, 9935.80128397428, 9956.352837065568, 9956.352837065568, 39199.60800391988, 39452.80273598642, 39513.80243098795, 39584.40623390651, 39585.604143958764, 2866.140157952627, 2873.540233562641, 2894.8407837568925, 3086.24387025178, 3632.3824949758605, 29490.410191796043, 29784.40431191364, 29886.252843678863, 30320.84839575788, 31320.21699457509, 3389.372966001273, 3409.6760807723226, 3481.582210134775, 3490.912727181815, 3507.4037413639744, 252924.0, 253562.0, 253611.0, 253736.73131634408, 253846.0, 56161.0, 57230.14154787682, 57411.71294143503, 57483.0, 57585.0, 59696.40303596909, 59897.40102599005, 59978.400215998154, 59987.0, 60042.39957600455, 15054.096754194783, 15640.0, 15662.451814186677, 15668.728034435171, 15668.764968525482, 10753.408562528979, 11618.360990145455, 12048.87951120495, 12054.15620906528, 12115.454804533818, 18355.81644183568, 18487.352942647212, 18550.814491855177, 18612.627747444974, 18674.626507469773, 6867.484938629623, 7045.26024767392, 7095.82260443493, 7108.436144048301, 7123.857522849514, 768.9577073261024, 854.2354592639552, 927.3137877970254, 944.5230158769915, 980.7302991677345, 27360.58959115615, 28192.0, 28212.576811347848, 28594.0, 28908.566371504443, 954.4893481987103, 955.4060725131163, 1016.9949150254349, 1031.242037102729, 1096.550414330121, 14473.85526144725, 14856.480023199136, 14921.0, 15015.774763378558, 15244.23778811055, 372815.0, 374589.0, 377315.0, 377748.0, 379238.0, 50569.0, 51352.74323628358, 51448.0, 51457.0, 51620.74189629028, 1094.3051162511704, 1187.1867770577182, 1204.795184818583, 1228.8341073954903, 1235.6787235318702, 28025.579616305364, 29270.7072929268, 29407.411851762416, 29525.0, 29987.550186747652, 41421.585784142975, 41528.58471415368, 42042.57957420387, 42062.1587568253, 42067.7896610515, 295473.0, 296054.0, 297129.0, 297250.0, 298161.0, 21639.13443462244, 22951.770482294964, 23891.283261502183, 25289.367765806, 25290.36774080589, 42636.78681606572, 42693.35959960541, 42842.78578607087, 43340.0, 43847.0, 36060.0, 36216.27567448689, 36241.27517449689, 36775.632243678294, 37395.43906841345, 34687.306253875286, 36391.27217455583, 36425.45361819522, 36777.264454711294, 36808.44787328139, 36581.45127823138, 36890.63109368872, 37197.628023719415, 37396.81301593475, 37442.812785935894, 32063.35873282568, 33675.83162084272, 33677.0, 33710.0, 33771.3245735079, 25224.747752522973, 25266.36834079163, 25479.61780573256, 25599.50047821291, 26157.73842261629], "value": 18191.55719032539, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.9963100368996, 369.94635777812226, 376.2456275168289, 384.3159176665536, 385.2353079137911, 15802.683946321082, 17174.3130274789, 17383.82616173841, 17653.382131625396, 17856.196471158797, 16281.104539250337, 16660.75008874868, 17176.0, 17181.140942952865, 17218.0, 4896.55930966213, 5023.874403139914, 5029.647924645276, 5075.213341932006, 5083.84748457545, 3676.5036720042854, 3862.903427414309, 4973.701577905319, 5421.918671219935, 5787.13193021046, 5782.363939966622, 5784.652920824764, 5805.883882322351, 5813.273340832396, 5821.18503409523, 5682.573806964473, 5690.7439165237665, 5769.336526299467, 5777.19119323295, 5859.0, 3342.5153352763714, 4767.094252092092, 5072.898542029176, 5083.237514372837, 5155.510226528474, 19643.214271429126, 20140.697889531668, 20168.79831201684, 20786.37640870776, 20788.0, 1955.3938279133515, 1959.9706004409945, 1997.6304383688919, 2201.3726088064823, 2498.537770512461, 12422.937885310606, 12533.0, 12554.497820087185, 12683.112182147253, 12962.805557916545, 1705.7356109803, 1745.3978377459755, 1756.6223261998732, 1762.3391228289393, 1798.505411011969, 63166.0, 64106.35893641051, 65017.67491162561, 65353.67323163401, 65740.67129664369, 9194.90805091954, 9353.953230233805, 9359.78322818043, 9413.388129771543, 9612.51937403127, 12681.429335679917, 12728.745425091447, 12822.974162067012, 12829.486820527074, 12860.099793014399, 7220.097487814023, 7292.781216563511, 7297.781066568012, 7385.335319821242, 7419.369353604896, 7068.469864760164, 7073.0, 7074.0, 7235.819104522324, 7282.927170728331, 5875.941240587539, 5881.823545293648, 5931.525477961753, 5948.940510594839, 6011.158437818709, 1579.9447019354268, 1654.0985163086148, 1700.4388551777884, 1739.3390511605762, 1762.4712586224082, 792.4334101117729, 861.7931696392945, 875.3434923807145, 886.1537231943479, 895.3598177303129, 16645.0, 16830.518652327522, 17149.91425042892, 17296.308147673953, 17601.471955841345, 865.9781457879762, 874.191372979991, 882.7572417585216, 900.2392977933636, 924.8982611912819, 6736.629485378351, 10029.749256268651, 10118.54466549007, 10200.3369780964, 10209.132223760915, 352454.0, 395339.0, 396556.0, 396989.0, 397272.0, 53031.0, 71089.93365099527, 79351.60324198457, 81687.591562043, 82165.0, 921.424109931293, 957.2342126298932, 962.3888830592624, 981.4847205217318, 1006.4565134827111, 15483.922580387027, 15745.44890928812, 15778.842211577738, 15847.920760396586, 16248.67502649964, 31890.52164217585, 33155.33689326248, 33943.66056339405, 34555.30889382148, 35195.47206791849, 40445.59554404536, 43526.34710479282, 44920.32619510775, 48322.0, 50273.74863125661, 7355.8161045974275, 7562.962185189039, 7652.464327497022, 7679.884801727867, 7795.259450352208, 10957.616483423042, 11278.210525263154, 11568.595099171825, 11622.07023438106, 11780.175387722777, 9556.187724043533, 9577.808443831223, 10002.799944000933, 10018.0, 10347.0, 10048.547815348473, 10111.191104711459, 10275.537600807833, 10352.637657681946, 10416.583336666448, 9884.703458896245, 9949.801003980025, 10170.08469237772, 10205.38767673942, 10378.948105259426, 7691.230876912264, 7723.961380193063, 7751.612419379121, 7854.057513098464, 7925.643346049557, 9002.864957025518, 9543.0, 9716.125548700651, 9741.61033558678, 9886.752831179278], "value": 8224.737388767382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.2673958994394, 1361.6323592629988, 1447.3125265498888, 1514.7197768412846, 1760.5158581390124, 6425.0, 7379.557226566403, 7652.120006199289, 7655.425843061772, 7661.9616901915415, 7475.663595138219, 7514.66184021719, 7616.581088040156, 7800.960995195031, 7814.570198639072, 2085.7392825896763, 2124.2883633982633, 2124.872507649546, 2131.6163090643677, 2133.0614529607, 2071.4200023993308, 2103.6949642301856, 2161.91352345906, 2164.6428339323993, 2169.1648715244664, 2094.3193462124796, 2098.1397626972944, 2100.548382097849, 2115.7672656007903, 2128.9041993110345, 2082.7084208210863, 2108.230495869012, 2113.9682904756364, 2117.1108134583433, 2119.533702585444, 2039.6940458931278, 2086.3636590839787, 2087.7077209190725, 2088.6658134698528, 2089.2687559354104, 7454.2173071827765, 7502.024736784183, 7513.060867391576, 7517.0, 7576.166621671612, 4489.25927222008, 4633.9536604634195, 4648.651351148677, 4651.790669419885, 4654.953450465519, 2774.819636723627, 2883.942321153565, 2917.766578673701, 2933.9266518337, 2934.1784300395925, 912.6030176873081, 920.9447433154032, 938.0525669074216, 949.349695458613, 953.2564599612314, 10324.483775811255, 10573.154147668169, 10603.204759643058, 10625.043746062815, 10627.0, 4096.426500289962, 4162.875113746592, 4241.0, 4249.97875010623, 4259.0204253021975, 9048.0, 9090.59092340833, 9096.727098187064, 9110.498922559324, 9128.361014728906, 4693.27254275581, 4713.481517033124, 4716.080364328992, 4718.339432479455, 4729.5743383095, 3558.964410355915, 3687.9262414751556, 4146.91706165875, 4223.366495025771, 4237.300845360481, 3600.7839529628304, 3633.6548027937833, 3656.6160553142067, 3730.2539492101687, 3829.3872980323013, 1124.2523721725124, 1130.4460814201148, 1169.5497233564968, 1172.7185475485821, 1176.0650283025016, 814.4543156085437, 821.2731732416854, 824.4970567953544, 828.4904783558069, 841.5665932045001, 5079.6952182869145, 5091.87270318245, 5134.666246693953, 5411.810586629528, 5455.645383050089, 851.0850835352021, 912.5710915869531, 913.4930113786912, 922.7047344849584, 952.0099096939244, 3313.3207692422993, 3366.646502117291, 3381.594208694972, 3409.880654177092, 3475.270193259393, 9255.167034966886, 9647.903520964841, 9652.662156824477, 9729.70810875675, 9733.172680322252, 9471.052894710612, 9570.090841370058, 9585.856212156823, 9601.47191904438, 9602.90397096034, 7060.470464715167, 7338.082739657543, 7350.96324518374, 7372.078490188726, 7491.06361704776, 5059.727345789587, 5205.271262023244, 5253.947460525499, 5263.736813159403, 5271.841844744664, 8808.471491710518, 8888.64445422176, 8940.105989401009, 8996.955015224881, 9017.233535149586, 8581.141885811368, 8964.641414343354, 8980.191782739585, 8993.460392376479, 8995.82008359816, 5753.626014309057, 6537.836554086186, 6633.0, 6634.402903738686, 6644.136262285871, 7323.12122545298, 7366.079240094989, 7400.407967362706, 7426.368758655575, 7426.5915374654915, 6759.662016899037, 6827.590344579341, 6953.895691564731, 6978.057962175244, 7028.0, 6847.794566163023, 6857.108575885103, 6873.518853680194, 6945.270746571739, 6965.5124141309625, 5837.3870743571315, 6019.939800601938, 6049.304330002106, 6181.567290289637, 6211.0, 4202.2646036944025, 4289.077848262638, 4371.519132895442, 4380.3210502372185, 4405.867823965286, 4341.652667786507, 4453.04259584178, 4458.531854155397, 4532.4334458192725, 4575.9771201143785], "value": 4087.317805555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.12040355503274, 285.5360039935105, 289.4616014213563, 293.370719806016, 294.2100460264192, 4774.283857421384, 4794.928076078853, 4798.592119669824, 4812.157872372339, 4828.52729917375, 4727.05458908218, 4732.621390288778, 4743.244999350245, 4746.21687421575, 4756.738379389132, 3541.2917416516734, 3557.719221080409, 3669.7522842233634, 3686.594474607791, 3703.5370578677666, 3662.4323229899273, 3674.614165512623, 3691.7046636269033, 3710.3506886294927, 3711.6845068169237, 3489.5867173794654, 3677.7977211253506, 3680.11677197472, 3691.3724666806706, 3703.037210325308, 3520.0495866116007, 3541.5041894134843, 3614.837332320026, 3619.69232615228, 3659.963400366002, 3222.5649537312397, 3236.336551007038, 3238.983805080983, 3242.837858107085, 3245.2698142917657, 4565.5206203348835, 4579.793909274091, 4580.381648477446, 4582.747948862811, 4603.7698115094445, 3957.2085582883537, 4128.174365126986, 4135.462389889295, 4166.333386658151, 4171.353440216772, 4894.975525122387, 4920.646822123908, 4923.261510773377, 4925.3350797642215, 4926.261060840867, 3486.599041110254, 3489.8604055837736, 3492.4412094065083, 3497.2863296984547, 3508.4912687660403, 5055.51972562606, 5183.211791931778, 5197.636165468419, 5213.7393130343335, 5260.948230190229, 3546.1843775931166, 3547.5742910850863, 3549.307884962459, 3552.4493703476, 3565.607783143852, 3594.6699721102837, 3625.510556074949, 3626.2384899170943, 3628.3106209820576, 3630.4009838376373, 4155.522114956758, 4162.646175075092, 4163.375493675972, 4172.436721042681, 4189.0, 4678.877069503363, 4953.6037117030555, 4961.404631444249, 4980.2778597103215, 4988.6507944444265, 1211.3216598704753, 1219.737756382382, 1221.6274036418977, 1223.6023292429995, 1224.8101544260653, 757.7575175943755, 782.9882551761729, 786.2137862137862, 789.9802504937422, 792.2354927494995, 4024.4768180136393, 4266.168097221012, 4287.97856010718, 4419.359192917009, 4424.358468022183, 5146.665466744725, 5151.2273159026445, 5151.6136289778415, 5159.380874295033, 5168.638195326366, 4406.162829062468, 4422.226110430662, 4428.645708343325, 4451.710638808467, 4455.888602784891, 2614.5293847107323, 2696.61349705512, 2706.0, 2732.53546897028, 2743.684476285253, 4805.207140821725, 4805.879853003633, 4816.229403295526, 4847.5394837490385, 4866.31871537985, 5231.529162375328, 5234.581233501311, 5244.842654720364, 5263.473652634706, 5279.551238144724, 4585.495595484494, 4813.9037219255415, 4841.8379588899115, 4852.398708426141, 4864.197407427806, 5130.230465430215, 5149.510796474329, 5168.457311982338, 5170.681476223539, 5172.508611681884, 5058.241263810458, 5067.645264831426, 5086.389633243886, 5138.100832354397, 5157.355330583677, 4657.487676355666, 4819.421669399694, 4837.201861692922, 4848.539388758062, 4855.441624213119, 3446.327966046697, 3462.688358047788, 3466.86132554695, 3492.5285086514014, 3494.0, 5181.766820493162, 5187.559057480005, 5203.0, 5219.921701174561, 5229.0, 4836.758162091952, 4993.450720420678, 5004.199328107486, 5011.498850115106, 5070.492950705047, 4970.652054356305, 4976.676516026447, 4983.754061484628, 4995.425526064404, 4997.475265097112, 4940.6788558743565, 4941.678790878582, 4945.653804233669, 4998.6750861193905, 5003.899922001467, 4759.286107083965, 4794.472608013186, 4815.494373090775, 4991.625628077836, 5045.9243111352625, 4880.194767863263, 4899.877503062452, 4909.0672772173175, 4916.459189489082, 4922.409310882717], "value": 3719.144098727886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.1895125251526, 623.5479277523796, 624.1044101714041, 668.9230738465078, 737.963101844908, 12612.684682882933, 12644.431000604973, 12874.871251287495, 12976.416061277241, 13420.530281440151, 13244.271565063918, 13279.070465067425, 13412.189354437172, 13433.865661343383, 13439.126456780303, 627.8273474794422, 757.9507332023414, 785.2540086917451, 804.8792681097852, 817.435969181266, 794.9364050875917, 802.4543310548825, 803.2088392932985, 803.9276465118138, 805.8670319397293, 846.3652260804397, 850.3919697416346, 850.740524140137, 851.1701091435863, 851.2253848997414, 657.3426573426574, 807.5397023696466, 824.4558591329753, 834.0408530190269, 837.539353355652, 614.3518587889774, 614.62200746541, 614.6895817612077, 614.9631022138686, 615.6152404747033, 13815.309234538232, 13855.722885542333, 13894.58316250504, 13920.234387108705, 13958.371873265727, 12812.167209131376, 12997.610071697864, 13136.6715832104, 13260.668483287898, 13584.184948903, 11864.940675296655, 11916.34460104694, 11998.820017699742, 12045.518179272818, 12046.457909394097, 4104.384342348641, 4117.8970525736795, 4144.958550414487, 4166.458360413158, 4202.873913782591, 55456.44543554553, 55542.722286388715, 55574.72212638951, 55588.72205638946, 56245.71877140629, 10174.796504069876, 10340.844887326695, 10374.27380083402, 10624.575016999388, 10743.731406714895, 18475.445736627924, 19120.52198695016, 19142.521436964187, 20282.087306071262, 20309.18763249483, 7065.222825489295, 7080.327368899946, 7131.536450130725, 7142.857142857218, 7280.453965952574, 3555.982220088883, 3662.047867554402, 3676.117731744362, 3683.244934788362, 3710.406334986443, 2959.1270575180374, 3024.758019358446, 3067.2791893904914, 3072.877084916623, 3074.4158609864053, 521.7260938007577, 523.1786095829511, 531.0971348707213, 537.712323906708, 546.4535464535464, 428.6892003297647, 512.397932429394, 542.9728513574305, 554.2655980825423, 566.7761234312424, 7925.207479252144, 8186.2632363087605, 8267.255946964802, 8308.587570057576, 8352.290055345364, 424.9758083019907, 499.2635862103441, 513.186599240201, 556.7772890843614, 624.5752888036179, 3785.167263202091, 3831.616838316146, 3868.477755502971, 3985.501812273466, 4033.6974726895014, 86036.5698171505, 86064.56967715247, 88155.55922220348, 89195.55402222948, 90562.0, 49086.509134908905, 60988.0, 62212.37787622066, 78678.6066069666, 79702.0, 68339.0, 69254.65372673105, 69374.65312673405, 69817.0, 70011.29988700048, 7739.535627862347, 7804.375649948104, 7939.166387529457, 8027.478213916077, 8168.959155204186, 41799.79100104602, 43294.78352608217, 43933.340999884385, 44346.778266108464, 44364.11271774611, 57668.423315767985, 58844.0, 58873.70563147157, 59404.40595594161, 59677.70161149166, 10669.626563070255, 10716.73208169802, 10881.78236435251, 10940.945295273472, 11331.150163737588, 11280.09759219277, 11573.652790416301, 11957.103217258566, 12013.399330033639, 12149.210301330739, 9125.589348479201, 9364.297677674338, 9879.456629885426, 9888.258380621339, 9934.602615895572, 9678.89771153587, 9842.11420972116, 9880.505974701093, 9937.25470589723, 9993.500324983866, 10169.084782369326, 10502.317349372266, 10710.0, 10723.94638026805, 11005.394703291076, 9687.370320929118, 9922.851157232502, 9932.25508086882, 9940.701778946643, 10245.590176392861, 9726.270529710158, 10011.749706257111, 10071.414765659563, 10217.284790064625, 10227.59089636436], "value": 6416.061807411217, "unit": "score"}], "name": "dromaeo_css", "value": 6380.584033439042, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 115.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 132.0, 132.0, 190.0, 148.0, 131.0, 149.0, 131.0, 168.0, 134.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 120.0, 75.0, 78.0, 76.0, 74.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 113.0, 85.0, 85.0, 87.0, 120.0, 87.0, 87.0, 124.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 87.0, 84.0, 86.0, 85.0, 119.0, 84.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 142.0, 150.0, 139.0, 139.0, 131.0, 140.0, 136.0, 142.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 167.0, 169.0, 170.0, 172.0, 166.0, 167.0, 171.0, 170.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 67.0, 67.0, 71.0, 67.0, 67.0, 69.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 05:02:46 INFO - Return code: 0 05:02:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:47 ERROR - # TBPL SUCCESS # 05:02:47 INFO - Running post-action listener: _resource_record_post_action 05:02:47 INFO - ##### 05:02:47 INFO - ##### Finished run-tests step (success) 05:02:47 INFO - ##### 05:02:47 INFO - Running post-run listener: _resource_record_post_run 05:02:47 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 535666688; Read time: 0; Write time: 440620 05:02:47 INFO - TinderboxPrint: CPU usage
13.1% 05:02:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:02:47 INFO - TinderboxPrint: I/O write bytes / time
535,666,688 / 440,620 05:02:47 INFO - TinderboxPrint: CPU idle
8,337.0 (86.9%) 05:02:47 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 05:02:47 INFO - TinderboxPrint: Swap in / out
0 / 0 05:02:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237817856; Read time: 0; Write time: 246584 05:02:47 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 297263104; Read time: 0; Write time: 194032 05:02:47 INFO - Running post-run listener: _upload_blobber_files 05:02:47 INFO - Blob upload gear active. 05:02:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:47 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 05:02:47 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'] 05:02:47 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 05:02:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:02:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:48 INFO - (blobuploader) - INFO - Done attempting. 05:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:02:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:52 INFO - (blobuploader) - INFO - Done attempting. 05:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:53 INFO - (blobuploader) - INFO - Done attempting. 05:02:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:53 INFO - Return code: 0 05:02:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f2e99740948e04555879851856d937f0a2712b9d7de319b128b142f5796f5dc7b049ae8a83efb338fa6fb35f1688d42d5b910d2516d616db5ec7069609030dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/210a7cb324b875a056a63f84caf0774a34207386878eb99f8ba70bca642842a2290e9915c5159bfdf407e4daef5d48272982d1588153f2f30796833f85c01ec2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96ededf2e54b616c8f479602453b0148ebf95c4f778c0afe94e205294691eb50d2d691ddd03ce2be71de43a0768d96b10ca3188f03cebb3aa2c961fec86c1ada"} 05:02:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:53 INFO - Contents: 05:02:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f2e99740948e04555879851856d937f0a2712b9d7de319b128b142f5796f5dc7b049ae8a83efb338fa6fb35f1688d42d5b910d2516d616db5ec7069609030dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/210a7cb324b875a056a63f84caf0774a34207386878eb99f8ba70bca642842a2290e9915c5159bfdf407e4daef5d48272982d1588153f2f30796833f85c01ec2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96ededf2e54b616c8f479602453b0148ebf95c4f778c0afe94e205294691eb50d2d691ddd03ce2be71de43a0768d96b10ca3188f03cebb3aa2c961fec86c1ada"} 05:02:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:53 INFO - Copying logs to upload dir... 05:02:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.128899 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-08 05:02:53.323669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:02:53.326968) ========= 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=4300f881736b422476174874000001bc-1465386127.545686-852107915 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/2f2e99740948e04555879851856d937f0a2712b9d7de319b128b142f5796f5dc7b049ae8a83efb338fa6fb35f1688d42d5b910d2516d616db5ec7069609030dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/210a7cb324b875a056a63f84caf0774a34207386878eb99f8ba70bca642842a2290e9915c5159bfdf407e4daef5d48272982d1588153f2f30796833f85c01ec2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96ededf2e54b616c8f479602453b0148ebf95c4f778c0afe94e205294691eb50d2d691ddd03ce2be71de43a0768d96b10ca3188f03cebb3aa2c961fec86c1ada"} build_url:https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/LIyQ7wbbSUaXiy__4KDWOA/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/2f2e99740948e04555879851856d937f0a2712b9d7de319b128b142f5796f5dc7b049ae8a83efb338fa6fb35f1688d42d5b910d2516d616db5ec7069609030dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/210a7cb324b875a056a63f84caf0774a34207386878eb99f8ba70bca642842a2290e9915c5159bfdf407e4daef5d48272982d1588153f2f30796833f85c01ec2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96ededf2e54b616c8f479602453b0148ebf95c4f778c0afe94e205294691eb50d2d691ddd03ce2be71de43a0768d96b10ca3188f03cebb3aa2c961fec86c1ada"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:02:53.352813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:02:53.353156) ========= 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=4300f881736b422476174874000001bc-1465386127.545686-852107915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:02:53.435184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:02:53.435523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:02:53.435848) ========= ========= Total master_lag: 0.17 =========