builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1464879928.63 results: success (0) buildid: 20160602072746 builduid: d5be538e3f5147af8436157f0fa31b52 revision: a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.633159) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.634078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.634639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.649976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.650344) ========= 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-1464879928.553273-502650710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 08:05:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-06-02 08:05:29 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.763013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.763336) ========= 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-1464879928.553273-502650710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014254 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:28.813764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:05:28.814526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 --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 a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 --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-1464879928.553273-502650710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 08:05:29,492 truncating revision to first 12 chars 2016-06-02 08:05:29,492 Setting DEBUG logging. 2016-06-02 08:05:29,492 attempt 1/10 2016-06-02 08:05:29,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a9b6393d78b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 08:05:30,230 unpacking tar archive at: fx-team-a9b6393d78b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.077896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:05:29.906291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:29.906620) ========= script_repo_revision: a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:29.907036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:29.907308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:05:29.915855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 08:05:29.916341) ========= /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-1464879928.553273-502650710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:30 INFO - MultiFileLogger online at 20160602 08:05:30 in /builds/slave/test 08:05:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:05:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:30 INFO - {'append_to_log': False, 08:05:30 INFO - 'base_work_dir': '/builds/slave/test', 08:05:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:05:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:30 INFO - 'branch': 'Fx-Team-Non-PGO', 08:05:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:30 INFO - 'config_files': ('talos/linux_config.py',), 08:05:30 INFO - 'default_actions': ('clobber', 08:05:30 INFO - 'read-buildbot-config', 08:05:30 INFO - 'download-and-extract', 08:05:30 INFO - 'populate-webroot', 08:05:30 INFO - 'create-virtualenv', 08:05:30 INFO - 'install', 08:05:30 INFO - 'run-tests'), 08:05:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:30 INFO - 'download_minidump_stackwalk': True, 08:05:30 INFO - 'download_symbols': 'ondemand', 08:05:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:30 INFO - 'installer_path': 'installer.exe', 08:05:30 INFO - 'log_level': 'info', 08:05:30 INFO - 'log_name': 'talos', 08:05:30 INFO - 'log_to_console': True, 08:05:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:30 INFO - 'opt_config_files': (), 08:05:30 INFO - 'pip_index': False, 08:05:30 INFO - 'sps_profile': False, 08:05:30 INFO - 'sps_profile_interval': 0, 08:05:30 INFO - 'suite': 'dromaeojs', 08:05:30 INFO - 'system_bits': '32', 08:05:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:30 INFO - 'title': 'talos-linux64-ix-045', 08:05:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:30 INFO - 'use_talos_json': True, 08:05:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:30 INFO - 'work_dir': 'build'} 08:05:30 INFO - ##### 08:05:30 INFO - ##### Running clobber step. 08:05:30 INFO - ##### 08:05:30 INFO - Running pre-action listener: _resource_record_pre_action 08:05:30 INFO - Running main action method: clobber 08:05:30 INFO - rmtree: /builds/slave/test/build 08:05:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:31 INFO - Running post-action listener: _resource_record_post_action 08:05:31 INFO - ##### 08:05:31 INFO - ##### Finished clobber step (success) 08:05:31 INFO - ##### 08:05:31 INFO - ##### 08:05:31 INFO - ##### Running read-buildbot-config step. 08:05:31 INFO - ##### 08:05:31 INFO - Running pre-action listener: _resource_record_pre_action 08:05:31 INFO - Running main action method: read_buildbot_config 08:05:31 INFO - Using buildbot properties: 08:05:31 INFO - { 08:05:31 INFO - "project": "", 08:05:31 INFO - "product": "firefox", 08:05:31 INFO - "script_repo_revision": "production", 08:05:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:05:31 INFO - "repository": "", 08:05:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:05:31 INFO - "buildid": "20160602072746", 08:05:31 INFO - "pgo_build": "False", 08:05:31 INFO - "basedir": "/builds/slave/test", 08:05:31 INFO - "buildnumber": 3037, 08:05:31 INFO - "slavename": "talos-linux64-ix-045", 08:05:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:05:31 INFO - "platform": "ubuntu64_hw", 08:05:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:05:31 INFO - "branch": "fx-team", 08:05:31 INFO - "repo_path": "integration/fx-team", 08:05:31 INFO - "revision": "a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9", 08:05:31 INFO - "stage_platform": "linux64", 08:05:31 INFO - "builduid": "d5be538e3f5147af8436157f0fa31b52", 08:05:31 INFO - "slavebuilddir": "test" 08:05:31 INFO - } 08:05:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:05:31 INFO - Running post-action listener: _resource_record_post_action 08:05:31 INFO - ##### 08:05:31 INFO - ##### Finished read-buildbot-config step (success) 08:05:31 INFO - ##### 08:05:31 INFO - ##### 08:05:31 INFO - ##### Running download-and-extract step. 08:05:31 INFO - ##### 08:05:31 INFO - Running pre-action listener: _resource_record_pre_action 08:05:31 INFO - Running main action method: download_and_extract 08:05:31 INFO - mkdir: /builds/slave/test/build/tests 08:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:31 INFO - https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:05:31 INFO - Downloaded 1361 bytes. 08:05:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:05:31 INFO - Using the following test package requirements: 08:05:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'jsshell-linux-x86_64.zip'], 08:05:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:31 INFO - https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:33 INFO - Downloaded 22866922 bytes. 08:05:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:34 INFO - Return code: 0 08:05:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:34 INFO - https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:36 INFO - Downloaded 22866922 bytes. 08:05:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:05:37 INFO - Return code: 0 08:05: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')]} 08:05:37 INFO - https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:38 INFO - Downloaded 10834055 bytes. 08:05:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:05:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:05:38 INFO - Return code: 0 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:39 INFO - https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:05:40 INFO - Downloaded 55084648 bytes. 08:05:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:40 INFO - mkdir: /builds/slave/test/properties 08:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:40 INFO - Contents: 08:05:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:41 INFO - Running post-action listener: _resource_record_post_action 08:05:41 INFO - Running post-action listener: set_extra_try_arguments 08:05:41 INFO - ##### 08:05:41 INFO - ##### Finished download-and-extract step (success) 08:05:41 INFO - ##### 08:05:41 INFO - ##### 08:05:41 INFO - ##### Running populate-webroot step. 08:05:41 INFO - ##### 08:05:41 INFO - Running pre-action listener: _resource_record_pre_action 08:05:41 INFO - Running main action method: populate_webroot 08:05:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:41 INFO - '--tppagecycles', 08:05:41 INFO - '7'], 08:05:41 INFO - 'tests': ['tsvgm']}}, 08:05:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['damp', 'tps']}, 08:05:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'tests': ['damp', 'tps']}, 08:05:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['dromaeo_dom']}, 08:05:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['a11yr', 08:05:41 INFO - 'ts_paint', 08:05:41 INFO - 'tpaint', 08:05:41 INFO - 'sessionrestore', 08:05:41 INFO - 'sessionrestore_no_auto_restore', 08:05:41 INFO - 'tabpaint']}, 08:05:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['tsvgx', 08:05:41 INFO - 'tsvgr_opacity', 08:05:41 INFO - 'tart', 08:05:41 INFO - 'tscrollx', 08:05:41 INFO - 'cart']}, 08:05:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:41 INFO - 'tsvgr_opacity', 08:05:41 INFO - 'tart', 08:05:41 INFO - 'tscrollx', 08:05:41 INFO - 'cart']}, 08:05:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'talos_options': ['--disable-e10s'], 08:05:41 INFO - 'tests': ['tp5o']}, 08:05:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'tests': ['tp5o']}, 08:05:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'talos_options': ['--disable-e10s', 08:05:41 INFO - '--xperf_path', 08:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:41 INFO - 'tests': ['tp5n']}, 08:05:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:41 INFO - 'talos_options': ['--xperf_path', 08:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:41 INFO - 'tests': ['tp5n']}}, 08:05:41 INFO - 'talos.zip': {'path': '', 08:05:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:41 INFO - Running post-action listener: _resource_record_post_action 08:05:41 INFO - ##### 08:05:41 INFO - ##### Finished populate-webroot step (success) 08:05:41 INFO - ##### 08:05:41 INFO - ##### 08:05:41 INFO - ##### Running create-virtualenv step. 08:05:41 INFO - ##### 08:05:41 INFO - Running pre-action listener: _resource_record_pre_action 08:05:41 INFO - Running main action method: create_virtualenv 08:05:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:05:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:41 INFO - Using real prefix '/usr' 08:05:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:43 INFO - Installing pip.................done. 08:05:43 INFO - Return code: 0 08:05:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:43 INFO - Using env: {'DISPLAY': ':0', 08:05:43 INFO - 'HOME': '/home/cltbld', 08:05:43 INFO - 'LANG': 'en_US.UTF-8', 08:05:43 INFO - 'LANGUAGE': 'en_US:en', 08:05:43 INFO - 'LOGNAME': 'cltbld', 08:05:43 INFO - 'MAIL': '/var/mail/cltbld', 08:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:43 INFO - 'MOZ_NO_REMOTE': '1', 08:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:43 INFO - 'NO_EM_RESTART': '1', 08:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:43 INFO - 'PWD': '/builds/slave/test', 08:05:43 INFO - 'SHELL': '/bin/bash', 08:05:43 INFO - 'SHLVL': '1', 08:05:43 INFO - 'TERM': 'linux', 08:05:43 INFO - 'TMOUT': '86400', 08:05:43 INFO - 'USER': 'cltbld', 08:05:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:43 INFO - '_': '/tools/buildbot/bin/python'} 08:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:05:44 INFO - Cleaning up... 08:05:44 INFO - Return code: 0 08:05:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:44 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:44 INFO - Using env: {'DISPLAY': ':0', 08:05:44 INFO - 'HOME': '/home/cltbld', 08:05:44 INFO - 'LANG': 'en_US.UTF-8', 08:05:44 INFO - 'LANGUAGE': 'en_US:en', 08:05:44 INFO - 'LOGNAME': 'cltbld', 08:05:44 INFO - 'MAIL': '/var/mail/cltbld', 08:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:44 INFO - 'MOZ_NO_REMOTE': '1', 08:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:44 INFO - 'NO_EM_RESTART': '1', 08:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:44 INFO - 'PWD': '/builds/slave/test', 08:05:44 INFO - 'SHELL': '/bin/bash', 08:05:44 INFO - 'SHLVL': '1', 08:05:44 INFO - 'TERM': 'linux', 08:05:44 INFO - 'TMOUT': '86400', 08:05:44 INFO - 'USER': 'cltbld', 08:05:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:44 INFO - '_': '/tools/buildbot/bin/python'} 08:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:44 INFO - Downloading/unpacking psutil>=3.1.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:46 INFO - Installing collected packages: psutil 08:05:46 INFO - Running setup.py install for psutil 08:05:46 INFO - building 'psutil._psutil_linux' extension 08:05:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:05:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:05:46 INFO - building 'psutil._psutil_posix' extension 08:05:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:05:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:46 INFO - Successfully installed psutil 08:05:46 INFO - Cleaning up... 08:05:46 INFO - Return code: 0 08:05:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:05:46 INFO - Using env: {'DISPLAY': ':0', 08:05:46 INFO - 'HOME': '/home/cltbld', 08:05:46 INFO - 'LANG': 'en_US.UTF-8', 08:05:46 INFO - 'LANGUAGE': 'en_US:en', 08:05:46 INFO - 'LOGNAME': 'cltbld', 08:05:46 INFO - 'MAIL': '/var/mail/cltbld', 08:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:46 INFO - 'MOZ_NO_REMOTE': '1', 08:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:46 INFO - 'NO_EM_RESTART': '1', 08:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:46 INFO - 'PWD': '/builds/slave/test', 08:05:46 INFO - 'SHELL': '/bin/bash', 08:05:46 INFO - 'SHLVL': '1', 08:05:46 INFO - 'TERM': 'linux', 08:05:46 INFO - 'TMOUT': '86400', 08:05:46 INFO - 'USER': 'cltbld', 08:05:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:46 INFO - '_': '/tools/buildbot/bin/python'} 08:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:48 INFO - Installing collected packages: mozsystemmonitor 08:05:48 INFO - Running setup.py install for mozsystemmonitor 08:05:49 INFO - Successfully installed mozsystemmonitor 08:05:49 INFO - Cleaning up... 08:05:49 INFO - Return code: 0 08:05:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:49 INFO - Using env: {'DISPLAY': ':0', 08:05:49 INFO - 'HOME': '/home/cltbld', 08:05:49 INFO - 'LANG': 'en_US.UTF-8', 08:05:49 INFO - 'LANGUAGE': 'en_US:en', 08:05:49 INFO - 'LOGNAME': 'cltbld', 08:05:49 INFO - 'MAIL': '/var/mail/cltbld', 08:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:49 INFO - 'MOZ_NO_REMOTE': '1', 08:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:49 INFO - 'NO_EM_RESTART': '1', 08:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:49 INFO - 'PWD': '/builds/slave/test', 08:05:49 INFO - 'SHELL': '/bin/bash', 08:05:49 INFO - 'SHLVL': '1', 08:05:49 INFO - 'TERM': 'linux', 08:05:49 INFO - 'TMOUT': '86400', 08:05:49 INFO - 'USER': 'cltbld', 08:05:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:49 INFO - '_': '/tools/buildbot/bin/python'} 08:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - Downloading docopt-0.6.1.tar.gz 08:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:51 INFO - Running setup.py install for blobuploader 08:05:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:52 INFO - Running setup.py install for requests 08:05:52 INFO - Running setup.py install for docopt 08:05:52 INFO - Successfully installed blobuploader requests docopt 08:05:52 INFO - Cleaning up... 08:05:52 INFO - Return code: 0 08:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:52 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:52 INFO - Using env: {'DISPLAY': ':0', 08:05:52 INFO - 'HOME': '/home/cltbld', 08:05:52 INFO - 'LANG': 'en_US.UTF-8', 08:05:52 INFO - 'LANGUAGE': 'en_US:en', 08:05:52 INFO - 'LOGNAME': 'cltbld', 08:05:52 INFO - 'MAIL': '/var/mail/cltbld', 08:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:52 INFO - 'MOZ_NO_REMOTE': '1', 08:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:52 INFO - 'NO_EM_RESTART': '1', 08:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:52 INFO - 'PWD': '/builds/slave/test', 08:05:52 INFO - 'SHELL': '/bin/bash', 08:05:52 INFO - 'SHLVL': '1', 08:05:52 INFO - 'TERM': 'linux', 08:05:52 INFO - 'TMOUT': '86400', 08:05:52 INFO - 'USER': 'cltbld', 08:05:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:52 INFO - '_': '/tools/buildbot/bin/python'} 08:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:52 INFO - Running setup.py (path:/tmp/pip-84n3o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:52 INFO - Running setup.py (path:/tmp/pip-fLNT2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:52 INFO - Running setup.py (path:/tmp/pip-ykueZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:53 INFO - Running setup.py (path:/tmp/pip-nwlfju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:53 INFO - Running setup.py (path:/tmp/pip-Awz5IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:53 INFO - Running setup.py (path:/tmp/pip-h8NsU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:53 INFO - Running setup.py (path:/tmp/pip-WZkCQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:53 INFO - Running setup.py (path:/tmp/pip-jqLwoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:53 INFO - Running setup.py (path:/tmp/pip-bM5JXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:53 INFO - Running setup.py (path:/tmp/pip-ymZagi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:53 INFO - Running setup.py (path:/tmp/pip-a2N49o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:53 INFO - Running setup.py (path:/tmp/pip-CkBA2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:53 INFO - Running setup.py (path:/tmp/pip-wtfakP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:53 INFO - Running setup.py (path:/tmp/pip-8cU9JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:53 INFO - Running setup.py (path:/tmp/pip-7rlkfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:53 INFO - Running setup.py (path:/tmp/pip-ill1Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:53 INFO - Running setup.py (path:/tmp/pip-EDV6U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:54 INFO - Running setup.py install for manifestparser 08:05:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Running setup.py install for mozcrash 08:05:54 INFO - Running setup.py install for mozdebug 08:05:54 INFO - Running setup.py install for mozdevice 08:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Running setup.py install for mozfile 08:05:54 INFO - Running setup.py install for mozhttpd 08:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Running setup.py install for mozinfo 08:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Running setup.py install for mozInstall 08:05:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:54 INFO - Running setup.py install for mozleak 08:05:54 INFO - Running setup.py install for mozlog 08:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Running setup.py install for moznetwork 08:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Running setup.py install for mozprocess 08:05:55 INFO - Running setup.py install for mozprofile 08:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Running setup.py install for mozrunner 08:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Running setup.py install for mozscreenshot 08:05:55 INFO - Running setup.py install for moztest 08:05:55 INFO - Running setup.py install for mozversion 08:05:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:56 INFO - Running setup.py (path:/tmp/pip-AaFkrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:56 INFO - Running setup.py (path:/tmp/pip-0clQ3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:56 INFO - Running setup.py (path:/tmp/pip-BpFith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:56 INFO - Running setup.py (path:/tmp/pip-K88vQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:56 INFO - Running setup.py (path:/tmp/pip-QP9Zcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:56 INFO - Running setup.py (path:/tmp/pip-oNm291-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:56 INFO - Running setup.py (path:/tmp/pip-MMb_CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:56 INFO - Running setup.py (path:/tmp/pip-HfMO4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:56 INFO - Running setup.py (path:/tmp/pip-HqBMBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:56 INFO - Running setup.py (path:/tmp/pip-EyHZST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:56 INFO - Running setup.py (path:/tmp/pip-J3huI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:56 INFO - Running setup.py (path:/tmp/pip-LAYkLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:56 INFO - Running setup.py (path:/tmp/pip-zLgs7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:56 INFO - Running setup.py (path:/tmp/pip-wjip4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:57 INFO - Running setup.py (path:/tmp/pip-0Nztfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:57 INFO - Running setup.py (path:/tmp/pip-NDhq96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:57 INFO - Running setup.py (path:/tmp/pip-rHfMs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:59 INFO - Downloading blessings-1.6.tar.gz 08:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:59 INFO - Installing collected packages: blessings 08:05:59 INFO - Running setup.py install for blessings 08:05:59 INFO - Successfully installed blessings 08:05:59 INFO - Cleaning up... 08:05:59 INFO - Return code: 0 08:05:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:59 INFO - Reading from file tmpfile_stdout 08:05:59 INFO - Current package versions: 08:05:59 INFO - argparse == 1.2.1 08:05:59 INFO - blessings == 1.6 08:05:59 INFO - blobuploader == 1.2.4 08:05:59 INFO - docopt == 0.6.1 08:05:59 INFO - manifestparser == 1.1 08:05:59 INFO - mozInstall == 1.12 08:05:59 INFO - mozcrash == 0.17 08:05:59 INFO - mozdebug == 0.1 08:05:59 INFO - mozdevice == 0.48 08:05:59 INFO - mozfile == 1.2 08:05:59 INFO - mozhttpd == 0.7 08:05:59 INFO - mozinfo == 0.9 08:05:59 INFO - mozleak == 0.1 08:05:59 INFO - mozlog == 3.2 08:05:59 INFO - moznetwork == 0.27 08:05:59 INFO - mozprocess == 0.22 08:05:59 INFO - mozprofile == 0.28 08:05:59 INFO - mozrunner == 6.11 08:05:59 INFO - mozscreenshot == 0.1 08:05:59 INFO - mozsystemmonitor == 0.3 08:05:59 INFO - moztest == 0.7 08:05:59 INFO - mozversion == 1.4 08:05:59 INFO - psutil == 3.1.1 08:05:59 INFO - requests == 1.2.3 08:05:59 INFO - wsgiref == 0.1.2 08:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:59 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 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:59 INFO - Using env: {'DISPLAY': ':0', 08:05:59 INFO - 'HOME': '/home/cltbld', 08:05:59 INFO - 'LANG': 'en_US.UTF-8', 08:05:59 INFO - 'LANGUAGE': 'en_US:en', 08:05:59 INFO - 'LOGNAME': 'cltbld', 08:05:59 INFO - 'MAIL': '/var/mail/cltbld', 08:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:59 INFO - 'MOZ_NO_REMOTE': '1', 08:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:59 INFO - 'NO_EM_RESTART': '1', 08:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:59 INFO - 'PWD': '/builds/slave/test', 08:05:59 INFO - 'SHELL': '/bin/bash', 08:05:59 INFO - 'SHLVL': '1', 08:05:59 INFO - 'TERM': 'linux', 08:05:59 INFO - 'TMOUT': '86400', 08:05:59 INFO - 'USER': 'cltbld', 08:05:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:59 INFO - '_': '/tools/buildbot/bin/python'} 08:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:59 INFO - Cleaning up... 08:05:59 INFO - Return code: 0 08:05:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:59 INFO - Using env: {'DISPLAY': ':0', 08:05:59 INFO - 'HOME': '/home/cltbld', 08:05:59 INFO - 'LANG': 'en_US.UTF-8', 08:05:59 INFO - 'LANGUAGE': 'en_US:en', 08:05:59 INFO - 'LOGNAME': 'cltbld', 08:05:59 INFO - 'MAIL': '/var/mail/cltbld', 08:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:59 INFO - 'MOZ_NO_REMOTE': '1', 08:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:59 INFO - 'NO_EM_RESTART': '1', 08:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:59 INFO - 'PWD': '/builds/slave/test', 08:05:59 INFO - 'SHELL': '/bin/bash', 08:05:59 INFO - 'SHLVL': '1', 08:05:59 INFO - 'TERM': 'linux', 08:05:59 INFO - 'TMOUT': '86400', 08:05:59 INFO - 'USER': 'cltbld', 08:05:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:59 INFO - '_': '/tools/buildbot/bin/python'} 08:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:00 INFO - Downloading/unpacking jsonschema 08:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:02 INFO - warning: no files found matching '*.txt' 08:06:02 INFO - no previously-included directories found matching 'build' 08:06:02 INFO - no previously-included directories found matching 'dist' 08:06:02 INFO - no previously-included directories found matching '.git*' 08:06:02 INFO - Installing collected packages: jsonschema, functools32 08:06:02 INFO - Running setup.py install for functools32 08:06:02 INFO - warning: no files found matching '*.txt' 08:06:02 INFO - no previously-included directories found matching 'build' 08:06:02 INFO - no previously-included directories found matching 'dist' 08:06:02 INFO - no previously-included directories found matching '.git*' 08:06:02 INFO - Successfully installed jsonschema functools32 08:06:02 INFO - Cleaning up... 08:06:02 INFO - Return code: 0 08:06:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5566d9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, '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-1464879928.553273-502650710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:02 INFO - Downloading/unpacking flake8 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:06:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:06:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:05 INFO - no previously-included directories found matching 'docs/_build' 08:06:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:06:05 INFO - Running setup.py install for pep8 08:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:05 INFO - no previously-included directories found matching 'docs/_build' 08:06:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:06:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:06:05 INFO - Cleaning up... 08:06:05 INFO - Return code: 0 08:06:05 INFO - Running post-action listener: _resource_record_post_action 08:06:05 INFO - Running post-action listener: _start_resource_monitoring 08:06:05 INFO - Starting resource monitoring. 08:06:05 INFO - ##### 08:06:05 INFO - ##### Finished create-virtualenv step (success) 08:06:05 INFO - ##### 08:06:05 INFO - ##### 08:06:05 INFO - ##### Running install step. 08:06:05 INFO - ##### 08:06:05 INFO - Running pre-action listener: _resource_record_pre_action 08:06:05 INFO - Running main action method: install 08:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:05 INFO - Reading from file tmpfile_stdout 08:06:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:05 INFO - Reading from file tmpfile_stdout 08:06:05 INFO - Output received: 08:06:05 INFO - Usage: mozinstall [options] installer 08:06:05 INFO - Options: 08:06:05 INFO - -h, --help show this help message and exit 08:06:05 INFO - -d DEST, --destination=DEST 08:06:05 INFO - Directory to install application into. [default: 08:06:05 INFO - "/builds/slave/test"] 08:06:05 INFO - --app=APP Application being installed. [default: firefox] 08:06:05 INFO - mkdir: /builds/slave/test/build/application 08:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:06:21 INFO - Reading from file tmpfile_stdout 08:06:21 INFO - Output received: 08:06:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:06:21 INFO - Running post-action listener: _resource_record_post_action 08:06:21 INFO - ##### 08:06:21 INFO - ##### Finished install step (success) 08:06:21 INFO - ##### 08:06:21 INFO - ##### 08:06:21 INFO - ##### Running run-tests step. 08:06:21 INFO - ##### 08:06:21 INFO - Running pre-action listener: _resource_record_pre_action 08:06:21 INFO - Running main action method: run_tests 08:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:21 INFO - Python 2.7.3 08:06:21 INFO - Return code: 0 08:06:21 INFO - grabbing minidump binary from tooltool 08:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:21 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 0xe0d9c0>, '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 0xe0e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:06:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:06:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:06:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:21 INFO - Return code: 0 08:06:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:06:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:06:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:06:22 INFO - Return code: 0 08:06:22 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/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.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 08:06:22 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/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.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 08:06:22 INFO - Using env: {'DISPLAY': ':0', 08:06:22 INFO - 'HOME': '/home/cltbld', 08:06:22 INFO - 'LANG': 'en_US.UTF-8', 08:06:22 INFO - 'LANGUAGE': 'en_US:en', 08:06:22 INFO - 'LOGNAME': 'cltbld', 08:06:22 INFO - 'MAIL': '/var/mail/cltbld', 08:06:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:22 INFO - 'MOZ_NO_REMOTE': '1', 08:06:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:22 INFO - 'NO_EM_RESTART': '1', 08:06:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:22 INFO - 'PWD': '/builds/slave/test', 08:06:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:22 INFO - 'SHELL': '/bin/bash', 08:06:22 INFO - 'SHLVL': '1', 08:06:22 INFO - 'TERM': 'linux', 08:06:22 INFO - 'TMOUT': '86400', 08:06:22 INFO - 'USER': 'cltbld', 08:06:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464879928.553273-502650710', 08:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:22 INFO - '_': '/tools/buildbot/bin/python'} 08:06:22 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/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.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 08:06:22 INFO - mozversion application_buildid: 20160602072746 08:06:22 INFO - mozversion application_changeset: a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 08:06:22 INFO - mozversion application_display_name: Nightly 08:06:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:22 INFO - mozversion application_name: Firefox 08:06:22 INFO - mozversion application_remotingname: firefox 08:06:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:22 INFO - mozversion application_vendor: Mozilla 08:06:22 INFO - mozversion application_version: 49.0a1 08:06:22 INFO - mozversion platform_buildid: 20160602072746 08:06:22 INFO - mozversion platform_changeset: a9b6393d78b0f4d3b0d8a1a80e75b76247c68ff9 08:06:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:22 INFO - mozversion platform_version: 49.0a1 08:06:22 INFO - using testdate: 1464879982 08:06:22 INFO - actual date: 1464879982 08:06:22 INFO - starting webserver on 'localhost:33502' 08:06:22 INFO - SUITE-START | Running 2 tests 08:06:22 INFO - TEST-START | dromaeo_css 08:06:22 INFO - operating with platform_type : linux_ 08:06:22 INFO - Initialising browser for dromaeo_css test... 08:06:22 INFO - TEST-INFO | started process 3651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEiQ4__/profile http://localhost:33502/getInfo.html) 08:06:27 INFO - PROCESS | 3651 | __metrics Screen width/height:1600/1200 08:06:27 INFO - PROCESS | 3651 | colorDepth:24 08:06:27 INFO - PROCESS | 3651 | Browser inner width/height: 1024/697 08:06:27 INFO - PROCESS | 3651 | __metrics 08:06:28 ERROR - PROCESS | 3651 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:06:29 INFO - TEST-INFO | 3651: exit 0 08:06:29 INFO - Browser initialized. 08:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:29 INFO - TEST-INFO | started process 3734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEiQ4__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:41 INFO - PROCESS | 3734 | RSS: Main: 158019584 08:06:41 INFO - PROCESS | 3734 | 08:07:32 INFO - PROCESS | 3734 | 1464880052802 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:09:43 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33502/tests/dromaeo/cssquery-ext.html) 08:09:44 INFO - PROCESS | 3734 | RSS: Main: 276635648 08:09:44 INFO - PROCESS | 3734 | 08:12:47 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-ext.html (next: http://localhost:33502/tests/dromaeo/cssquery-jquery.html) 08:12:48 INFO - PROCESS | 3734 | RSS: Main: 238182400 08:12:48 INFO - PROCESS | 3734 | 08:15:50 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33502/tests/dromaeo/cssquery-mootools.html) 08:15:51 INFO - PROCESS | 3734 | RSS: Main: 232251392 08:15:51 INFO - PROCESS | 3734 | 08:18:53 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33502/tests/dromaeo/cssquery-prototype.html) 08:18:53 INFO - PROCESS | 3734 | RSS: Main: 240001024 08:18:53 INFO - PROCESS | 3734 | 08:21:56 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33502/tests/dromaeo/cssquery-yui.html) 08:21:57 INFO - PROCESS | 3734 | RSS: Main: 222289920 08:21:57 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-yui.html (next: http://localhost:33502/tests/dromaeo/cssquery-dojo.html) 08:25:00 INFO - PROCESS | 3734 | RSS: Main: 292716544 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | __start_tp_report 08:25:00 INFO - PROCESS | 3734 | _x_x_mozilla_page_load 08:25:00 INFO - PROCESS | 3734 | _x_x_mozilla_page_load_details 08:25:00 INFO - PROCESS | 3734 | |i|pagename|runs| 08:25:00 INFO - PROCESS | 3734 | |0;dojo.html;2628.0670362021483;2653.3499292673296;2677.5849743289787;2702.959455608166;2711.471263103694;4535.863924082275;4623.14471822713;4639.814407423699;4721.457032441266;4775.617950563956;4655.4413470383515;4689.85930422087;4702.882427939303;4758.571728544431;4762.28565715142;4292.441982542281;4314.82740690372;4333.566643335673;4362.585554372337;4389.407429996957;83.68993396072081;4419.491758447772;4419.823207071713;4426.86719398417;4445.110977804452;4207.158568286324;4236;4259.659227261812;4385.276429389147;4419.690621656486;4276.572342765729;4342.544032876534;4343.370211319341;4371.540988196225;4384.408104905829;4312.5903039211225;4323.935140972888;4326.718763280377;4361.302191649321;4367.213901497729;4536.206163921333;4590.357349971006;4591.79336929839;4639.234526303156;4640.953590464086;5034.0686972910125;5104.9744751276;5149.201873709581;5150.716710580917;5157.045946499909;5078.7460626968505;5112.590992720573;5112.744362781883;5122.564582010534;5124.641275110744;4545.568171023748;4632.675712700112;4689.882752931136;4693.202155633482;4711.1519926413575;5190;5205.531502164823;5211.817586384458;5215.374155101412;5218.634695571273;4843.370361852936;4963.851084467472;4968.776405061781;5003.774830132653;5020.447750747415;5047.041062198171;5096.311997880312;5105.387353517602;5108.846734597968;5117.5905927526455;5055.570276526537;5063.3923929128005;5066.544011039025;5067.1639179535705;5100.285959965608;4758.738269395148;4803.351547541037;5007.899842003139;5009.499050095034;5053.191489361684;4239.321708526621;4310.719803212781;4313.331433627793;4335.414719012893;4376.715513491613;3743.3074881147077;3743.9625603743616;3768.8869333920024;3773.509443772292;3811.656950874379;4259.829606815754;4273.081287523198;4338.197433474817;4340.262155433584;4385.583369579885;5081.415637201769;5115.411727651293;5143.17709166539;5144.7942082316285;5148.382194136728;4384.12317536494;4397.714148580332;4407.228734971367;4410.955890441119;4459.175052615276;4494.056248187917;4558.794854231567;4620.075984802986;4624.5144259852905;4665.440147182292;4748.928766068511;4790.712557246507;4800.231962885921;4806.038792241496;4814.494478079751;5089.160288552495;5116.258142569232;5122.820701275437;5125.8974820502635;5172.896542069062;4623.491415944176;4758.643101767312;4811.591014763784;4828.758562071812;4880.267959806058;4971.701697898137;4989.80040798364;5012.523810238022;5019.623528235324;5069.949300506948;5068.619853511075;5082.161443361804;5087.542121209109;5105.7191854448365;5130.2817605536;4769.666123371469;4878;4928.556429921325;4949.554540091409;4949.604031677529;4971.080350135237;4991.15150424436;4993.975030124971;5010.649254552146;5044.520770526794;4912.1158191525865;4925.38432695913;4935;4976.900461990812;5001.299818025552;4865.805367785249;4917.655764096479;4944.950550494449;5082.567981721447;5107.080725469451;4844.2007068833245;4865.343178670834;4866.05112003156;4915.5330243626795;4920.21276595743 08:25:00 INFO - PROCESS | 3734 | |1;ext.html;537.9326742089517;583.2213994317589;594.56002558107;595.348093837248;606.5208485296616;27361.315967100832;41646.79176604116;41941.58058419415;42163.15673686525;42224;42662;43044.78477607608;43120.353194702104;43127.353089703676;43237.13525729484;7464.066991626047;7760.340371068466;7953.562554059525;7956.801079972989;10030.74923126924;10005.04952029556;10140.847887281696;10142.036506531867;10142.340747851365;10143.442110683909;10068.446235457048;10180.898191018106;10181.134603558707;10183.745406364864;10189.592416303376;7564.50830696003;9741.90258097417;10085.193184545218;10098.29311948164;10109.292349535535;10066.245031622657;10156.949215253877;10167.59329626814;10182.083612474913;10184.032516910882;39275.214495710214;39528.80235598804;39602.40596391056;39713.80143099266;39769.40345894814;2925.297928497145;2941.7352438280445;3033.7421319187897;3068.324968506925;3108.4870996285586;29737.851310743525;29835.850820745756;29903.551446728317;30438.239044023856;30485.085447436613;3535.2045789697368;3547.5033495310677;3579.0515513388973;3583.623719509466;3649.7445178837493;404758;408997;412067;412325;412457;57955.71022144862;58382.12426813601;58634.7068264656;58973.705131474926;58994.75528845955;34517.309653806784;34878.47682284717;35070.649293506736;37008.074798129725;37098;14195.361208745631;14212.64468388278;14233.359498822578;14241.78637320441;14250.073745206528;10809.405482698527;11859.229150105215;11906.52373905034;11932.88067119335;12368;19275.903620482088;19309.903450482656;19336.903315483614;19344.70982935257;19356.128974196195;6809.421199198025;6843.452523798084;6907.481938854606;6979.82550436233;7184.281571842878;857.1771099744316;925.9351845370759;1044.070777008463;1058.9735256618492;1077.6228320087907;29150.27124321909;29241.561376579368;29577.26056848596;29615.85192074069;29737.702622973928;965.1699538396973;974.8050389922043;1028.6091285311534;1033.0289527843802;1073.130764081097;14860.256987150598;15223.31495082724;15267;15438.15090170029;15495.225238738018;361966;363417;364094;365199;365421;52161.47838521642;52556.47443525592;52684.73657631764;52732.20901686401;52752.736236318575;1115.893990070942;1121.8092924202906;1200.159888078366;1231.2181764579377;1266.6580023393817;27633.723662763114;29243.85378073096;29879.402411952073;30345.848270758506;30422.847885760428;42940.35589466223;43490.782546087066;43720.34419483774;43752;43788;293029;295639;296338;296682.6824524672;297147;22804.65793013073;23067.6539851899;23267.76732232656;23321.300360989197;25789.742102578733;43352.56647433611;43769.34345984749;44196.33705494356;44207.77896110499;44467.77766111149;36465.27069458543;36477.81761091178;36845.81577092098;37024.81487592545;37292.627073728916;36638.45042324314;37393;37465.43801843029;37604.81197593995;38131.237375252895;35343;35802.64197357993;36268.637313626525;36488;36659.26681466409;32176.839115804272;32930.67069329276;33519.832400838815;33842.66157338395;33953;25210.74789252084;25265.494690105726;25425.61861572115;25944.57066769649;26119.216423507325 08:25:00 INFO - PROCESS | 3734 | |2;jquery.html;368.81559220389806;376.700523084148;380.17881376227353;386.5863526027152;390.6972096625115;15837.287322070506;16369.345226190968;16447.2598733057;16672.74990875138;16683.91658041708;15715.764263536055;16183.757243641356;16670.33318667255;16689;16705.081220532866;4884.462709101996;5045.798168073273;5053.191489361703;5067.695938243699;5070.036693028332;3665.7983810890523;3845.0771814764394;5005.699658020512;5519.254900588409;5821.6507009579345;5839.299284085894;5844.357120716739;5851.210086638292;5862.824115276549;5864.618799778023;5650.434956504317;5773.971130144343;5810.564207684441;5854.4438278363705;5857.502112320458;3341.448660970937;4823.2282834746275;5098.745062746848;5123.026624941249;5135.666181698178;19432.514187145294;19936.601267974704;19987.800121998738;20490.077946492296;20491.848355922713;1862.9254829806928;1946.2993322403922;1995.321590659183;2251.7748225177515;2510.835450605305;12568;12917.612471625866;12928.353582320846;13472.461101555926;13507.25710085945;1731.8354756298259;1741.2077504735441;1779.1015537153785;1824.8357647811629;1844.317602487075;62413;62642;63924.68037659782;65112.674436627516;65346.346536534504;9166.450012999241;9268.860967085498;9277.350585458953;9501.429914205031;9543.713688589354;12622.747545049047;12796.424160912595;12797.040221983389;12844.807327890088;12916.677083072998;7335.633218339061;7394.630268486554;7453.180150183475;7545.094588649397;7545.453182097657;7307.671154798047;7344.265573442613;7352.228016058344;7526.774196774106;7545.886811697829;5763;5967.940320596826;5969.253843269591;6003.909941350796;6146.200993870768;1572.512521118434;1655.8095818980971;1678.3789997700928;1747.3709464592737;1805.341050516552;879.0681877210178;884.7036242858715;886.7118186589385;895.7671005538476;901.427593478133;16617.335306587844;16763.580910477336;17198.570035748955;17302.480925572254;17648.911755441142;905.6422713028448;915.7893684452613;923.676713150392;925.0564424287189;949.9097585729345;9513.524323783784;9921.65274215399;10011;10089.416921965765;10150.238732095122;164052;165934;166534;345900;346595;75620;77016.22983770202;79627.60186199032;80199.59900200462;80558.19441805506;917.4082716647724;941.7880976780307;953.6709835106877;956.9138777509918;989.1098011789303;15270.083794971893;15428.69142617119;15437.691246174789;15480.148591827558;15878.9206053969;33545.66454335425;34896.82551587226;34953.126171845906;35020.47469287912;35357.469637954935;47294.29058564193;47544.7622761884;48572.27141592808;49143.26285105655;49167.7541612304;6929.272426395156;7373.225811289737;7384.113906331059;7410.6665200065045;7446.515976461513;9992;10074.589557461815;10680;11534.365609891202;11551.133664974992;9510.50207346704;9529;9676.661316853877;9795;10034.247431442816;9720.805583888141;9971.252156088467;9977.750556236153;10138.695839124837;10227.02843229892;9369.156775890202;9525.666601668909;10129.139023182817;10169.593216271267;10260.692179234336;6729.461643068641;7025.824354391181;7129.679164437509;7207.0630817995425;7255.709771609077;9291;9358.11097945694;9926.454045027593;10194.490275486047;10202.28583999113 08:25:00 INFO - PROCESS | 3734 | |3;mootools.html;1216.4465168348402;1374.4090041282248;1450.586582823895;1496.5585152380047;1700.2433916906973;6515.64163970982;7459.104907411104;7689.61551922403;7698.692052317914;7889.763307100782;7622.352100071486;7753.10839253486;7762.45662803604;7763.961180194091;7773.455858089936;1897.2126567474481;1960.40207736641;1961.8626696131278;2215.235743668436;2247.505548779266;1927.6915693489045;2171.6851056596784;2268.2968279833303;2272.4659704969317;2276.237460450751;2184.1154332495366;2200.8899555022267;2210.027587861336;2210.4142402263415;2213.1147540983657;1837.2650939624123;2101.2120454829437;2104.905279262437;2107.3993911735233;2108.5677436125557;2126.776688447722;2174.510735084609;2188.321620297713;2193.2981445937307;2193.407779899434;7518.210587888302;7580.50726702768;7611.923880761177;7616;7616.352610028154;4506.526814684444;4656.627469802442;4661.46393164787;4664.393628828265;4666.416697912761;2874.755645770112;2985.507391280436;3054.9083527494213;3060.3114299282706;3071.754259659222;882.3338379523483;891.8394688955985;972.8394814855541;975.5073687787622;992.5781542844335;10468.842967355497;10469.84295235572;10477.057064864199;10509.527071281811;10530.526126324334;4155.210510003089;4240.554741752072;4300.16146851361;4376.562343765661;4381.40850985113;8981.46111233315;8995.955020224988;9016.143466370684;9065;9065.320100992452;4693.108309421199;4699.95300047002;4704.411948506437;4705.411823522059;4709.7174169549935;3620.456931460302;3714.3871261242134;4191.895202619959;4309.116631090682;4310.31035034393;3620.6560376764164;3711.870084547028;3761.8307176177136;3790.6019867913474;3790.962090379061;1177.3406892140429;1192.2071822238288;1192.3918801411344;1196.1029228078942;1206.5234232478122;876.0932434929817;877.3902138014018;881.9559022048871;888.3324390389275;890.9688160914467;5141.691498510101;5158.819441319611;5176.792928282902;5196.272521846944;5410.458954104558;804.5574933786394;851.1488511488511;852.3692467573951;874.728834061443;903.2412773270353;3591.102224443889;3723.2925744108534;3724.7392682512505;3776.244751049801;3845.730798844054;9185.770355741026;9369.953150234342;9468.14786669203;9520.476373799369;9533.38033027865;9145.496997665192;9405.43567385959;9430.19843313326;9472.810543789086;9487.573059212215;6891.862162756717;6921.1002569665625;7034.085568876013;7035.12060992376;7040.190378106583;5198.272241886063;5202.323697919246;5220.373555173252;5368.248445217595;5372.1404575269335;8702;8704.34717396185;8726.432781869158;8786.428882122642;8817.206451419403;8506.319494440553;8897.555122243992;8910.019897811366;8921.955390223007;8934.061923498199;5686.09022556389;5877.441643043904;5880.529557635294;6082.513398928164;6223.657698826608;6905.37851593359;6966.512344135862;7190.20907700163;7398.778036658909;7427.368673662799;6683.832904177434;6795.898061528982;6812.523123381316;6882.69027893736;6886.311368863074;6687;6700.262971073275;6749.5612785168805;6836.794896153124;6847;6178.814635560941;6282.340354262737;6296.842578935563;6339.809805705651;6346.587471814318;4528.773561321855;4543.136804007228;4605.0099228665995;4665.906681866411;4735.668503204743;4681.157391669532;4740.1230772307235;4754.548317909793;4809.663323567317;4830.541098595628 08:25:00 INFO - PROCESS | 3734 | |4;prototype.html;291.22098386815264;294.71559944653404;303.078640931568;305.45933697355696;312.07469851889147;4902.6813257138265;4915.70505769654;4975.179095449246;4985.476524964881;4988.152014157588;4622.838200662977;4703.200455922492;4719.221328480797;4758.214894542405;4900.509949005098;3695.5565332160045;3722.1997270586885;3768.265188288271;3812.7902965336893;3877.728559000857;3799.4490798834154;3844.154286057063;3847.1343947611845;3851.845926162964;3854.672352850011;3592.3533763922483;3785.5078839750795;3801.2777572261184;3802.4676545283683;3815.351390263662;3788.2423515296773;3788.3370410178245;3791.620837916214;3798.7340886137845;3799.3920972644246;3321.717653999413;3334.949975750366;3336.099253201646;3339.1652086978256;3342.9331413371597;4743.667943243974;4756.191447453941;4757.191277482836;4761;4761.619070474354;4076.5719599442223;4346.608805207515;4359.866434726962;4362.956370436318;4413.867583972486;5103.795848166069;5119.259451786411;5146.485351464861;5150.094465047919;5159.793608255665;3597.6402359764074;3598.4962105305276;3613.2050948791225;3618.2220822523022;3618.3848745713294;5136.768845401966;5341.519263266325;5383.631202270988;5430.945690543083;5493.148561972901;3639.6542328478754;3677.742558020913;3688.3729765939856;3694.796786176786;3720.311742327678;3747.9063023424633;3765.811709414518;3771.17034252464;3771.641694039062;3782.8108594570162;4265.658747300208;4306.956930430718;4312.180685669713;4365.738055716667;4367.410399596078;4996.950030499721;5123.846284611468;5183.041137389595;5189.948100519022;5209.531142197145;1215.9148859579745;1284.865089165624;1299.2789002103734;1307.895368370528;1319.4524272427027;869.5261082709939;882.6601758323092;894.8344556257114;899.3030401438806;904.7243386824678;4490.618297444688;4497.190505709003;4525.366448697119;4539.933115717804;4546.704464209815;5222.6083043771105;5228.4510126436935;5245.501677340647;5266.657667251693;5279.392869819943;4360.258756011485;4464.214314274316;4469.664775141812;4507.954920450754;4509.729416234971;2789.9442011159663;2821.50623640862;2853.586229996639;2858.2139911524496;2862.2128914548666;5037.596992240612;5041.193409054534;5053.9747301264;5054.949450505448;5064.670796398296;5190.169572868398;5372.892542149135;5419.3225846769155;5435.852838128917;5456.563474921997;4972.726500042532;4998.850034498971;5011.173156429149;5021.1421773943875;5035;5021.5229553192385;5261.631685781958;5262.236975638434;5281.445448228034;5290.761915713879;5140.717260550556;5171.431142574389;5185.662931909414;5206;5217.113090774654;4927.260910863399;4948.406191257072;4958.785097651099;4988.326575912205;4999.525045120708;3730.142067324476;3732.9813350933073;3739.495168152265;3740.6072362401555;3749;5062.265971434195;5296.841094767163;5351.277577527139;5354.464553544614;5356.1697936819855;5174.7153906533995;5186.58507319406;5188.325517682828;5216.739163041757;5222.399424066281;4990.925136123034;5175.301334319819;5203.635745497779;5207.29701490294;5221.590170653978;4916.8770780730765;5023.673461225008;5179.730965913375;5187.19598462239;5192.169252919514;5236.136037553761;5249.527542521191;5255.89488210226;5259.947400525945;5262.552683021833;5107.540321371094;5132.178851383761;5132.769025393941;5133.666311689728;5142.254373115952 08:25:00 INFO - PROCESS | 3734 | |5;yui.html;624.687656171914;661.9172603424569;679.6601699150425;741.9183889772124;760.2967255288856;12518.436670349833;12821.743565128692;12998.155119917199;13095.803562946563;13100.475980960773;12056.27662340258;12073.939630301837;12086.456109475073;13697.794533081988;14136;804.7746630943316;805.1545876829335;811.3063330852125;811.6307080278459;811.7767613906163;635.4408120853642;769.4613770360742;795.6181033104114;802.3821657323857;809.7894547417684;841.0916210492653;841.4362377207286;843.0768308701993;843.7215718812807;844.0377969115214;828.2173346187855;828.9792755181109;830.6469750356074;831.1522247307743;832.2634468495364;489.32228863024613;491.2582001178247;496.03521151360616;497.06055555001075;603.3966033966034;12314.13801033928;13115.27865967381;13172.60482185536;13214.405351759195;13233.86766132336;12093.637190884288;12661.936690316581;12732.681682957907;12810.308887625579;12998.15511991727;10708;10739;10781.838272425919;10856;10876.293040952312;3350.681685239923;3392.4741665041956;3409.4203985322556;3439.8452069656923;3511.508388825541;58165.418345816426;58220.417795822344;59030.70484647549;59070.409295906924;59166.40833591695;10261.9486902565;10375.760241078207;10380.221483388625;10476.47617619116;10542.103921166634;18622.627547448974;18668;18764.53088672767;18767.812321876878;18769.7184542232;6620.337966203341;6644.335566443317;6650.434713049445;6651.301613330627;6755.594664320059;3690.225052738901;3717.1636381813873;3796.1648437343742;3796.8291426885858;3819.7135214858995;2923.7953343266195;3031.9242018949262;3044.34546572488;3045.421369939704;3046.573479712842;522.7516929458553;525.6504424557703;526.1581469648609;546.4235231830378;551.3879593651044;551.589066145724;573.131705466219;577.5148874945066;599.7541008186622;612.2928018139056;8390.874136887951;8467.49195048299;8488.533130677872;8564.400491965502;8789.121087891288;569.3736889421604;592.2803793390965;606.2088973889029;620.88203241384;631.88626047311;4217.198732240864;4277.508086570022;4296.2481565725875;4356.302991521405;4420.646348292129;57693;81926;83612;84797.15202848017;85668.57165714132;73014.26985730181;73177.26822731811;74795.62602186954;75626.62186689141;78075;68361.3163868365;69065.65467172633;70135.64932175307;72031.6398418015;72931.63534182402;8625.309975202093;8687.435316704394;8761.474311541328;8779.473231606124;8928.598213080297;40882.79558602188;41847.58152418437;42129.78935105305;42141.78929105335;42872.571274286856;53279;57767;58363;59311.11033334417;60545;10903.509342079467;11161.386123763272;11272.267302625303;11273.830892536782;11590.826137608112;12124.644766390373;12390.75218495607;12710.682232944251;12712.555060572835;12745.936270318589;11782.17524773292;12081.456334464794;12244;12476.563320283747;12494.750104998031;9198.724038278862;9773.85339219898;10124.34191777532;11803.940980295387;12008;11692.649220523397;11802.52789888395;11897.46461409256;12431.62705118848;12486.750264994467;10099.69700908974;10165.84751228747;10241.846372304273;10448.58205671795;10526.421046842192;10237.436940968319;10404.47977601132;10557.252175477903;10612.204084693525;10661.147108231478 08:25:00 INFO - PROCESS | 3734 | __end_tp_report 08:25:00 INFO - PROCESS | 3734 | __start_cc_report 08:25:00 INFO - PROCESS | 3734 | _x_x_mozilla_cycle_collect,1149 08:25:00 INFO - PROCESS | 3734 | __end_cc_report 08:25:00 INFO - PROCESS | 3734 | __startTimestamp1464881100717__endTimestamp 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | ------- Summary: start ------- 08:25:00 INFO - PROCESS | 3734 | Number of tests: 6 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#0] dojo.html Cycles:165 Average:4658.36 Median:4806.04 stddev:610.33 (12.7%) stddev-sans-first:591.05 08:25:00 INFO - PROCESS | 3734 | Values: 2628.1 2653.3 2677.6 2703.0 2711.5 4535.9 4623.1 4639.8 4721.5 4775.6 4655.4 4689.9 4702.9 4758.6 4762.3 4292.4 4314.8 4333.6 4362.6 4389.4 83.7 4419.5 4419.8 4426.9 4445.1 4207.2 4236.0 4259.7 4385.3 4419.7 4276.6 4342.5 4343.4 4371.5 4384.4 4312.6 4323.9 4326.7 4361.3 4367.2 4536.2 4590.4 4591.8 4639.2 4641.0 5034.1 5105.0 5149.2 5150.7 5157.0 5078.7 5112.6 5112.7 5122.6 5124.6 4545.6 4632.7 4689.9 4693.2 4711.2 5190.0 5205.5 5211.8 5215.4 5218.6 4843.4 4963.9 4968.8 5003.8 5020.4 5047.0 5096.3 5105.4 5108.8 5117.6 5055.6 5063.4 5066.5 5067.2 5100.3 4758.7 4803.4 5007.9 5009.5 5053.2 4239.3 4310.7 4313.3 4335.4 4376.7 3743.3 3744.0 3768.9 3773.5 3811.7 4259.8 4273.1 4338.2 4340.3 4385.6 5081.4 5115.4 5143.2 5144.8 5148.4 4384.1 4397.7 4407.2 4411.0 4459.2 4494.1 4558.8 4620.1 4624.5 4665.4 4748.9 4790.7 4800.2 4806.0 4814.5 5089.2 5116.3 5122.8 5125.9 5172.9 4623.5 4758.6 4811.6 4828.8 4880.3 4971.7 4989.8 5012.5 5019.6 5069.9 5068.6 5082.2 5087.5 5105.7 5130.3 4769.7 4878.0 4928.6 4949.6 4949.6 4971.1 4991.2 4994.0 5010.6 5044.5 4912.1 4925.4 4935.0 4976.9 5001.3 4865.8 4917.7 4945.0 5082.6 5107.1 4844.2 4865.3 4866.1 4915.5 4920.2 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#1] ext.html Cycles:180 Average:50945.75 Median:34235.15 stddev:94775.50 (276.8%) stddev-sans-first:94965.80 08:25:00 INFO - PROCESS | 3734 | Values: 537.9 583.2 594.6 595.3 606.5 27361.3 41646.8 41941.6 42163.2 42224.0 42662.0 43044.8 43120.4 43127.4 43237.1 7464.1 7760.3 7953.6 7956.8 10030.7 10005.0 10140.8 10142.0 10142.3 10143.4 10068.4 10180.9 10181.1 10183.7 10189.6 7564.5 9741.9 10085.2 10098.3 10109.3 10066.2 10156.9 10167.6 10182.1 10184.0 39275.2 39528.8 39602.4 39713.8 39769.4 2925.3 2941.7 3033.7 3068.3 3108.5 29737.9 29835.9 29903.6 30438.2 30485.1 3535.2 3547.5 3579.1 3583.6 3649.7 404758.0 408997.0 412067.0 412325.0 412457.0 57955.7 58382.1 58634.7 58973.7 58994.8 34517.3 34878.5 35070.6 37008.1 37098.0 14195.4 14212.6 14233.4 14241.8 14250.1 10809.4 11859.2 11906.5 11932.9 12368.0 19275.9 19309.9 19336.9 19344.7 19356.1 6809.4 6843.5 6907.5 6979.8 7184.3 857.2 925.9 1044.1 1059.0 1077.6 29150.3 29241.6 29577.3 29615.9 29737.7 965.2 974.8 1028.6 1033.0 1073.1 14860.3 15223.3 15267.0 15438.2 15495.2 361966.0 363417.0 364094.0 365199.0 365421.0 52161.5 52556.5 52684.7 52732.2 52752.7 1115.9 1121.8 1200.2 1231.2 1266.7 27633.7 29243.9 29879.4 30345.8 30422.8 42940.4 43490.8 43720.3 43752.0 43788.0 293029.0 295639.0 296338.0 296682.7 297147.0 22804.7 23067.7 23267.8 23321.3 25789.7 43352.6 43769.3 44196.3 44207.8 44467.8 36465.3 36477.8 36845.8 37024.8 37292.6 36638.5 37393.0 37465.4 37604.8 38131.2 35343.0 35802.6 36268.6 36488.0 36659.3 32176.8 32930.7 33519.8 33842.7 33953.0 25210.7 25265.5 25425.6 25944.6 26119.2 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#2] jquery.html Cycles:180 Average:19841.37 Median:5025.75 stddev:43239.10 (860.4%) stddev-sans-first:43335.68 08:25:00 INFO - PROCESS | 3734 | Values: 368.8 376.7 380.2 386.6 390.7 15837.3 16369.3 16447.3 16672.7 16683.9 15715.8 16183.8 16670.3 16689.0 16705.1 4884.5 5045.8 5053.2 5067.7 5070.0 3665.8 3845.1 5005.7 5519.3 5821.7 5839.3 5844.4 5851.2 5862.8 5864.6 5650.4 5774.0 5810.6 5854.4 5857.5 3341.4 4823.2 5098.7 5123.0 5135.7 19432.5 19936.6 19987.8 20490.1 20491.8 1862.9 1946.3 1995.3 2251.8 2510.8 12568.0 12917.6 12928.4 13472.5 13507.3 1731.8 1741.2 1779.1 1824.8 1844.3 62413.0 62642.0 63924.7 65112.7 65346.3 9166.5 9268.9 9277.4 9501.4 9543.7 12622.7 12796.4 12797.0 12844.8 12916.7 7335.6 7394.6 7453.2 7545.1 7545.5 7307.7 7344.3 7352.2 7526.8 7545.9 5763.0 5967.9 5969.3 6003.9 6146.2 1572.5 1655.8 1678.4 1747.4 1805.3 879.1 884.7 886.7 895.8 901.4 16617.3 16763.6 17198.6 17302.5 17648.9 905.6 915.8 923.7 925.1 949.9 9513.5 9921.7 10011.0 10089.4 10150.2 164052.0 165934.0 166534.0 345900.0 346595.0 75620.0 77016.2 79627.6 80199.6 80558.2 917.4 941.8 953.7 956.9 989.1 15270.1 15428.7 15437.7 15480.1 15878.9 33545.7 34896.8 34953.1 35020.5 35357.5 47294.3 47544.8 48572.3 49143.3 49167.8 6929.3 7373.2 7384.1 7410.7 7446.5 9992.0 10074.6 10680.0 11534.4 11551.1 9510.5 9529.0 9676.7 9795.0 10034.2 9720.8 9971.3 9977.8 10138.7 10227.0 9369.2 9525.7 10129.1 10169.6 10260.7 6729.5 7025.8 7129.7 7207.1 7255.7 9291.0 9358.1 9926.5 10194.5 10202.3 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#3] mootools.html Cycles:180 Average:5073.49 Median:5211.35 stddev:2796.86 (53.7%) stddev-sans-first:2789.68 08:25:00 INFO - PROCESS | 3734 | Values: 1216.4 1374.4 1450.6 1496.6 1700.2 6515.6 7459.1 7689.6 7698.7 7889.8 7622.4 7753.1 7762.5 7764.0 7773.5 1897.2 1960.4 1961.9 2215.2 2247.5 1927.7 2171.7 2268.3 2272.5 2276.2 2184.1 2200.9 2210.0 2210.4 2213.1 1837.3 2101.2 2104.9 2107.4 2108.6 2126.8 2174.5 2188.3 2193.3 2193.4 7518.2 7580.5 7611.9 7616.0 7616.4 4506.5 4656.6 4661.5 4664.4 4666.4 2874.8 2985.5 3054.9 3060.3 3071.8 882.3 891.8 972.8 975.5 992.6 10468.8 10469.8 10477.1 10509.5 10530.5 4155.2 4240.6 4300.2 4376.6 4381.4 8981.5 8996.0 9016.1 9065.0 9065.3 4693.1 4700.0 4704.4 4705.4 4709.7 3620.5 3714.4 4191.9 4309.1 4310.3 3620.7 3711.9 3761.8 3790.6 3791.0 1177.3 1192.2 1192.4 1196.1 1206.5 876.1 877.4 882.0 888.3 891.0 5141.7 5158.8 5176.8 5196.3 5410.5 804.6 851.1 852.4 874.7 903.2 3591.1 3723.3 3724.7 3776.2 3845.7 9185.8 9370.0 9468.1 9520.5 9533.4 9145.5 9405.4 9430.2 9472.8 9487.6 6891.9 6921.1 7034.1 7035.1 7040.2 5198.3 5202.3 5220.4 5368.2 5372.1 8702.0 8704.3 8726.4 8786.4 8817.2 8506.3 8897.6 8910.0 8922.0 8934.1 5686.1 5877.4 5880.5 6082.5 6223.7 6905.4 6966.5 7190.2 7398.8 7427.4 6683.8 6795.9 6812.5 6882.7 6886.3 6687.0 6700.3 6749.6 6836.8 6847.0 6178.8 6282.3 6296.8 6339.8 6346.6 4528.8 4543.1 4605.0 4665.9 4735.7 4681.2 4740.1 4754.5 4809.7 4830.5 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#4] prototype.html Cycles:180 Average:4263.78 Median:4909.19 stddev:1247.48 (25.4%) stddev-sans-first:1214.83 08:25:00 INFO - PROCESS | 3734 | Values: 291.2 294.7 303.1 305.5 312.1 4902.7 4915.7 4975.2 4985.5 4988.2 4622.8 4703.2 4719.2 4758.2 4900.5 3695.6 3722.2 3768.3 3812.8 3877.7 3799.4 3844.2 3847.1 3851.8 3854.7 3592.4 3785.5 3801.3 3802.5 3815.4 3788.2 3788.3 3791.6 3798.7 3799.4 3321.7 3334.9 3336.1 3339.2 3342.9 4743.7 4756.2 4757.2 4761.0 4761.6 4076.6 4346.6 4359.9 4363.0 4413.9 5103.8 5119.3 5146.5 5150.1 5159.8 3597.6 3598.5 3613.2 3618.2 3618.4 5136.8 5341.5 5383.6 5430.9 5493.1 3639.7 3677.7 3688.4 3694.8 3720.3 3747.9 3765.8 3771.2 3771.6 3782.8 4265.7 4307.0 4312.2 4365.7 4367.4 4997.0 5123.8 5183.0 5189.9 5209.5 1215.9 1284.9 1299.3 1307.9 1319.5 869.5 882.7 894.8 899.3 904.7 4490.6 4497.2 4525.4 4539.9 4546.7 5222.6 5228.5 5245.5 5266.7 5279.4 4360.3 4464.2 4469.7 4508.0 4509.7 2789.9 2821.5 2853.6 2858.2 2862.2 5037.6 5041.2 5054.0 5054.9 5064.7 5190.2 5372.9 5419.3 5435.9 5456.6 4972.7 4998.9 5011.2 5021.1 5035.0 5021.5 5261.6 5262.2 5281.4 5290.8 5140.7 5171.4 5185.7 5206.0 5217.1 4927.3 4948.4 4958.8 4988.3 4999.5 3730.1 3733.0 3739.5 3740.6 3749.0 5062.3 5296.8 5351.3 5354.5 5356.2 5174.7 5186.6 5188.3 5216.7 5222.4 4990.9 5175.3 5203.6 5207.3 5221.6 4916.9 5023.7 5179.7 5187.2 5192.2 5236.1 5249.5 5255.9 5259.9 5262.6 5107.5 5132.2 5132.8 5133.7 5142.3 08:25:00 INFO - PROCESS | 3734 | 08:25:00 INFO - PROCESS | 3734 | [#5] yui.html Cycles:180 Average:16614.61 Median:4326.28 stddev:22378.80 (517.3%) stddev-sans-first:22409.36 08:25:00 INFO - PROCESS | 3734 | Values: 624.7 661.9 679.7 741.9 760.3 12518.4 12821.7 12998.2 13095.8 13100.5 12056.3 12073.9 12086.5 13697.8 14136.0 804.8 805.2 811.3 811.6 811.8 635.4 769.5 795.6 802.4 809.8 841.1 841.4 843.1 843.7 844.0 828.2 829.0 830.6 831.2 832.3 489.3 491.3 496.0 497.1 603.4 12314.1 13115.3 13172.6 13214.4 13233.9 12093.6 12661.9 12732.7 12810.3 12998.2 10708.0 10739.0 10781.8 10856.0 10876.3 3350.7 3392.5 3409.4 3439.8 3511.5 58165.4 58220.4 59030.7 59070.4 59166.4 10261.9 10375.8 10380.2 10476.5 10542.1 18622.6 18668.0 18764.5 18767.8 18769.7 6620.3 6644.3 6650.4 6651.3 6755.6 3690.2 3717.2 3796.2 3796.8 3819.7 2923.8 3031.9 3044.3 3045.4 3046.6 522.8 525.7 526.2 546.4 551.4 551.6 573.1 577.5 599.8 612.3 8390.9 8467.5 8488.5 8564.4 8789.1 569.4 592.3 606.2 620.9 631.9 4217.2 4277.5 4296.2 4356.3 4420.6 57693.0 81926.0 83612.0 84797.2 85668.6 73014.3 73177.3 74795.6 75626.6 78075.0 68361.3 69065.7 70135.6 72031.6 72931.6 8625.3 8687.4 8761.5 8779.5 8928.6 40882.8 41847.6 42129.8 42141.8 42872.6 53279.0 57767.0 58363.0 59311.1 60545.0 10903.5 11161.4 11272.3 11273.8 11590.8 12124.6 12390.8 12710.7 12712.6 12745.9 11782.2 12081.5 12244.0 12476.6 12494.8 9198.7 9773.9 10124.3 11803.9 12008.0 11692.6 11802.5 11897.5 12431.6 12486.8 10099.7 10165.8 10241.8 10448.6 10526.4 10237.4 10404.5 10557.3 10612.2 10661.1 08:25:00 INFO - PROCESS | 3734 | -------- Summary: end -------- 08:25:00 INFO - PROCESS | 3734 | 08:25:01 INFO - TEST-INFO | 3734: exit 0 08:25:01 INFO - TEST-OK | dromaeo_css | took 1118464ms 08:25:01 INFO - TEST-START | kraken 08:25:01 INFO - operating with platform_type : linux_ 08:25:01 INFO - Initialising browser for kraken test... 08:25:01 INFO - TEST-INFO | started process 3911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptwuLQe/profile http://localhost:33502/getInfo.html) 08:25:05 INFO - PROCESS | 3911 | __metrics Screen width/height:1600/1200 08:25:05 INFO - PROCESS | 3911 | colorDepth:24 08:25:05 INFO - PROCESS | 3911 | Browser inner width/height: 1024/697 08:25:05 INFO - PROCESS | 3911 | __metrics 08:25:06 ERROR - PROCESS | 3911 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:25:07 INFO - TEST-INFO | 3911: exit 0 08:25:07 INFO - Browser initialized. 08:25:07 INFO - Running cycle 1/1 for kraken test... 08:25:07 INFO - TEST-INFO | started process 3993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptwuLQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:19 INFO - PROCESS | 3993 | RSS: Main: 157663232 08:25:19 INFO - PROCESS | 3993 | 08:25:22 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:23 INFO - PROCESS | 3993 | RSS: Main: 214904832 08:25:23 INFO - PROCESS | 3993 | 08:25:26 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-dft) 08:25:26 INFO - PROCESS | 3993 | RSS: Main: 200241152 08:25:26 INFO - PROCESS | 3993 | 08:25:30 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-fft) 08:25:30 INFO - PROCESS | 3993 | RSS: Main: 270639104 08:25:30 INFO - PROCESS | 3993 | 08:25:32 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-oscillator) 08:25:33 INFO - PROCESS | 3993 | RSS: Main: 180629504 08:25:33 INFO - PROCESS | 3993 | 08:25:35 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:36 INFO - PROCESS | 3993 | RSS: Main: 185053184 08:25:36 INFO - PROCESS | 3993 | 08:25:39 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:40 INFO - PROCESS | 3993 | RSS: Main: 220532736 08:25:40 INFO - PROCESS | 3993 | 08:25:43 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:44 INFO - PROCESS | 3993 | RSS: Main: 216702976 08:25:44 INFO - PROCESS | 3993 | 08:25:47 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33502/tests/kraken/driver.html?testName=json-parse-financial) 08:25:47 INFO - PROCESS | 3993 | RSS: Main: 219115520 08:25:47 INFO - PROCESS | 3993 | 08:25:49 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:49 INFO - PROCESS | 3993 | RSS: Main: 208035840 08:25:49 INFO - PROCESS | 3993 | 08:25:51 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:52 INFO - PROCESS | 3993 | RSS: Main: 210874368 08:25:52 INFO - PROCESS | 3993 | 08:25:54 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:55 INFO - PROCESS | 3993 | RSS: Main: 216182784 08:25:55 INFO - PROCESS | 3993 | 08:25:58 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:58 INFO - PROCESS | 3993 | RSS: Main: 221253632 08:25:58 INFO - PROCESS | 3993 | 08:26:01 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:02 INFO - PROCESS | 3993 | RSS: Main: 220028928 08:26:02 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33502/tests/kraken/driver.html?testName=ai-astar) 08:26:04 INFO - PROCESS | 3993 | RSS: Main: 262967296 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | __start_tp_report 08:26:04 INFO - PROCESS | 3993 | _x_x_mozilla_page_load 08:26:04 INFO - PROCESS | 3993 | _x_x_mozilla_page_load_details 08:26:04 INFO - PROCESS | 3993 | |i|pagename|runs| 08:26:04 INFO - PROCESS | 3993 | |0;ai-astar;119;111;115;116;114;116;114;116;115;116 08:26:04 INFO - PROCESS | 3993 | |1;audio-beat-detection;155;138;132;177;133;132;161;139;177;129 08:26:04 INFO - PROCESS | 3993 | |2;audio-dft;161;161;160;162;162;162;162;161;161;161 08:26:04 INFO - PROCESS | 3993 | |3;audio-fft;82;75;75;112;78;76;76;77;102;75 08:26:04 INFO - PROCESS | 3993 | |4;audio-oscillator;84;85;107;83;85;83;119;85;84;132 08:26:04 INFO - PROCESS | 3993 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 08:26:04 INFO - PROCESS | 3993 | |6;imaging-darkroom;147;147;146;145;146;147;147;146;146;145 08:26:04 INFO - PROCESS | 3993 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 08:26:04 INFO - PROCESS | 3993 | |8;json-parse-financial;64;65;67;64;65;65;74;64;64;65 08:26:04 INFO - PROCESS | 3993 | |9;json-stringify-tinderbox;65;66;66;65;65;66;66;66;66;68 08:26:04 INFO - PROCESS | 3993 | |10;stanford-crypto-aes;84;84;84;84;85;86;84;85;125;87 08:26:04 INFO - PROCESS | 3993 | |11;stanford-crypto-ccm;133;129;131;128;132;128;132;132;136;136 08:26:04 INFO - PROCESS | 3993 | |12;stanford-crypto-pbkdf2;175;186;176;182;174;183;175;179;176;173 08:26:04 INFO - PROCESS | 3993 | |13;stanford-crypto-sha256-iterative;68;68;70;68;67;66;66;65;66;66 08:26:04 INFO - PROCESS | 3993 | __end_tp_report 08:26:04 INFO - PROCESS | 3993 | __start_cc_report 08:26:04 INFO - PROCESS | 3993 | _x_x_mozilla_cycle_collect,1928 08:26:04 INFO - PROCESS | 3993 | __end_cc_report 08:26:04 INFO - PROCESS | 3993 | __startTimestamp1464881164384__endTimestamp 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | ------- Summary: start ------- 08:26:04 INFO - PROCESS | 3993 | Number of tests: 14 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:2.04 (1.8%) stddev-sans-first:1.64 08:26:04 INFO - PROCESS | 3993 | Values: 119.0 111.0 115.0 116.0 114.0 116.0 114.0 116.0 115.0 116.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:147.00 stddev:18.78 (12.8%) stddev-sans-first:19.71 08:26:04 INFO - PROCESS | 3993 | Values: 155.0 138.0 132.0 177.0 133.0 132.0 161.0 139.0 177.0 129.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 08:26:04 INFO - PROCESS | 3993 | Values: 161.0 161.0 160.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.14 (17.3%) stddev-sans-first:13.93 08:26:04 INFO - PROCESS | 3993 | Values: 82.0 75.0 75.0 112.0 78.0 76.0 76.0 77.0 102.0 75.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:18.01 (21.4%) stddev-sans-first:18.68 08:26:04 INFO - PROCESS | 3993 | Values: 84.0 85.0 107.0 83.0 85.0 83.0 119.0 85.0 84.0 132.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:26:04 INFO - PROCESS | 3993 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:26:04 INFO - PROCESS | 3993 | Values: 147.0 147.0 146.0 145.0 146.0 147.0 147.0 146.0 146.0 145.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:26:04 INFO - PROCESS | 3993 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:3.06 (4.7%) stddev-sans-first:3.18 08:26:04 INFO - PROCESS | 3993 | Values: 64.0 65.0 67.0 64.0 65.0 65.0 74.0 64.0 64.0 65.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:26:04 INFO - PROCESS | 3993 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 68.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:84.50 stddev:12.76 (15.1%) stddev-sans-first:13.42 08:26:04 INFO - PROCESS | 3993 | Values: 84.0 84.0 84.0 84.0 85.0 86.0 84.0 85.0 125.0 87.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:132.00 stddev:2.87 (2.2%) stddev-sans-first:3.00 08:26:04 INFO - PROCESS | 3993 | Values: 133.0 129.0 131.0 128.0 132.0 128.0 132.0 132.0 136.0 136.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:177.50 stddev:4.38 (2.5%) stddev-sans-first:4.52 08:26:04 INFO - PROCESS | 3993 | Values: 175.0 186.0 176.0 182.0 174.0 183.0 175.0 179.0 176.0 173.0 08:26:04 INFO - PROCESS | 3993 | 08:26:04 INFO - PROCESS | 3993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.54 08:26:04 INFO - PROCESS | 3993 | Values: 68.0 68.0 70.0 68.0 67.0 66.0 66.0 65.0 66.0 66.0 08:26:04 INFO - PROCESS | 3993 | -------- Summary: end -------- 08:26:04 INFO - PROCESS | 3993 | 08:26:05 INFO - TEST-INFO | 3993: exit 0 08:26:05 INFO - TEST-OK | kraken | took 64178ms 08:26:05 INFO - SUITE-END | took 1182s 08:26:06 INFO - Completed test suite (00:19:43) 08:26:06 INFO - javascript benchmark 08:26:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.0670362021483, 2653.3499292673296, 2677.5849743289787, 2702.959455608166, 2711.471263103694, 4535.863924082275, 4623.14471822713, 4639.814407423699, 4721.457032441266, 4775.617950563956, 4655.4413470383515, 4689.85930422087, 4702.882427939303, 4758.571728544431, 4762.28565715142, 4292.441982542281, 4314.82740690372, 4333.566643335673, 4362.585554372337, 4389.407429996957, 83.68993396072081, 4419.491758447772, 4419.823207071713, 4426.86719398417, 4445.110977804452, 4207.158568286324, 4236.0, 4259.659227261812, 4385.276429389147, 4419.690621656486, 4276.572342765729, 4342.544032876534, 4343.370211319341, 4371.540988196225, 4384.408104905829, 4312.5903039211225, 4323.935140972888, 4326.718763280377, 4361.302191649321, 4367.213901497729, 4536.206163921333, 4590.357349971006, 4591.79336929839, 4639.234526303156, 4640.953590464086, 5034.0686972910125, 5104.9744751276, 5149.201873709581, 5150.716710580917, 5157.045946499909, 5078.7460626968505, 5112.590992720573, 5112.744362781883, 5122.564582010534, 5124.641275110744, 4545.568171023748, 4632.675712700112, 4689.882752931136, 4693.202155633482, 4711.1519926413575, 5190.0, 5205.531502164823, 5211.817586384458, 5215.374155101412, 5218.634695571273, 4843.370361852936, 4963.851084467472, 4968.776405061781, 5003.774830132653, 5020.447750747415, 5047.041062198171, 5096.311997880312, 5105.387353517602, 5108.846734597968, 5117.5905927526455, 5055.570276526537, 5063.3923929128005, 5066.544011039025, 5067.1639179535705, 5100.285959965608, 4758.738269395148, 4803.351547541037, 5007.899842003139, 5009.499050095034, 5053.191489361684, 4239.321708526621, 4310.719803212781, 4313.331433627793, 4335.414719012893, 4376.715513491613, 3743.3074881147077, 3743.9625603743616, 3768.8869333920024, 3773.509443772292, 3811.656950874379, 4259.829606815754, 4273.081287523198, 4338.197433474817, 4340.262155433584, 4385.583369579885, 5081.415637201769, 5115.411727651293, 5143.17709166539, 5144.7942082316285, 5148.382194136728, 4384.12317536494, 4397.714148580332, 4407.228734971367, 4410.955890441119, 4459.175052615276, 4494.056248187917, 4558.794854231567, 4620.075984802986, 4624.5144259852905, 4665.440147182292, 4748.928766068511, 4790.712557246507, 4800.231962885921, 4806.038792241496, 4814.494478079751, 5089.160288552495, 5116.258142569232, 5122.820701275437, 5125.8974820502635, 5172.896542069062, 4623.491415944176, 4758.643101767312, 4811.591014763784, 4828.758562071812, 4880.267959806058, 4971.701697898137, 4989.80040798364, 5012.523810238022, 5019.623528235324, 5069.949300506948, 5068.619853511075, 5082.161443361804, 5087.542121209109, 5105.7191854448365, 5130.2817605536, 4769.666123371469, 4878.0, 4928.556429921325, 4949.554540091409, 4949.604031677529, 4971.080350135237, 4991.15150424436, 4993.975030124971, 5010.649254552146, 5044.520770526794, 4912.1158191525865, 4925.38432695913, 4935.0, 4976.900461990812, 5001.299818025552, 4865.805367785249, 4917.655764096479, 4944.950550494449, 5082.567981721447, 5107.080725469451, 4844.2007068833245, 4865.343178670834, 4866.05112003156, 4915.5330243626795, 4920.21276595743], "value": 4622.633321879589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.9326742089517, 583.2213994317589, 594.56002558107, 595.348093837248, 606.5208485296616, 27361.315967100832, 41646.79176604116, 41941.58058419415, 42163.15673686525, 42224.0, 42662.0, 43044.78477607608, 43120.353194702104, 43127.353089703676, 43237.13525729484, 7464.066991626047, 7760.340371068466, 7953.562554059525, 7956.801079972989, 10030.74923126924, 10005.04952029556, 10140.847887281696, 10142.036506531867, 10142.340747851365, 10143.442110683909, 10068.446235457048, 10180.898191018106, 10181.134603558707, 10183.745406364864, 10189.592416303376, 7564.50830696003, 9741.90258097417, 10085.193184545218, 10098.29311948164, 10109.292349535535, 10066.245031622657, 10156.949215253877, 10167.59329626814, 10182.083612474913, 10184.032516910882, 39275.214495710214, 39528.80235598804, 39602.40596391056, 39713.80143099266, 39769.40345894814, 2925.297928497145, 2941.7352438280445, 3033.7421319187897, 3068.324968506925, 3108.4870996285586, 29737.851310743525, 29835.850820745756, 29903.551446728317, 30438.239044023856, 30485.085447436613, 3535.2045789697368, 3547.5033495310677, 3579.0515513388973, 3583.623719509466, 3649.7445178837493, 404758.0, 408997.0, 412067.0, 412325.0, 412457.0, 57955.71022144862, 58382.12426813601, 58634.7068264656, 58973.705131474926, 58994.75528845955, 34517.309653806784, 34878.47682284717, 35070.649293506736, 37008.074798129725, 37098.0, 14195.361208745631, 14212.64468388278, 14233.359498822578, 14241.78637320441, 14250.073745206528, 10809.405482698527, 11859.229150105215, 11906.52373905034, 11932.88067119335, 12368.0, 19275.903620482088, 19309.903450482656, 19336.903315483614, 19344.70982935257, 19356.128974196195, 6809.421199198025, 6843.452523798084, 6907.481938854606, 6979.82550436233, 7184.281571842878, 857.1771099744316, 925.9351845370759, 1044.070777008463, 1058.9735256618492, 1077.6228320087907, 29150.27124321909, 29241.561376579368, 29577.26056848596, 29615.85192074069, 29737.702622973928, 965.1699538396973, 974.8050389922043, 1028.6091285311534, 1033.0289527843802, 1073.130764081097, 14860.256987150598, 15223.31495082724, 15267.0, 15438.15090170029, 15495.225238738018, 361966.0, 363417.0, 364094.0, 365199.0, 365421.0, 52161.47838521642, 52556.47443525592, 52684.73657631764, 52732.20901686401, 52752.736236318575, 1115.893990070942, 1121.8092924202906, 1200.159888078366, 1231.2181764579377, 1266.6580023393817, 27633.723662763114, 29243.85378073096, 29879.402411952073, 30345.848270758506, 30422.847885760428, 42940.35589466223, 43490.782546087066, 43720.34419483774, 43752.0, 43788.0, 293029.0, 295639.0, 296338.0, 296682.6824524672, 297147.0, 22804.65793013073, 23067.6539851899, 23267.76732232656, 23321.300360989197, 25789.742102578733, 43352.56647433611, 43769.34345984749, 44196.33705494356, 44207.77896110499, 44467.77766111149, 36465.27069458543, 36477.81761091178, 36845.81577092098, 37024.81487592545, 37292.627073728916, 36638.45042324314, 37393.0, 37465.43801843029, 37604.81197593995, 38131.237375252895, 35343.0, 35802.64197357993, 36268.637313626525, 36488.0, 36659.26681466409, 32176.839115804272, 32930.67069329276, 33519.832400838815, 33842.66157338395, 33953.0, 25210.74789252084, 25265.494690105726, 25425.61861572115, 25944.57066769649, 26119.216423507325], "value": 18404.909917566853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.81559220389806, 376.700523084148, 380.17881376227353, 386.5863526027152, 390.6972096625115, 15837.287322070506, 16369.345226190968, 16447.2598733057, 16672.74990875138, 16683.91658041708, 15715.764263536055, 16183.757243641356, 16670.33318667255, 16689.0, 16705.081220532866, 4884.462709101996, 5045.798168073273, 5053.191489361703, 5067.695938243699, 5070.036693028332, 3665.7983810890523, 3845.0771814764394, 5005.699658020512, 5519.254900588409, 5821.6507009579345, 5839.299284085894, 5844.357120716739, 5851.210086638292, 5862.824115276549, 5864.618799778023, 5650.434956504317, 5773.971130144343, 5810.564207684441, 5854.4438278363705, 5857.502112320458, 3341.448660970937, 4823.2282834746275, 5098.745062746848, 5123.026624941249, 5135.666181698178, 19432.514187145294, 19936.601267974704, 19987.800121998738, 20490.077946492296, 20491.848355922713, 1862.9254829806928, 1946.2993322403922, 1995.321590659183, 2251.7748225177515, 2510.835450605305, 12568.0, 12917.612471625866, 12928.353582320846, 13472.461101555926, 13507.25710085945, 1731.8354756298259, 1741.2077504735441, 1779.1015537153785, 1824.8357647811629, 1844.317602487075, 62413.0, 62642.0, 63924.68037659782, 65112.674436627516, 65346.346536534504, 9166.450012999241, 9268.860967085498, 9277.350585458953, 9501.429914205031, 9543.713688589354, 12622.747545049047, 12796.424160912595, 12797.040221983389, 12844.807327890088, 12916.677083072998, 7335.633218339061, 7394.630268486554, 7453.180150183475, 7545.094588649397, 7545.453182097657, 7307.671154798047, 7344.265573442613, 7352.228016058344, 7526.774196774106, 7545.886811697829, 5763.0, 5967.940320596826, 5969.253843269591, 6003.909941350796, 6146.200993870768, 1572.512521118434, 1655.8095818980971, 1678.3789997700928, 1747.3709464592737, 1805.341050516552, 879.0681877210178, 884.7036242858715, 886.7118186589385, 895.7671005538476, 901.427593478133, 16617.335306587844, 16763.580910477336, 17198.570035748955, 17302.480925572254, 17648.911755441142, 905.6422713028448, 915.7893684452613, 923.676713150392, 925.0564424287189, 949.9097585729345, 9513.524323783784, 9921.65274215399, 10011.0, 10089.416921965765, 10150.238732095122, 164052.0, 165934.0, 166534.0, 345900.0, 346595.0, 75620.0, 77016.22983770202, 79627.60186199032, 80199.59900200462, 80558.19441805506, 917.4082716647724, 941.7880976780307, 953.6709835106877, 956.9138777509918, 989.1098011789303, 15270.083794971893, 15428.69142617119, 15437.691246174789, 15480.148591827558, 15878.9206053969, 33545.66454335425, 34896.82551587226, 34953.126171845906, 35020.47469287912, 35357.469637954935, 47294.29058564193, 47544.7622761884, 48572.27141592808, 49143.26285105655, 49167.7541612304, 6929.272426395156, 7373.225811289737, 7384.113906331059, 7410.6665200065045, 7446.515976461513, 9992.0, 10074.589557461815, 10680.0, 11534.365609891202, 11551.133664974992, 9510.50207346704, 9529.0, 9676.661316853877, 9795.0, 10034.247431442816, 9720.805583888141, 9971.252156088467, 9977.750556236153, 10138.695839124837, 10227.02843229892, 9369.156775890202, 9525.666601668909, 10129.139023182817, 10169.593216271267, 10260.692179234336, 6729.461643068641, 7025.824354391181, 7129.679164437509, 7207.0630817995425, 7255.709771609077, 9291.0, 9358.11097945694, 9926.454045027593, 10194.490275486047, 10202.28583999113], "value": 8123.492682689959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.4465168348402, 1374.4090041282248, 1450.586582823895, 1496.5585152380047, 1700.2433916906973, 6515.64163970982, 7459.104907411104, 7689.61551922403, 7698.692052317914, 7889.763307100782, 7622.352100071486, 7753.10839253486, 7762.45662803604, 7763.961180194091, 7773.455858089936, 1897.2126567474481, 1960.40207736641, 1961.8626696131278, 2215.235743668436, 2247.505548779266, 1927.6915693489045, 2171.6851056596784, 2268.2968279833303, 2272.4659704969317, 2276.237460450751, 2184.1154332495366, 2200.8899555022267, 2210.027587861336, 2210.4142402263415, 2213.1147540983657, 1837.2650939624123, 2101.2120454829437, 2104.905279262437, 2107.3993911735233, 2108.5677436125557, 2126.776688447722, 2174.510735084609, 2188.321620297713, 2193.2981445937307, 2193.407779899434, 7518.210587888302, 7580.50726702768, 7611.923880761177, 7616.0, 7616.352610028154, 4506.526814684444, 4656.627469802442, 4661.46393164787, 4664.393628828265, 4666.416697912761, 2874.755645770112, 2985.507391280436, 3054.9083527494213, 3060.3114299282706, 3071.754259659222, 882.3338379523483, 891.8394688955985, 972.8394814855541, 975.5073687787622, 992.5781542844335, 10468.842967355497, 10469.84295235572, 10477.057064864199, 10509.527071281811, 10530.526126324334, 4155.210510003089, 4240.554741752072, 4300.16146851361, 4376.562343765661, 4381.40850985113, 8981.46111233315, 8995.955020224988, 9016.143466370684, 9065.0, 9065.320100992452, 4693.108309421199, 4699.95300047002, 4704.411948506437, 4705.411823522059, 4709.7174169549935, 3620.456931460302, 3714.3871261242134, 4191.895202619959, 4309.116631090682, 4310.31035034393, 3620.6560376764164, 3711.870084547028, 3761.8307176177136, 3790.6019867913474, 3790.962090379061, 1177.3406892140429, 1192.2071822238288, 1192.3918801411344, 1196.1029228078942, 1206.5234232478122, 876.0932434929817, 877.3902138014018, 881.9559022048871, 888.3324390389275, 890.9688160914467, 5141.691498510101, 5158.819441319611, 5176.792928282902, 5196.272521846944, 5410.458954104558, 804.5574933786394, 851.1488511488511, 852.3692467573951, 874.728834061443, 903.2412773270353, 3591.102224443889, 3723.2925744108534, 3724.7392682512505, 3776.244751049801, 3845.730798844054, 9185.770355741026, 9369.953150234342, 9468.14786669203, 9520.476373799369, 9533.38033027865, 9145.496997665192, 9405.43567385959, 9430.19843313326, 9472.810543789086, 9487.573059212215, 6891.862162756717, 6921.1002569665625, 7034.085568876013, 7035.12060992376, 7040.190378106583, 5198.272241886063, 5202.323697919246, 5220.373555173252, 5368.248445217595, 5372.1404575269335, 8702.0, 8704.34717396185, 8726.432781869158, 8786.428882122642, 8817.206451419403, 8506.319494440553, 8897.555122243992, 8910.019897811366, 8921.955390223007, 8934.061923498199, 5686.09022556389, 5877.441643043904, 5880.529557635294, 6082.513398928164, 6223.657698826608, 6905.37851593359, 6966.512344135862, 7190.20907700163, 7398.778036658909, 7427.368673662799, 6683.832904177434, 6795.898061528982, 6812.523123381316, 6882.69027893736, 6886.311368863074, 6687.0, 6700.262971073275, 6749.5612785168805, 6836.794896153124, 6847.0, 6178.814635560941, 6282.340354262737, 6296.842578935563, 6339.809805705651, 6346.587471814318, 4528.773561321855, 4543.136804007228, 4605.0099228665995, 4665.906681866411, 4735.668503204743, 4681.157391669532, 4740.1230772307235, 4754.548317909793, 4809.663323567317, 4830.541098595628], "value": 4111.888898006601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.22098386815264, 294.71559944653404, 303.078640931568, 305.45933697355696, 312.07469851889147, 4902.6813257138265, 4915.70505769654, 4975.179095449246, 4985.476524964881, 4988.152014157588, 4622.838200662977, 4703.200455922492, 4719.221328480797, 4758.214894542405, 4900.509949005098, 3695.5565332160045, 3722.1997270586885, 3768.265188288271, 3812.7902965336893, 3877.728559000857, 3799.4490798834154, 3844.154286057063, 3847.1343947611845, 3851.845926162964, 3854.672352850011, 3592.3533763922483, 3785.5078839750795, 3801.2777572261184, 3802.4676545283683, 3815.351390263662, 3788.2423515296773, 3788.3370410178245, 3791.620837916214, 3798.7340886137845, 3799.3920972644246, 3321.717653999413, 3334.949975750366, 3336.099253201646, 3339.1652086978256, 3342.9331413371597, 4743.667943243974, 4756.191447453941, 4757.191277482836, 4761.0, 4761.619070474354, 4076.5719599442223, 4346.608805207515, 4359.866434726962, 4362.956370436318, 4413.867583972486, 5103.795848166069, 5119.259451786411, 5146.485351464861, 5150.094465047919, 5159.793608255665, 3597.6402359764074, 3598.4962105305276, 3613.2050948791225, 3618.2220822523022, 3618.3848745713294, 5136.768845401966, 5341.519263266325, 5383.631202270988, 5430.945690543083, 5493.148561972901, 3639.6542328478754, 3677.742558020913, 3688.3729765939856, 3694.796786176786, 3720.311742327678, 3747.9063023424633, 3765.811709414518, 3771.17034252464, 3771.641694039062, 3782.8108594570162, 4265.658747300208, 4306.956930430718, 4312.180685669713, 4365.738055716667, 4367.410399596078, 4996.950030499721, 5123.846284611468, 5183.041137389595, 5189.948100519022, 5209.531142197145, 1215.9148859579745, 1284.865089165624, 1299.2789002103734, 1307.895368370528, 1319.4524272427027, 869.5261082709939, 882.6601758323092, 894.8344556257114, 899.3030401438806, 904.7243386824678, 4490.618297444688, 4497.190505709003, 4525.366448697119, 4539.933115717804, 4546.704464209815, 5222.6083043771105, 5228.4510126436935, 5245.501677340647, 5266.657667251693, 5279.392869819943, 4360.258756011485, 4464.214314274316, 4469.664775141812, 4507.954920450754, 4509.729416234971, 2789.9442011159663, 2821.50623640862, 2853.586229996639, 2858.2139911524496, 2862.2128914548666, 5037.596992240612, 5041.193409054534, 5053.9747301264, 5054.949450505448, 5064.670796398296, 5190.169572868398, 5372.892542149135, 5419.3225846769155, 5435.852838128917, 5456.563474921997, 4972.726500042532, 4998.850034498971, 5011.173156429149, 5021.1421773943875, 5035.0, 5021.5229553192385, 5261.631685781958, 5262.236975638434, 5281.445448228034, 5290.761915713879, 5140.717260550556, 5171.431142574389, 5185.662931909414, 5206.0, 5217.113090774654, 4927.260910863399, 4948.406191257072, 4958.785097651099, 4988.326575912205, 4999.525045120708, 3730.142067324476, 3732.9813350933073, 3739.495168152265, 3740.6072362401555, 3749.0, 5062.265971434195, 5296.841094767163, 5351.277577527139, 5354.464553544614, 5356.1697936819855, 5174.7153906533995, 5186.58507319406, 5188.325517682828, 5216.739163041757, 5222.399424066281, 4990.925136123034, 5175.301334319819, 5203.635745497779, 5207.29701490294, 5221.590170653978, 4916.8770780730765, 5023.673461225008, 5179.730965913375, 5187.19598462239, 5192.169252919514, 5236.136037553761, 5249.527542521191, 5255.89488210226, 5259.947400525945, 5262.552683021833, 5107.540321371094, 5132.178851383761, 5132.769025393941, 5133.666311689728, 5142.254373115952], "value": 3867.6333459115785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.687656171914, 661.9172603424569, 679.6601699150425, 741.9183889772124, 760.2967255288856, 12518.436670349833, 12821.743565128692, 12998.155119917199, 13095.803562946563, 13100.475980960773, 12056.27662340258, 12073.939630301837, 12086.456109475073, 13697.794533081988, 14136.0, 804.7746630943316, 805.1545876829335, 811.3063330852125, 811.6307080278459, 811.7767613906163, 635.4408120853642, 769.4613770360742, 795.6181033104114, 802.3821657323857, 809.7894547417684, 841.0916210492653, 841.4362377207286, 843.0768308701993, 843.7215718812807, 844.0377969115214, 828.2173346187855, 828.9792755181109, 830.6469750356074, 831.1522247307743, 832.2634468495364, 489.32228863024613, 491.2582001178247, 496.03521151360616, 497.06055555001075, 603.3966033966034, 12314.13801033928, 13115.27865967381, 13172.60482185536, 13214.405351759195, 13233.86766132336, 12093.637190884288, 12661.936690316581, 12732.681682957907, 12810.308887625579, 12998.15511991727, 10708.0, 10739.0, 10781.838272425919, 10856.0, 10876.293040952312, 3350.681685239923, 3392.4741665041956, 3409.4203985322556, 3439.8452069656923, 3511.508388825541, 58165.418345816426, 58220.417795822344, 59030.70484647549, 59070.409295906924, 59166.40833591695, 10261.9486902565, 10375.760241078207, 10380.221483388625, 10476.47617619116, 10542.103921166634, 18622.627547448974, 18668.0, 18764.53088672767, 18767.812321876878, 18769.7184542232, 6620.337966203341, 6644.335566443317, 6650.434713049445, 6651.301613330627, 6755.594664320059, 3690.225052738901, 3717.1636381813873, 3796.1648437343742, 3796.8291426885858, 3819.7135214858995, 2923.7953343266195, 3031.9242018949262, 3044.34546572488, 3045.421369939704, 3046.573479712842, 522.7516929458553, 525.6504424557703, 526.1581469648609, 546.4235231830378, 551.3879593651044, 551.589066145724, 573.131705466219, 577.5148874945066, 599.7541008186622, 612.2928018139056, 8390.874136887951, 8467.49195048299, 8488.533130677872, 8564.400491965502, 8789.121087891288, 569.3736889421604, 592.2803793390965, 606.2088973889029, 620.88203241384, 631.88626047311, 4217.198732240864, 4277.508086570022, 4296.2481565725875, 4356.302991521405, 4420.646348292129, 57693.0, 81926.0, 83612.0, 84797.15202848017, 85668.57165714132, 73014.26985730181, 73177.26822731811, 74795.62602186954, 75626.62186689141, 78075.0, 68361.3163868365, 69065.65467172633, 70135.64932175307, 72031.6398418015, 72931.63534182402, 8625.309975202093, 8687.435316704394, 8761.474311541328, 8779.473231606124, 8928.598213080297, 40882.79558602188, 41847.58152418437, 42129.78935105305, 42141.78929105335, 42872.571274286856, 53279.0, 57767.0, 58363.0, 59311.11033334417, 60545.0, 10903.509342079467, 11161.386123763272, 11272.267302625303, 11273.830892536782, 11590.826137608112, 12124.644766390373, 12390.75218495607, 12710.682232944251, 12712.555060572835, 12745.936270318589, 11782.17524773292, 12081.456334464794, 12244.0, 12476.563320283747, 12494.750104998031, 9198.724038278862, 9773.85339219898, 10124.34191777532, 11803.940980295387, 12008.0, 11692.649220523397, 11802.52789888395, 11897.46461409256, 12431.62705118848, 12486.750264994467, 10099.69700908974, 10165.84751228747, 10241.846372304273, 10448.58205671795, 10526.421046842192, 10237.436940968319, 10404.47977601132, 10557.252175477903, 10612.204084693525, 10661.147108231478], "value": 6513.045532729424, "unit": "score"}], "name": "dromaeo_css", "value": 6443.888051089082, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 111.0, 115.0, 116.0, 114.0, 116.0, 114.0, 116.0, 115.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 138.0, 132.0, 177.0, 133.0, 132.0, 161.0, 139.0, 177.0, 129.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 112.0, 78.0, 76.0, 76.0, 77.0, 102.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 83.0, 85.0, 83.0, 119.0, 85.0, 84.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 64.0, 65.0, 65.0, 74.0, 64.0, 64.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 68.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 86.0, 84.0, 85.0, 125.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 131.0, 128.0, 132.0, 128.0, 132.0, 132.0, 136.0, 136.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 186.0, 176.0, 182.0, 174.0, 183.0, 175.0, 179.0, 176.0, 173.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1556.1000000000001, "alertThreshold": 2.0}]} 08:26:06 INFO - Return code: 0 08:26:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:26:06 ERROR - # TBPL SUCCESS # 08:26:06 INFO - Running post-action listener: _resource_record_post_action 08:26:06 INFO - ##### 08:26:06 INFO - ##### Finished run-tests step (success) 08:26:06 INFO - ##### 08:26:06 INFO - Running post-run listener: _resource_record_post_run 08:26:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 531611648; Read time: 0; Write time: 457176 08:26:06 INFO - TinderboxPrint: CPU usage
13.1% 08:26:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:26:06 INFO - TinderboxPrint: I/O write bytes / time
531,611,648 / 457,176 08:26:06 INFO - TinderboxPrint: CPU idle
8,320.2 (86.9%) 08:26:06 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 08:26:06 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243077120; Read time: 0; Write time: 218772 08:26:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287920128; Read time: 0; Write time: 238404 08:26:06 INFO - Running post-run listener: _upload_blobber_files 08:26:06 INFO - Blob upload gear active. 08:26:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:26:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:08 INFO - (blobuploader) - INFO - Done attempting. 08:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:12 INFO - (blobuploader) - INFO - Done attempting. 08:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:13 INFO - (blobuploader) - INFO - Done attempting. 08:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:13 INFO - Return code: 0 08:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58001dd434b2d52db33a3b7b74b8e5c7880e5615e4d4ddde3e2b9052393ccb0785dc391069fd37085a77161a76f696ac5fbb83b957a34e1d6acce83a3962ef52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc13128cfea3be6ace140abd305c2a137e715081c2b583665c172557c34dde7ac10a52bd846ef449886d7b491f14f3722307bfbf5eadb8e571893b786d19a35f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc45a289512534aaff7bf77be8037311e91c3ba3195ec59c8c92ce1c8c1dc73eaaa53da3501cf063a904ad01cf96e152bf59640c1686895ea1afe5c659122e99"} 08:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:13 INFO - Contents: 08:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/58001dd434b2d52db33a3b7b74b8e5c7880e5615e4d4ddde3e2b9052393ccb0785dc391069fd37085a77161a76f696ac5fbb83b957a34e1d6acce83a3962ef52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc13128cfea3be6ace140abd305c2a137e715081c2b583665c172557c34dde7ac10a52bd846ef449886d7b491f14f3722307bfbf5eadb8e571893b786d19a35f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc45a289512534aaff7bf77be8037311e91c3ba3195ec59c8c92ce1c8c1dc73eaaa53da3501cf063a904ad01cf96e152bf59640c1686895ea1afe5c659122e99"} 08:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:13 INFO - Copying logs to upload dir... 08:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.151906 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 08:26:13.100989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 08:26:13.102162) ========= 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-1464879928.553273-502650710 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/58001dd434b2d52db33a3b7b74b8e5c7880e5615e4d4ddde3e2b9052393ccb0785dc391069fd37085a77161a76f696ac5fbb83b957a34e1d6acce83a3962ef52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc13128cfea3be6ace140abd305c2a137e715081c2b583665c172557c34dde7ac10a52bd846ef449886d7b491f14f3722307bfbf5eadb8e571893b786d19a35f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc45a289512534aaff7bf77be8037311e91c3ba3195ec59c8c92ce1c8c1dc73eaaa53da3501cf063a904ad01cf96e152bf59640c1686895ea1afe5c659122e99"} build_url:https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/Xl2W1Y2UTPaQKD8OSOR0YQ/artifacts/public/build/firefox-49.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/58001dd434b2d52db33a3b7b74b8e5c7880e5615e4d4ddde3e2b9052393ccb0785dc391069fd37085a77161a76f696ac5fbb83b957a34e1d6acce83a3962ef52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc13128cfea3be6ace140abd305c2a137e715081c2b583665c172557c34dde7ac10a52bd846ef449886d7b491f14f3722307bfbf5eadb8e571893b786d19a35f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc45a289512534aaff7bf77be8037311e91c3ba3195ec59c8c92ce1c8c1dc73eaaa53da3501cf063a904ad01cf96e152bf59640c1686895ea1afe5c659122e99"}' ========= master_lag: 0.84 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 08:26:13.951402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:26:13.951874) ========= 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-1464879928.553273-502650710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004045 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:26:13.975918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 08:26:13.976300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 08:26:13.976669) ========= ========= Total master_lag: 0.96 =========