builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1464187296.4 results: success (0) buildid: 20160525062239 builduid: 311dc684c0e84b57a1a6280d0e7b77b7 revision: ff6044ca81893c73528253564e0f3ccbcacff046 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.405154) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.405843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.406125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.421673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.421936) ========= 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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 07:41:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-25 07:41:36 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.518583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.518864) ========= 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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019649 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:36.607175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 07:41:36.607528) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff6044ca81893c73528253564e0f3ccbcacff046 --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 ff6044ca81893c73528253564e0f3ccbcacff046 --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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 07:41:36,730 truncating revision to first 12 chars 2016-05-25 07:41:36,730 Setting DEBUG logging. 2016-05-25 07:41:36,731 attempt 1/10 2016-05-25 07:41:36,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff6044ca8189?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 07:41:37,783 unpacking tar archive at: fx-team-ff6044ca8189/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 07:41:37.990189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:37.990701) ========= script_repo_revision: ff6044ca81893c73528253564e0f3ccbcacff046 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:37.991335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:37.991809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 07:41:38.002768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-25 07:41:38.003120) ========= /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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:38 INFO - MultiFileLogger online at 20160525 07:41:38 in /builds/slave/test 07:41:38 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 07:41:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:38 INFO - {'append_to_log': False, 07:41:38 INFO - 'base_work_dir': '/builds/slave/test', 07:41:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:41:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:38 INFO - 'branch': 'Fx-Team-Non-PGO', 07:41:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:38 INFO - 'config_files': ('talos/linux_config.py',), 07:41:38 INFO - 'default_actions': ('clobber', 07:41:38 INFO - 'read-buildbot-config', 07:41:38 INFO - 'download-and-extract', 07:41:38 INFO - 'populate-webroot', 07:41:38 INFO - 'create-virtualenv', 07:41:38 INFO - 'install', 07:41:38 INFO - 'run-tests'), 07:41:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:38 INFO - 'download_minidump_stackwalk': True, 07:41:38 INFO - 'download_symbols': 'ondemand', 07:41:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:38 INFO - 'installer_path': 'installer.exe', 07:41:38 INFO - 'log_level': 'info', 07:41:38 INFO - 'log_name': 'talos', 07:41:38 INFO - 'log_to_console': True, 07:41:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:38 INFO - 'opt_config_files': (), 07:41:38 INFO - 'pip_index': False, 07:41:38 INFO - 'sps_profile': False, 07:41:38 INFO - 'sps_profile_interval': 0, 07:41:38 INFO - 'suite': 'dromaeojs', 07:41:38 INFO - 'system_bits': '32', 07:41:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:38 INFO - 'title': 'talos-linux64-ix-031', 07:41:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:38 INFO - 'use_talos_json': True, 07:41:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:38 INFO - 'work_dir': 'build'} 07:41:38 INFO - ##### 07:41:38 INFO - ##### Running clobber step. 07:41:38 INFO - ##### 07:41:38 INFO - Running pre-action listener: _resource_record_pre_action 07:41:38 INFO - Running main action method: clobber 07:41:38 INFO - rmtree: /builds/slave/test/build 07:41:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:38 INFO - Running post-action listener: _resource_record_post_action 07:41:38 INFO - ##### 07:41:38 INFO - ##### Finished clobber step (success) 07:41:38 INFO - ##### 07:41:38 INFO - ##### 07:41:38 INFO - ##### Running read-buildbot-config step. 07:41:38 INFO - ##### 07:41:38 INFO - Running pre-action listener: _resource_record_pre_action 07:41:38 INFO - Running main action method: read_buildbot_config 07:41:38 INFO - Using buildbot properties: 07:41:38 INFO - { 07:41:38 INFO - "project": "", 07:41:38 INFO - "product": "firefox", 07:41:38 INFO - "script_repo_revision": "production", 07:41:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:41:38 INFO - "repository": "", 07:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:41:38 INFO - "buildid": "20160525062239", 07:41:38 INFO - "pgo_build": "False", 07:41:38 INFO - "basedir": "/builds/slave/test", 07:41:38 INFO - "buildnumber": 1714, 07:41:38 INFO - "slavename": "talos-linux64-ix-031", 07:41:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:41:38 INFO - "platform": "ubuntu64_hw", 07:41:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:41:38 INFO - "branch": "fx-team", 07:41:38 INFO - "repo_path": "integration/fx-team", 07:41:38 INFO - "revision": "ff6044ca81893c73528253564e0f3ccbcacff046", 07:41:38 INFO - "stage_platform": "linux64", 07:41:38 INFO - "builduid": "311dc684c0e84b57a1a6280d0e7b77b7", 07:41:38 INFO - "slavebuilddir": "test" 07:41:38 INFO - } 07:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:41:38 INFO - Running post-action listener: _resource_record_post_action 07:41:38 INFO - ##### 07:41:38 INFO - ##### Finished read-buildbot-config step (success) 07:41:38 INFO - ##### 07:41:38 INFO - ##### 07:41:38 INFO - ##### Running download-and-extract step. 07:41:38 INFO - ##### 07:41:38 INFO - Running pre-action listener: _resource_record_pre_action 07:41:38 INFO - Running main action method: download_and_extract 07:41:38 INFO - mkdir: /builds/slave/test/build/tests 07:41: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')]} 07:41:38 INFO - https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:43 INFO - Downloaded 1361 bytes. 07:41:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:41:43 INFO - Using the following test package requirements: 07:41:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:41:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'jsshell-linux-x86_64.zip'], 07:41:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:41:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:41:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41: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')]} 07:41:43 INFO - https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:47 INFO - Downloaded 22848271 bytes. 07:41:47 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'] 07:41:47 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 07:41:49 INFO - Return code: 0 07:41:49 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 07:41: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')]} 07:41:49 INFO - https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:52 INFO - Downloaded 22848271 bytes. 07:41:52 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'] 07:41:52 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 07:41:54 INFO - Return code: 0 07:41:54 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')]} 07:41:54 INFO - https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:41:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:54 INFO - Downloaded 10834034 bytes. 07:41:54 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'] 07:41:54 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 07:41:55 INFO - Return code: 0 07:41: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')]} 07:41:55 INFO - https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:41:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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 07:41:57 INFO - Downloaded 54824341 bytes. 07:41:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:57 INFO - mkdir: /builds/slave/test/properties 07:41:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:57 INFO - Contents: 07:41:57 INFO - build_url:https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:41:57 INFO - Running post-action listener: _resource_record_post_action 07:41:57 INFO - Running post-action listener: set_extra_try_arguments 07:41:57 INFO - ##### 07:41:57 INFO - ##### Finished download-and-extract step (success) 07:41:57 INFO - ##### 07:41:57 INFO - ##### 07:41:57 INFO - ##### Running populate-webroot step. 07:41:57 INFO - ##### 07:41:57 INFO - Running pre-action listener: _resource_record_pre_action 07:41:57 INFO - Running main action method: populate_webroot 07:41:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:57 INFO - '--tppagecycles', 07:41:57 INFO - '7'], 07:41:57 INFO - 'tests': ['tsvgm']}}, 07:41:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['damp', 'tps']}, 07:41:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'tests': ['damp', 'tps']}, 07:41:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['dromaeo_dom']}, 07:41:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['a11yr', 07:41:57 INFO - 'ts_paint', 07:41:57 INFO - 'tpaint', 07:41:57 INFO - 'sessionrestore', 07:41:57 INFO - 'sessionrestore_no_auto_restore', 07:41:57 INFO - 'tabpaint']}, 07:41:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['tsvgx', 07:41:57 INFO - 'tsvgr_opacity', 07:41:57 INFO - 'tart', 07:41:57 INFO - 'tscrollx', 07:41:57 INFO - 'cart']}, 07:41:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:57 INFO - 'tsvgr_opacity', 07:41:57 INFO - 'tart', 07:41:57 INFO - 'tscrollx', 07:41:57 INFO - 'cart']}, 07:41:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'talos_options': ['--disable-e10s'], 07:41:57 INFO - 'tests': ['tp5o']}, 07:41:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'tests': ['tp5o']}, 07:41:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'talos_options': ['--disable-e10s', 07:41:57 INFO - '--xperf_path', 07:41:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:57 INFO - 'tests': ['tp5n']}, 07:41:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:57 INFO - 'talos_options': ['--xperf_path', 07:41:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:57 INFO - 'tests': ['tp5n']}}, 07:41:57 INFO - 'talos.zip': {'path': '', 07:41:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:57 INFO - Running post-action listener: _resource_record_post_action 07:41:57 INFO - ##### 07:41:57 INFO - ##### Finished populate-webroot step (success) 07:41:57 INFO - ##### 07:41:57 INFO - ##### 07:41:57 INFO - ##### Running create-virtualenv step. 07:41:57 INFO - ##### 07:41:57 INFO - Running pre-action listener: _resource_record_pre_action 07:41:57 INFO - Running main action method: create_virtualenv 07:41:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:57 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 07:41:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:57 INFO - Using real prefix '/usr' 07:41:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:00 INFO - Installing pip.................done. 07:42:00 INFO - Return code: 0 07:42:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:00 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 07:42:00 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 07:42:00 INFO - Using env: {'DISPLAY': ':0', 07:42:00 INFO - 'HOME': '/home/cltbld', 07:42:00 INFO - 'LANG': 'en_US.UTF-8', 07:42:00 INFO - 'LANGUAGE': 'en_US:en', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MAIL': '/var/mail/cltbld', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SHLVL': '1', 07:42:00 INFO - 'TERM': 'linux', 07:42:00 INFO - 'TMOUT': '86400', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - '_': '/tools/buildbot/bin/python'} 07:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:00 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 07:42:00 INFO - Cleaning up... 07:42:00 INFO - Return code: 0 07:42:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:00 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 07:42:00 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 07:42:00 INFO - Using env: {'DISPLAY': ':0', 07:42:00 INFO - 'HOME': '/home/cltbld', 07:42:00 INFO - 'LANG': 'en_US.UTF-8', 07:42:00 INFO - 'LANGUAGE': 'en_US:en', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MAIL': '/var/mail/cltbld', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SHLVL': '1', 07:42:00 INFO - 'TERM': 'linux', 07:42:00 INFO - 'TMOUT': '86400', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - '_': '/tools/buildbot/bin/python'} 07:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:00 INFO - Downloading/unpacking psutil>=3.1.1 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:02 INFO - Installing collected packages: psutil 07:42:02 INFO - Running setup.py install for psutil 07:42:02 INFO - building 'psutil._psutil_linux' extension 07:42:02 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 07:42:03 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 07:42:03 INFO - building 'psutil._psutil_posix' extension 07:42:03 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 07:42:03 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 07:42:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:03 INFO - Successfully installed psutil 07:42:03 INFO - Cleaning up... 07:42:03 INFO - Return code: 0 07:42:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:42:03 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')]} 07:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:03 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')]} 07:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:03 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:03 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 07:42:03 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 07:42:03 INFO - Using env: {'DISPLAY': ':0', 07:42:03 INFO - 'HOME': '/home/cltbld', 07:42:03 INFO - 'LANG': 'en_US.UTF-8', 07:42:03 INFO - 'LANGUAGE': 'en_US:en', 07:42:03 INFO - 'LOGNAME': 'cltbld', 07:42:03 INFO - 'MAIL': '/var/mail/cltbld', 07:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:03 INFO - 'MOZ_NO_REMOTE': '1', 07:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:03 INFO - 'NO_EM_RESTART': '1', 07:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:03 INFO - 'PWD': '/builds/slave/test', 07:42:03 INFO - 'SHELL': '/bin/bash', 07:42:03 INFO - 'SHLVL': '1', 07:42:03 INFO - 'TERM': 'linux', 07:42:03 INFO - 'TMOUT': '86400', 07:42:03 INFO - 'USER': 'cltbld', 07:42:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:03 INFO - '_': '/tools/buildbot/bin/python'} 07:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:42:03 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 07:42:03 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 07:42:03 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 07:42:03 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 07:42:03 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 07:42:03 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 07:42:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:05 INFO - Installing collected packages: mozsystemmonitor 07:42:05 INFO - Running setup.py install for mozsystemmonitor 07:42:05 INFO - Successfully installed mozsystemmonitor 07:42:05 INFO - Cleaning up... 07:42:05 INFO - Return code: 0 07:42:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:05 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')]} 07:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:05 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')]} 07:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:05 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:05 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 07:42:05 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 07:42:05 INFO - Using env: {'DISPLAY': ':0', 07:42:05 INFO - 'HOME': '/home/cltbld', 07:42:05 INFO - 'LANG': 'en_US.UTF-8', 07:42:05 INFO - 'LANGUAGE': 'en_US:en', 07:42:05 INFO - 'LOGNAME': 'cltbld', 07:42:05 INFO - 'MAIL': '/var/mail/cltbld', 07:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:05 INFO - 'MOZ_NO_REMOTE': '1', 07:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:05 INFO - 'NO_EM_RESTART': '1', 07:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:05 INFO - 'PWD': '/builds/slave/test', 07:42:05 INFO - 'SHELL': '/bin/bash', 07:42:05 INFO - 'SHLVL': '1', 07:42:05 INFO - 'TERM': 'linux', 07:42:05 INFO - 'TMOUT': '86400', 07:42:05 INFO - 'USER': 'cltbld', 07:42:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:05 INFO - '_': '/tools/buildbot/bin/python'} 07:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:05 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 07:42:05 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 07:42:05 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 07:42:05 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 07:42:05 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 07:42:05 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 07:42:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 INFO - Downloading docopt-0.6.1.tar.gz 07:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:08 INFO - Running setup.py install for blobuploader 07:42:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:08 INFO - Running setup.py install for requests 07:42:08 INFO - Running setup.py install for docopt 07:42:09 INFO - Successfully installed blobuploader requests docopt 07:42:09 INFO - Cleaning up... 07:42:09 INFO - Return code: 0 07:42:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:09 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')]} 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 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')]} 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:09 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 07:42:09 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 07:42:09 INFO - Using env: {'DISPLAY': ':0', 07:42:09 INFO - 'HOME': '/home/cltbld', 07:42:09 INFO - 'LANG': 'en_US.UTF-8', 07:42:09 INFO - 'LANGUAGE': 'en_US:en', 07:42:09 INFO - 'LOGNAME': 'cltbld', 07:42:09 INFO - 'MAIL': '/var/mail/cltbld', 07:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:09 INFO - 'MOZ_NO_REMOTE': '1', 07:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:09 INFO - 'NO_EM_RESTART': '1', 07:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:09 INFO - 'PWD': '/builds/slave/test', 07:42:09 INFO - 'SHELL': '/bin/bash', 07:42:09 INFO - 'SHLVL': '1', 07:42:09 INFO - 'TERM': 'linux', 07:42:09 INFO - 'TMOUT': '86400', 07:42:09 INFO - 'USER': 'cltbld', 07:42:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:09 INFO - '_': '/tools/buildbot/bin/python'} 07:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:09 INFO - Running setup.py (path:/tmp/pip-bsy2WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:09 INFO - Running setup.py (path:/tmp/pip-JFe4GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:09 INFO - Running setup.py (path:/tmp/pip-drWU33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:09 INFO - Running setup.py (path:/tmp/pip-VSttRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:09 INFO - Running setup.py (path:/tmp/pip-2TiC9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:09 INFO - Running setup.py (path:/tmp/pip-EQQf4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:09 INFO - Running setup.py (path:/tmp/pip-PmKG_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:09 INFO - Running setup.py (path:/tmp/pip-4sih7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:09 INFO - Running setup.py (path:/tmp/pip-iM9j5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:09 INFO - Running setup.py (path:/tmp/pip-vwIKEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:10 INFO - Running setup.py (path:/tmp/pip-50WDpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:10 INFO - Running setup.py (path:/tmp/pip-nEKq5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:10 INFO - Running setup.py (path:/tmp/pip-xedJLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:10 INFO - Running setup.py (path:/tmp/pip-WjYW1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:10 INFO - Running setup.py (path:/tmp/pip-nekrgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:10 INFO - Running setup.py (path:/tmp/pip-O9jMRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:10 INFO - Running setup.py (path:/tmp/pip-LYWBtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:10 INFO - Running setup.py install for manifestparser 07:42:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozcrash 07:42:10 INFO - Running setup.py install for mozdebug 07:42:10 INFO - Running setup.py install for mozdevice 07:42:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozfile 07:42:11 INFO - Running setup.py install for mozhttpd 07:42:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozinfo 07:42:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozInstall 07:42:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozleak 07:42:11 INFO - Running setup.py install for mozlog 07:42:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for moznetwork 07:42:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozprocess 07:42:11 INFO - Running setup.py install for mozprofile 07:42:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozrunner 07:42:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozscreenshot 07:42:12 INFO - Running setup.py install for moztest 07:42:12 INFO - Running setup.py install for mozversion 07:42:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:12 INFO - Cleaning up... 07:42:12 INFO - Return code: 0 07:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:12 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')]} 07:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:12 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')]} 07:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:12 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:12 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 07:42:12 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 07:42:12 INFO - Using env: {'DISPLAY': ':0', 07:42:12 INFO - 'HOME': '/home/cltbld', 07:42:12 INFO - 'LANG': 'en_US.UTF-8', 07:42:12 INFO - 'LANGUAGE': 'en_US:en', 07:42:12 INFO - 'LOGNAME': 'cltbld', 07:42:12 INFO - 'MAIL': '/var/mail/cltbld', 07:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:12 INFO - 'MOZ_NO_REMOTE': '1', 07:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:12 INFO - 'NO_EM_RESTART': '1', 07:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:12 INFO - 'PWD': '/builds/slave/test', 07:42:12 INFO - 'SHELL': '/bin/bash', 07:42:12 INFO - 'SHLVL': '1', 07:42:12 INFO - 'TERM': 'linux', 07:42:12 INFO - 'TMOUT': '86400', 07:42:12 INFO - 'USER': 'cltbld', 07:42:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:12 INFO - '_': '/tools/buildbot/bin/python'} 07:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:12 INFO - Running setup.py (path:/tmp/pip-rtpGYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:12 INFO - Running setup.py (path:/tmp/pip-ndeEw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:12 INFO - Running setup.py (path:/tmp/pip-1MnbWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:12 INFO - Running setup.py (path:/tmp/pip-MwLVaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:12 INFO - Running setup.py (path:/tmp/pip-3yU3ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:12 INFO - Running setup.py (path:/tmp/pip-pXCPXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:12 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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:12 INFO - Running setup.py (path:/tmp/pip-UA_0vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:13 INFO - Running setup.py (path:/tmp/pip-JvIGqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:13 INFO - Running setup.py (path:/tmp/pip-lvzObW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:13 INFO - Running setup.py (path:/tmp/pip-i_FHqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:13 INFO - Running setup.py (path:/tmp/pip-gnhO9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:13 INFO - Running setup.py (path:/tmp/pip-Ku8Uwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:13 INFO - Running setup.py (path:/tmp/pip-c6TMBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:13 INFO - Running setup.py (path:/tmp/pip-37uhjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:13 INFO - Running setup.py (path:/tmp/pip-dmjHYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:13 INFO - Running setup.py (path:/tmp/pip-wMBDkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:13 INFO - Running setup.py (path:/tmp/pip-bpPG0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:13 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)) 07:42:13 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)) 07:42:13 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)) 07:42:13 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)) 07:42:13 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)) 07:42:13 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)) 07:42:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:13 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 07:42:13 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 07:42:13 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 07:42:13 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 07:42:13 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 07:42:13 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 07:42:15 INFO - Downloading blessings-1.6.tar.gz 07:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:15 INFO - Installing collected packages: blessings 07:42:15 INFO - Running setup.py install for blessings 07:42:15 INFO - Successfully installed blessings 07:42:15 INFO - Cleaning up... 07:42:15 INFO - Return code: 0 07:42:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:16 INFO - Reading from file tmpfile_stdout 07:42:16 INFO - Current package versions: 07:42:16 INFO - argparse == 1.2.1 07:42:16 INFO - blessings == 1.6 07:42:16 INFO - blobuploader == 1.2.4 07:42:16 INFO - docopt == 0.6.1 07:42:16 INFO - manifestparser == 1.1 07:42:16 INFO - mozInstall == 1.12 07:42:16 INFO - mozcrash == 0.17 07:42:16 INFO - mozdebug == 0.1 07:42:16 INFO - mozdevice == 0.48 07:42:16 INFO - mozfile == 1.2 07:42:16 INFO - mozhttpd == 0.7 07:42:16 INFO - mozinfo == 0.9 07:42:16 INFO - mozleak == 0.1 07:42:16 INFO - mozlog == 3.2 07:42:16 INFO - moznetwork == 0.27 07:42:16 INFO - mozprocess == 0.22 07:42:16 INFO - mozprofile == 0.28 07:42:16 INFO - mozrunner == 6.11 07:42:16 INFO - mozscreenshot == 0.1 07:42:16 INFO - mozsystemmonitor == 0.3 07:42:16 INFO - moztest == 0.7 07:42:16 INFO - mozversion == 1.4 07:42:16 INFO - psutil == 3.1.1 07:42:16 INFO - requests == 1.2.3 07:42:16 INFO - wsgiref == 0.1.2 07:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:16 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 07:42:16 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 07:42:16 INFO - Using env: {'DISPLAY': ':0', 07:42:16 INFO - 'HOME': '/home/cltbld', 07:42:16 INFO - 'LANG': 'en_US.UTF-8', 07:42:16 INFO - 'LANGUAGE': 'en_US:en', 07:42:16 INFO - 'LOGNAME': 'cltbld', 07:42:16 INFO - 'MAIL': '/var/mail/cltbld', 07:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:16 INFO - 'MOZ_NO_REMOTE': '1', 07:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:16 INFO - 'NO_EM_RESTART': '1', 07:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:16 INFO - 'PWD': '/builds/slave/test', 07:42:16 INFO - 'SHELL': '/bin/bash', 07:42:16 INFO - 'SHLVL': '1', 07:42:16 INFO - 'TERM': 'linux', 07:42:16 INFO - 'TMOUT': '86400', 07:42:16 INFO - 'USER': 'cltbld', 07:42:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:16 INFO - '_': '/tools/buildbot/bin/python'} 07:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 INFO - Cleaning up... 07:42:16 INFO - Return code: 0 07:42:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 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 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:16 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 07:42:16 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 07:42:16 INFO - Using env: {'DISPLAY': ':0', 07:42:16 INFO - 'HOME': '/home/cltbld', 07:42:16 INFO - 'LANG': 'en_US.UTF-8', 07:42:16 INFO - 'LANGUAGE': 'en_US:en', 07:42:16 INFO - 'LOGNAME': 'cltbld', 07:42:16 INFO - 'MAIL': '/var/mail/cltbld', 07:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:16 INFO - 'MOZ_NO_REMOTE': '1', 07:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:16 INFO - 'NO_EM_RESTART': '1', 07:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:16 INFO - 'PWD': '/builds/slave/test', 07:42:16 INFO - 'SHELL': '/bin/bash', 07:42:16 INFO - 'SHLVL': '1', 07:42:16 INFO - 'TERM': 'linux', 07:42:16 INFO - 'TMOUT': '86400', 07:42:16 INFO - 'USER': 'cltbld', 07:42:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:16 INFO - '_': '/tools/buildbot/bin/python'} 07:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:16 INFO - Downloading/unpacking jsonschema 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:42:18 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 07:42:18 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 07:42:18 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 07:42:18 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 07:42:18 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 07:42:18 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 07:42:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:18 INFO - warning: no files found matching '*.txt' 07:42:18 INFO - no previously-included directories found matching 'build' 07:42:18 INFO - no previously-included directories found matching 'dist' 07:42:18 INFO - no previously-included directories found matching '.git*' 07:42:18 INFO - Installing collected packages: jsonschema, functools32 07:42:18 INFO - Running setup.py install for functools32 07:42:18 INFO - warning: no files found matching '*.txt' 07:42:18 INFO - no previously-included directories found matching 'build' 07:42:18 INFO - no previously-included directories found matching 'dist' 07:42:18 INFO - no previously-included directories found matching '.git*' 07:42:18 INFO - Successfully installed jsonschema functools32 07:42:18 INFO - Cleaning up... 07:42:18 INFO - Return code: 0 07:42:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b41abbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, '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': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', '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 07:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:42:19 INFO - Using env: {'DISPLAY': ':0', 07:42:19 INFO - 'HOME': '/home/cltbld', 07:42:19 INFO - 'LANG': 'en_US.UTF-8', 07:42:19 INFO - 'LANGUAGE': 'en_US:en', 07:42:19 INFO - 'LOGNAME': 'cltbld', 07:42:19 INFO - 'MAIL': '/var/mail/cltbld', 07:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:19 INFO - 'MOZ_NO_REMOTE': '1', 07:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:19 INFO - 'NO_EM_RESTART': '1', 07:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:19 INFO - 'PWD': '/builds/slave/test', 07:42:19 INFO - 'SHELL': '/bin/bash', 07:42:19 INFO - 'SHLVL': '1', 07:42:19 INFO - 'TERM': 'linux', 07:42:19 INFO - 'TMOUT': '86400', 07:42:19 INFO - 'USER': 'cltbld', 07:42:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:19 INFO - '_': '/tools/buildbot/bin/python'} 07:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:19 INFO - Downloading/unpacking flake8 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:42:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:42:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 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 07:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:21 INFO - no previously-included directories found matching 'docs/_build' 07:42:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:42:21 INFO - Running setup.py install for pep8 07:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:22 INFO - no previously-included directories found matching 'docs/_build' 07:42:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:42:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:42:22 INFO - Cleaning up... 07:42:22 INFO - Return code: 0 07:42:22 INFO - Running post-action listener: _resource_record_post_action 07:42:22 INFO - Running post-action listener: _start_resource_monitoring 07:42:22 INFO - Starting resource monitoring. 07:42:22 INFO - ##### 07:42:22 INFO - ##### Finished create-virtualenv step (success) 07:42:22 INFO - ##### 07:42:22 INFO - ##### 07:42:22 INFO - ##### Running install step. 07:42:22 INFO - ##### 07:42:22 INFO - Running pre-action listener: _resource_record_pre_action 07:42:22 INFO - Running main action method: install 07:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:22 INFO - Reading from file tmpfile_stdout 07:42:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:22 INFO - Reading from file tmpfile_stdout 07:42:22 INFO - Output received: 07:42:22 INFO - Usage: mozinstall [options] installer 07:42:22 INFO - Options: 07:42:22 INFO - -h, --help show this help message and exit 07:42:22 INFO - -d DEST, --destination=DEST 07:42:22 INFO - Directory to install application into. [default: 07:42:22 INFO - "/builds/slave/test"] 07:42:22 INFO - --app=APP Application being installed. [default: firefox] 07:42:22 INFO - mkdir: /builds/slave/test/build/application 07:42:22 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'] 07:42:22 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 07:42:38 INFO - Reading from file tmpfile_stdout 07:42:38 INFO - Output received: 07:42:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - ##### 07:42:38 INFO - ##### Finished install step (success) 07:42:38 INFO - ##### 07:42:38 INFO - ##### 07:42:38 INFO - ##### Running run-tests step. 07:42:38 INFO - ##### 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: run_tests 07:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:38 INFO - Python 2.7.3 07:42:38 INFO - Return code: 0 07:42:38 INFO - grabbing minidump binary from tooltool 07:42: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')]} 07:42:38 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 0x1da99c0>, '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 0x1daa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1daad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:38 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 07:42:38 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 07:42:38 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 07:42:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:38 INFO - Return code: 0 07:42:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:42:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:42:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:39 INFO - Return code: 0 07:42:39 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/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:42:39 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/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 07:42:39 INFO - Using env: {'DISPLAY': ':0', 07:42:39 INFO - 'HOME': '/home/cltbld', 07:42:39 INFO - 'LANG': 'en_US.UTF-8', 07:42:39 INFO - 'LANGUAGE': 'en_US:en', 07:42:39 INFO - 'LOGNAME': 'cltbld', 07:42:39 INFO - 'MAIL': '/var/mail/cltbld', 07:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:39 INFO - 'MOZ_NO_REMOTE': '1', 07:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:39 INFO - 'NO_EM_RESTART': '1', 07:42:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:39 INFO - 'PWD': '/builds/slave/test', 07:42:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:39 INFO - 'SHELL': '/bin/bash', 07:42:39 INFO - 'SHLVL': '1', 07:42:39 INFO - 'TERM': 'linux', 07:42:39 INFO - 'TMOUT': '86400', 07:42:39 INFO - 'USER': 'cltbld', 07:42:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325', 07:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:39 INFO - '_': '/tools/buildbot/bin/python'} 07:42:39 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/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:42:39 INFO - mozversion application_buildid: 20160525062239 07:42:39 INFO - mozversion application_changeset: ff6044ca81893c73528253564e0f3ccbcacff046 07:42:39 INFO - mozversion application_display_name: Nightly 07:42:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:39 INFO - mozversion application_name: Firefox 07:42:39 INFO - mozversion application_remotingname: firefox 07:42:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:42:39 INFO - mozversion application_vendor: Mozilla 07:42:39 INFO - mozversion application_version: 49.0a1 07:42:39 INFO - mozversion platform_buildid: 20160525062239 07:42:39 INFO - mozversion platform_changeset: ff6044ca81893c73528253564e0f3ccbcacff046 07:42:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:42:39 INFO - mozversion platform_version: 49.0a1 07:42:39 INFO - using testdate: 1464187359 07:42:39 INFO - actual date: 1464187359 07:42:39 INFO - starting webserver on 'localhost:60689' 07:42:39 INFO - SUITE-START | Running 2 tests 07:42:39 INFO - TEST-START | dromaeo_css 07:42:39 INFO - operating with platform_type : linux_ 07:42:39 INFO - Initialising browser for dromaeo_css test... 07:42:39 INFO - TEST-INFO | started process 30469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOLi15/profile http://localhost:60689/getInfo.html) 07:42:43 INFO - PROCESS | 30469 | __metrics Screen width/height:1600/1200 07:42:43 INFO - PROCESS | 30469 | colorDepth:24 07:42:43 INFO - PROCESS | 30469 | Browser inner width/height: 1024/697 07:42:43 INFO - PROCESS | 30469 | __metrics 07:42:44 ERROR - PROCESS | 30469 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:42:45 INFO - TEST-INFO | 30469: exit 0 07:42:45 INFO - Browser initialized. 07:42:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:45 INFO - TEST-INFO | started process 30550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOLi15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:57 INFO - PROCESS | 30550 | RSS: Main: 156962816 07:42:57 INFO - PROCESS | 30550 | 07:43:49 INFO - PROCESS | 30550 | 1464187429054 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] 07:46:00 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60689/tests/dromaeo/cssquery-ext.html) 07:46:01 INFO - PROCESS | 30550 | RSS: Main: 234381312 07:46:01 INFO - PROCESS | 30550 | 07:49:04 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-ext.html (next: http://localhost:60689/tests/dromaeo/cssquery-jquery.html) 07:49:04 INFO - PROCESS | 30550 | RSS: Main: 235913216 07:49:04 INFO - PROCESS | 30550 | 07:52:06 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60689/tests/dromaeo/cssquery-mootools.html) 07:52:07 INFO - PROCESS | 30550 | RSS: Main: 239185920 07:52:07 INFO - PROCESS | 30550 | 07:55:09 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60689/tests/dromaeo/cssquery-prototype.html) 07:55:10 INFO - PROCESS | 30550 | RSS: Main: 239493120 07:55:10 INFO - PROCESS | 30550 | 07:58:13 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60689/tests/dromaeo/cssquery-yui.html) 07:58:13 INFO - PROCESS | 30550 | RSS: Main: 212434944 07:58:13 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | Cycle 1(1): loaded http://localhost:60689/tests/dromaeo/cssquery-yui.html (next: http://localhost:60689/tests/dromaeo/cssquery-dojo.html) 08:01:16 INFO - PROCESS | 30550 | RSS: Main: 272949248 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | __start_tp_report 08:01:16 INFO - PROCESS | 30550 | _x_x_mozilla_page_load 08:01:16 INFO - PROCESS | 30550 | _x_x_mozilla_page_load_details 08:01:16 INFO - PROCESS | 30550 | |i|pagename|runs| 08:01:16 INFO - PROCESS | 30550 | |0;dojo.html;2657.3223827923875;2664.5203863304623;2693.9326516837077;2698.5412479878423;2706.066407089553;4558.407407037089;4624.375709279255;4634.814607415704;4703.741294228812;4756.738379389132;4653.930191047137;4677.812887484505;4686.203345431276;4702.0595880823885;4705.058988202365;4276.550962148976;4335.891602709926;4356.041670832427;4395.208862404766;4490.50604433512;4453.332000199964;4466.531014243506;4478.574535419146;4505.234110201273;4529.388532548113;4187.685923555715;4222.19778242133;4304.160688665712;4342.435483387171;4342.544032876565;4277.743335399886;4292.678049146327;4294.119705460374;4321.481422229353;4339.370791235285;4314.633256173229;4323.005708687019;4338.262495375794;4366.8253269869165;4370.562943705636;4507.729536227804;4538.205813982539;4567.611753000999;4589.426321709786;4655.231886738684;4965.030433243737;4999.675021123651;5043.344365232533;5043.546080852704;5051.494850514956;5056.84829455117;5068.797248110071;5072.518110779507;5076.695398276115;5084.262781896641;4594.74728889911;4658.254679251338;4706.10583989041;4709.317149013374;4799.256115302133;5218.347706536683;5225.16397376418;5231;5231.450697676765;5233.790648374099;4871.488493708181;5019.42276638184;5024.698518088926;5025.597952163818;5027.1705168647495;4986.4514903360605;5022.020705962375;5025.39695236574;5036.949630503721;5064.063148317573;5001.299818025479;5009.824656137091;5011.298418221452;5011.323471331323;5062.797488100508;4765.451973023078;4887.462379138292;4982.77577509013;4993.475685053089;5051.696898186121;4074.2869997750277;4092.263392589303;4098.385242213632;4119.7940102994735;4140.23405669952;3583.104223944014;3597.0647631615443;3602.567691876939;3630.146915474861;3640.2719456108885;4282.314829627245;4284.464441944757;4290.871273861789;4327.718698284664;4348.369486424514;5050.368703912011;5101.795928162906;5106.259592359087;5109.897802043938;5140.820071297561;4396.8461103861855;4422.513523512411;4422.7346359218545;4465.26323156682;4476.574725401082;4421.690481666253;4494.70784399013;4509.278515437514;4531.999999999934;4545.36364908913;4821;4821.2045012572535;4828.227483602606;4861.80552777892;4890.119778439915;5183.766730497061;5191.039657663345;5191.32512773337;5193.844184674465;5195.74021298926;4677.953220467752;4681.485036646034;4704.67067305299;4731.337612734289;4880.389951256093;4948.851534453972;4963.5780958618925;4970.826021089245;4980.800767969241;5021.748912554431;5009.223570346602;5033.144365457808;5036.84889453317;5039.546440820343;5084.41529224144;4857.417109946829;4863.10032643962;4891.608671306358;4893.657443978887;4941.135301322182;4905.5094490550655;4923.5814955729165;4933.777979990838;4938.061768264019;4981.900361992813;4849.102915960559;4868.634852386014;4870.439899411472;4909.091818013679;4917.901641967069;4842.201036829025;4878.195097808822;4912;4923.08922849274;4959.9008019838675;4822.590079843252;4829.468758436499;4839.032193561372;4844.442889067803;4900.90198196027 08:01:16 INFO - PROCESS | 30550 | |1;ext.html;548.6214511986728;593.3028691287736;594.7412875399202;600.9008513595257;605.6880706436185;38697.41953870694;40250;40372;44407.55592444075;44429.99999999992;40748.79625601868;41262.38106428398;41305.55430559931;41317.58682413175;41353;7735.767926962186;7912;7914.169012253717;7922.04935407749;7935.365170786324;7789.883151752728;7845.68617255312;7873.881891771628;7887.566183859885;7908.762737117896;7602.2397760224085;7610.695572177106;7632.809179770495;7648.541087534766;7657.502262352957;7810.882836757453;7848.293653571206;7865.764027079197;7870.881936770953;7873.133955264945;7792.29869311759;7878.09401918781;7881.369490440751;7882.369410447208;7885.96057019717;37976.81011594952;38031;38183.809080954416;38295.42556861649;38311.616883831084;2800.327921298894;2814.802963792535;2831;2988;3294.96705032949;29037.709622903712;29219.269518262;29407;29438.70561294381;30039.249018774488;3442.621311655716;3484.6515348465205;3543.362194804934;3610.6028336883182;3620.674139327447;263366;265904.3409565899;266024;266704;268448;51755.741221293654;51998.48001520012;52075;52081.47918520766;52085.218721719204;47682;48832.26751598729;48904.02191956212;53289;54661.45338546563;12057.698557535956;14039.78940315896;14377.712445751027;14378.784318235235;14905.329260183318;11284.32294062359;11397.544098236143;11401.94299028516;11404.087672986141;11406.42967851604;15354.846451535564;15439.922800385926;15468.458603948808;15517.146556939251;15649;5044.445111037783;6310;6457.580257283262;6619.602823830585;6669.099671544376;836.3601844588894;959.3764053365369;1019.8776146862276;1062.5696592879897;1072.6567498400436;27575.31061723473;28022.439551208863;28191.57712634312;28700;28706.71293287082;900.293269783217;940.7130825098274;970.7039352997263;981.0091807274562;1027.972027972028;14838.629034274014;15060.774088388684;15102.244887755569;15330.463433779763;15372.769408458658;659585;676822;678773;680326;681059;49123.50876491261;50090.24864627034;54828.45171548233;54885.1767223492;54904.72547637316;1060.3531845574194;1257.8616352201434;1262.678017105632;1267.3663168415792;1269.3843485909326;28121.156365309074;28903.5664465029;29225.85387073051;29723.256918577208;29803;43036;43247;43254.351184732885;43403.78298108489;43519.78240108779;254762;254791;256392;256401;257448;32536;33360.666393335756;33704;38418.42372364361;38468.23063538769;42126.578734212264;42685.78657106694;42731.1541961225;42734.358984614635;43022.13955720805;34331.4850277251;35941.46087808633;36802;36938.44592331063;37498.2500349986;36495.45256821097;37018;37122.25755484929;37240.44139337966;37295.44056839204;35790.821045894605;36268;36269.27461450809;36671;36760.81619591885;30953;33235.83382083074;33351.49972750362;33581.99254022383;33685;22870.54258914779;22963.6555451665;23007;23058.308250752503;23066.538669226185 08:01:16 INFO - PROCESS | 30550 | |2;jquery.html;348.35901940429613;355.0626346445383;363.2752658446399;365.2712837888411;370.1468115992636;16630.16849157542;17199.226034828433;17212.913935430322;17696.20367083481;17876.91061544692;14589.197594132318;14723.705525889476;15026.17356045417;15026.971358866549;15057.548273551783;4774.1645212087915;4912.508749125094;4999.825006124786;5003.974980125095;5059.544640982311;3618.656227658368;3771.264603402338;4980.701157930535;5483.259759932418;5780.1907732917425;5806.158107074471;5808.070708686611;5831.212786273841;5842.47417732404;5843.912341314863;5732.31212254528;5735.225744524478;5880.676562789066;5884.705764711769;5912.17229587858;3301.7853839500353;4881.414230292352;5142.820001299937;5146.459621739701;5175.146100893348;19929.302474413325;20510;20525.17899284027;20738.170473181053;20744.06651700677;1935.4677463697456;1948.8733232339853;1952.463072655017;1956.2859556261863;1989.6816509358578;12045.457954392074;12439.689007774787;13095.803562946563;13510.797338039938;13583.864161358457;1807.475832008716;1841.2634946021565;1848.2884089625456;1851.278001579385;1863.6459072776265;66196.6690166546;67200;67364.32635673629;67610;69676;8988;9052.185303322602;9189.908100918905;9364.25085993119;9462.952685236529;12575.622731318075;12673.556425525063;12760.234385936874;12762.744745105232;12767.744645107046;6942.548734332353;6950.826229344307;7064;7089.61007144612;7304.780856574312;6304.306526282106;6370.745170193233;6434.903476447857;6569.113169722026;6644.800655980328;5885;6036.671932174914;6037.63774173551;6071.908921366183;6179.084483810033;1539.3611651164865;1574.3623832347917;1581.7152912475635;1622.9107399092927;1665.2107719569672;870.8954925408991;887.3389324952951;917.738444543302;923.4966943016072;942.9905700942903;16401.58996025085;17108.144592770313;17257.482275531755;17290;17386.04376759265;823.1357075071152;900.203320061737;900.2258058070055;915.8534634458455;943.5046600534774;9204.953975230215;9401.10689484498;9426.104520070583;9477.431354118775;9550.713478595653;379567;385012;385340;385688;385819;76029;77225.61387193028;77420;78136;78912.05439728106;941.1576638908276;947.346331031586;965.9517024148764;969.966051188205;976.2385339435252;14753.049390121803;14826.925865370604;15097.773533396788;15098.924505377403;15112.721656221522;32236.677633224306;32410.67589324171;34102.82948585241;35961;36629.1085409959;44096.55903440925;49933.75033124811;50043.49956500388;50113.498865010886;50241.24638130358;7154.928450715634;7201.639918003974;7229.963850180716;7308.451866109956;7514.812129696583;9196.540172991457;10960;11066.336019838835;11906;12063.517459301529;9700.805983880142;9710.660126895526;9874.913759486308;9903.108720215216;9959.253056020683;10187.643432479828;10307.793844122925;10316.123129534073;10645.520951557044;10793.40636265013;9672.70981870545;9836.163926066365;9975.551100200364;10040.748981275527;10171.389716617026;7121.501494895515;7184.533005354635;7207.6756545956605;7413.036305280279;7510.286522780327;7144.428445724434;8498.065212826708;9143.177114059767;9240.537973101184;9438.48088355147 08:01:16 INFO - PROCESS | 30550 | |3;mootools.html;1308.8102225177342;1381.8203633527644;1428.8642578955003;1561.859432651061;1765.9735103973442;6660.600363978165;7417.18410974793;7529.999999999993;7560.432967527444;7909.485883417574;7556.282153195451;7658.693652253917;7672.232776722325;7692.884606730903;7755.302022817959;2205.073868975034;2221.4779526811185;2228.721409823772;2231.8214542836536;2234.229190929127;2115.3548167808813;2173.261091228982;2179.3461961411595;2186.2348178137686;2189.912403503866;2137.21991473112;2155.849090563653;2186.0599942024924;2188.485705859122;2188.540406514634;2124.617568837609;2127.2767259131892;2133.839962002856;2136.3697709175754;2137.593857167133;2103.5056761661;2165.404513758713;2166.9349919502442;2167.1548096242323;2168.9891550542147;7391.113066432009;7645.694172233104;7667.808304792425;7668.38652907766;7699.037620297463;4342.956570434287;4448.466184057901;4453.4433195850515;4462.085272519126;4463.174312752151;2933.7212964768314;2949.0857834071508;2979.6424429068434;2988.865501052458;2992.431438026768;931.8555623878242;959.1176117971413;964.1659964131046;972.1299437003912;981.0581841432233;10676.62631807883;10768.515416806262;10799.136069114453;10830.620928267552;10845.349279043203;3904.06302487401;4005.7997100144876;4060.959390406117;4133.21468920904;4134.359174327984;8430.789230269169;8445.113263107409;8469.788255293666;8472.66109355619;8489.363297752694;4182.937255941163;4220.641245494167;4223.852165174204;4223.978880105641;4224.239636865394;3355.412802759556;3759.3797023491366;3830.157365379612;3872.0900588361715;3886.689064874803;3342.9665703343144;3360.6975372216616;3427.845746941394;3447.3277710846146;3452.37857185704;1026.2457094035879;1027.2398425165472;1029.4492446541065;1031.2368847053276;1038.813013657549;612.4732729852324;632.7595513704763;644.4039263681076;705.8623568404215;754.0084788503101;4834.661573689808;4953.18272485036;4958.528939750718;5074.06129865976;5111;418.4434701846537;423.7923417525452;424.23213982691425;433.9002029533225;600.1597763131564;3345.347657206821;3363.8654453822064;3434.3303055903857;3477.791332520057;3540.8583656653445;9171.58727857248;9395.62417503306;9539.61841526345;9545.856812147824;9549.809003820024;9357.672481463253;9465.290103242285;9465.716028519155;9468.715938521855;9500.762480937894;7156.177039640404;7246.891296630555;7324.523905946096;7330.340269375782;7357;4928.383952005999;4942.135126352802;5008.273800299009;5072.54347108762;5086.593072554261;8737.606807693795;8773.38586298953;8793.868091978498;8836.072212417603;8890.555472226491;8666.176713212235;8859.822803544022;8866.202041816268;8879.689210877588;8949.32880034013;6041.2750469943885;6122.877542449215;6126.295476020315;6126.989046807405;6133.202683651097;7023.789286321418;7078.1860086090755;7080.468964827555;7084.149902011792;7093.751718689821;6503.739850405931;6672.799816005528;6747.325267473213;6780.93219067803;6861.794146175623;6610.438112760469;6633.767818126343;6676.9332306676315;6781.0167525709485;6785.457163427012;6209.689515524115;6222.719977601109;6281.403266689657;6293.118963345044;6301.6534090625455;4432.601065904084;4463.776811159364;4516.006478574708;4569.017661202857;4579.313103034438;4456.777161141995;4477.597016268552;4509.864704058883;4512.435945506812;4532.796024178854 08:01:16 INFO - PROCESS | 30550 | |4;prototype.html;275.1017926470075;277.2610991707101;278.6572515805559;286.4957674492892;290.88655424384507;4686.367340409048;4721.858344249669;4727.4563425206115;4742.596879265262;4746.549077837609;4404.823807047715;4521.41221641187;4586.931196032062;4657.975245446005;4678.789454474549;3682.9503591476437;3724.7392682512236;3734.9626503734885;3746.8126593670345;3746.9812650936706;3709.9443508347395;3722.3858063419502;3743.4010558310674;3743.850245990157;3767.3030489359558;3497.45789402643;3591.8204089795536;3664.725145614076;3705.7591256568235;3734.178480734248;3663.8900832975055;3673.1551743099103;3679.1537946272238;3713.7586056906216;3713.8885833424906;3237.190702324419;3260.2827377976805;3268.967310326914;3274.8526316315583;3276.0826968448873;4385.802638881258;4514.887127821798;4524.45706515217;4545.636349092065;4572.497025327211;4152.501699796014;4160.771157586331;4172.520160181588;4172.7913604319665;4173.08192197716;4837.137701984761;4862.759996200946;4863.148948933923;4865.6107511399005;4871;3510.8238740022125;3513.875559820858;3516.5955915069585;3519.1554027033585;3519.7360197985;4822.035592881438;5103.988646698429;5114.590832733373;5120.15517439622;5130.410002849645;3484.111551554388;3487.459443786217;3491.546099007164;3496.947545786815;3501.4047611906035;3533.823308834548;3541.13242255649;3544.379733546619;3552.946705799415;3561.5726112866623;4014.1570270243574;4054.39184122384;4117.197146556453;4118.155778065489;4119.237940980928;4936.67911585753;4950.8267210647455;4955.281484184773;4957.429895562056;4972.129877271463;1132.7338075552238;1179.6814859987755;1206.1135065726685;1225.3689349984766;1236.3076677060874;818.1205204405288;822.6791551294999;822.9506229626242;834.8121672623732;839.4879123734516;4316.827326906951;4344.413504176896;4355.192595073073;4370.978145109318;4371.344298355209;4948.851534453972;4955.801767929314;4972.408829174702;4983.6760610560195;4996.300517927493;4330.566943305707;4333.826646934087;4346.348047792793;4359.6240049173275;4365.956340436555;2317.97682023181;2408.5071950531114;2410.2166795791436;2412.1557454891;2412.33660743297;4236.597523235288;4259.765712885821;4259.936100958488;4271.9359209611885;4280.443542339538;4592;4592.012717265804;4595.632349412039;4629.189891768927;4665.556772106713;3974.9098631895854;4281.37920001598;4287.871363859089;4288.24955632763;4291.013066994608;4479.731216127043;4486.371907932958;4499.932501012422;4513.187626227311;4522.660800439914;4413.183561041217;4413.779311034371;4426.690131690751;4452.5992660660695;4454.26504626733;4261.446012018542;4285.335772955197;4318.056874406592;4483.108395085217;4883.511648835088;3518.1380561761507;3531.9293614128087;3533.1697051192436;3535.151563624763;3538.6107528172397;5156.3499680103505;5157.174852023658;5179.326687530597;5182.740862956913;5196.636235463481;4798.328234047306;4858.732769697559;4933.4819843915875;4954.801807927786;4982.950170498249;4943.530364615356;4950.8267210647455;4965.677230979974;4966;4976.278439626161;4841;4877.634177436636;4889.168841297059;4891.168501354707;4917.532834380728;4724.598409135125;5018.899622007466;5021.112860105381;5022.196448568212;5029.295898574275;4869.391326084239;4891.63312751538;4901.9019619608125;4906.411230652345;4915.877103072452 08:01:16 INFO - PROCESS | 30550 | |5;yui.html;690.3338278561191;719.1621760648843;730.6164263761525;742.2243755275737;762.0550517358478;11678.416079196038;12437.191582547139;12661.113722039461;12981.415836287366;13109.60671179866;11716.707082322924;11766.823497647521;11779.293242405462;11790.705232369195;11806.468708908098;625.8904691678961;783.9568823714721;784.9921500784991;797.8125140591957;799.7360870912585;795.1809636074823;803.0884945586772;803.7387848949086;803.8512875118092;808.7695006923028;838.6310023589632;839.7061028639957;840.5839109640706;845.0155568762384;846.1327139681814;649.8472858878159;814.7515007922581;837.2381133168788;838.9622466988969;839.1692224697566;610.703808652803;611.4283145259197;611.4832966143601;611.8562137897591;611.911272865432;12333.260004399765;12339.259644421363;12387.876121238853;12398.31809250491;12411.317377544232;11823.11326650496;12208.32854193019;12233.571824986082;12237.632871013884;12411.503539858395;10442.373457592568;10583.417912014836;10703.250772445932;10821.783564328669;10886.40124793136;4053.43251944728;4064;4107.876763697094;4114.629683328485;4242.596953289432;45377.31934020959;45403.31895021578;45423.54576454259;45592.3161152583;46661.30008049882;9075.81848363029;9317.39436936597;9351.39215950961;9394.483303418241;9507.096825801538;17301.653966920592;17342.393016244623;17386.826131738522;17427.390041348746;17469.65060698779;6020.397960203944;6169.722362493699;6305.243370795534;6325.873482530324;6359.904601430982;3748.8125593720206;3756.7933763642714;3783.319002579507;3788.4127960165665;3884.2425726982965;2487.1046423287603;2580.87095645217;2581.767640912327;2588.145911849085;2590.430105376814;497.6267799150637;502.54770706364565;505.89123338482403;509.9337086178773;511.3097318619833;407.56390661991384;424.00102788128237;522.8745101175766;528.6510902804131;531.8085489223877;7369.4472914531625;7685.192552514415;7689.538627682357;7715.30562249389;7801.258880406353;440.46703488778934;513.8458462461322;521.7313083761866;523.5131327865122;524.1561086650489;3619.800910949923;3633.800140992271;3663.6153203913204;3737.3459644562095;3756.436534519844;53088;53574.196387054224;53720.731396342766;53767.19349209765;53815.192772107664;48643.75678121587;49005;49555.25667114996;49678.25482617764;50231.74884125556;45046.324305134796;45247.32129018068;45350.546494535294;45471;46049.53950460452;6884.586924784328;7007.509474336952;7012.123484564429;7078.610676412847;7092.893606596009;29749.5537566941;30549;31821;31873.043808685776;32179.195520112185;41126.58873411227;41203.7939810299;41314.79342603388;41574.79212604039;41934.790326048176;9734.561944712363;9938.254630902567;9982.650607228712;10255.487225638837;10305.330153539995;10794.784104318027;10817.031070195551;10831.446840621114;11204.83192752093;11454.911783380565;9978.101970822661;10360.585576576852;10531.104856087319;10821.837672434762;10910.290831095954;10397.53211105487;10442.112420444348;10486.318389304672;10530.31552949056;10548.525316360628;9946.254030947852;10160.898391015995;10380.06579407857;10623.256372053882;10677.89322106769;8949.373543851867;8981.595828187877;9191.86212206804;9269.907300927174;9270.165685088374;8596.957015215134;8705.427892234498;8846.911530884609;8850.424722393023;8915.375923685539 08:01:16 INFO - PROCESS | 30550 | __end_tp_report 08:01:16 INFO - PROCESS | 30550 | __start_cc_report 08:01:16 INFO - PROCESS | 30550 | _x_x_mozilla_cycle_collect,1051 08:01:16 INFO - PROCESS | 30550 | __end_cc_report 08:01:16 INFO - PROCESS | 30550 | __startTimestamp1464188476596__endTimestamp 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | ------- Summary: start ------- 08:01:16 INFO - PROCESS | 30550 | Number of tests: 6 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#0] dojo.html Cycles:165 Average:4657.00 Median:4822.59 stddev:499.20 (10.4%) stddev-sans-first:475.44 08:01:16 INFO - PROCESS | 30550 | Values: 2657.3 2664.5 2693.9 2698.5 2706.1 4558.4 4624.4 4634.8 4703.7 4756.7 4653.9 4677.8 4686.2 4702.1 4705.1 4276.6 4335.9 4356.0 4395.2 4490.5 4453.3 4466.5 4478.6 4505.2 4529.4 4187.7 4222.2 4304.2 4342.4 4342.5 4277.7 4292.7 4294.1 4321.5 4339.4 4314.6 4323.0 4338.3 4366.8 4370.6 4507.7 4538.2 4567.6 4589.4 4655.2 4965.0 4999.7 5043.3 5043.5 5051.5 5056.8 5068.8 5072.5 5076.7 5084.3 4594.7 4658.3 4706.1 4709.3 4799.3 5218.3 5225.2 5231.0 5231.5 5233.8 4871.5 5019.4 5024.7 5025.6 5027.2 4986.5 5022.0 5025.4 5036.9 5064.1 5001.3 5009.8 5011.3 5011.3 5062.8 4765.5 4887.5 4982.8 4993.5 5051.7 4074.3 4092.3 4098.4 4119.8 4140.2 3583.1 3597.1 3602.6 3630.1 3640.3 4282.3 4284.5 4290.9 4327.7 4348.4 5050.4 5101.8 5106.3 5109.9 5140.8 4396.8 4422.5 4422.7 4465.3 4476.6 4421.7 4494.7 4509.3 4532.0 4545.4 4821.0 4821.2 4828.2 4861.8 4890.1 5183.8 5191.0 5191.3 5193.8 5195.7 4678.0 4681.5 4704.7 4731.3 4880.4 4948.9 4963.6 4970.8 4980.8 5021.7 5009.2 5033.1 5036.8 5039.5 5084.4 4857.4 4863.1 4891.6 4893.7 4941.1 4905.5 4923.6 4933.8 4938.1 4981.9 4849.1 4868.6 4870.4 4909.1 4917.9 4842.2 4878.2 4912.0 4923.1 4959.9 4822.6 4829.5 4839.0 4844.4 4900.9 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#1] ext.html Cycles:180 Average:54417.46 Median:37396.85 stddev:119711.54 (320.1%) stddev-sans-first:119979.04 08:01:16 INFO - PROCESS | 30550 | Values: 548.6 593.3 594.7 600.9 605.7 38697.4 40250.0 40372.0 44407.6 44430.0 40748.8 41262.4 41305.6 41317.6 41353.0 7735.8 7912.0 7914.2 7922.0 7935.4 7789.9 7845.7 7873.9 7887.6 7908.8 7602.2 7610.7 7632.8 7648.5 7657.5 7810.9 7848.3 7865.8 7870.9 7873.1 7792.3 7878.1 7881.4 7882.4 7886.0 37976.8 38031.0 38183.8 38295.4 38311.6 2800.3 2814.8 2831.0 2988.0 3295.0 29037.7 29219.3 29407.0 29438.7 30039.2 3442.6 3484.7 3543.4 3610.6 3620.7 263366.0 265904.3 266024.0 266704.0 268448.0 51755.7 51998.5 52075.0 52081.5 52085.2 47682.0 48832.3 48904.0 53289.0 54661.5 12057.7 14039.8 14377.7 14378.8 14905.3 11284.3 11397.5 11401.9 11404.1 11406.4 15354.8 15439.9 15468.5 15517.1 15649.0 5044.4 6310.0 6457.6 6619.6 6669.1 836.4 959.4 1019.9 1062.6 1072.7 27575.3 28022.4 28191.6 28700.0 28706.7 900.3 940.7 970.7 981.0 1028.0 14838.6 15060.8 15102.2 15330.5 15372.8 659585.0 676822.0 678773.0 680326.0 681059.0 49123.5 50090.2 54828.5 54885.2 54904.7 1060.4 1257.9 1262.7 1267.4 1269.4 28121.2 28903.6 29225.9 29723.3 29803.0 43036.0 43247.0 43254.4 43403.8 43519.8 254762.0 254791.0 256392.0 256401.0 257448.0 32536.0 33360.7 33704.0 38418.4 38468.2 42126.6 42685.8 42731.2 42734.4 43022.1 34331.5 35941.5 36802.0 36938.4 37498.3 36495.5 37018.0 37122.3 37240.4 37295.4 35790.8 36268.0 36269.3 36671.0 36760.8 30953.0 33235.8 33351.5 33582.0 33685.0 22870.5 22963.7 23007.0 23058.3 23066.5 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#2] jquery.html Cycles:180 Average:23897.32 Median:5101.18 stddev:63450.93 (1243.8%) stddev-sans-first:63604.29 08:01:16 INFO - PROCESS | 30550 | Values: 348.4 355.1 363.3 365.3 370.1 16630.2 17199.2 17212.9 17696.2 17876.9 14589.2 14723.7 15026.2 15027.0 15057.5 4774.2 4912.5 4999.8 5004.0 5059.5 3618.7 3771.3 4980.7 5483.3 5780.2 5806.2 5808.1 5831.2 5842.5 5843.9 5732.3 5735.2 5880.7 5884.7 5912.2 3301.8 4881.4 5142.8 5146.5 5175.1 19929.3 20510.0 20525.2 20738.2 20744.1 1935.5 1948.9 1952.5 1956.3 1989.7 12045.5 12439.7 13095.8 13510.8 13583.9 1807.5 1841.3 1848.3 1851.3 1863.6 66196.7 67200.0 67364.3 67610.0 69676.0 8988.0 9052.2 9189.9 9364.3 9463.0 12575.6 12673.6 12760.2 12762.7 12767.7 6942.5 6950.8 7064.0 7089.6 7304.8 6304.3 6370.7 6434.9 6569.1 6644.8 5885.0 6036.7 6037.6 6071.9 6179.1 1539.4 1574.4 1581.7 1622.9 1665.2 870.9 887.3 917.7 923.5 943.0 16401.6 17108.1 17257.5 17290.0 17386.0 823.1 900.2 900.2 915.9 943.5 9205.0 9401.1 9426.1 9477.4 9550.7 379567.0 385012.0 385340.0 385688.0 385819.0 76029.0 77225.6 77420.0 78136.0 78912.1 941.2 947.3 966.0 970.0 976.2 14753.0 14826.9 15097.8 15098.9 15112.7 32236.7 32410.7 34102.8 35961.0 36629.1 44096.6 49933.8 50043.5 50113.5 50241.2 7154.9 7201.6 7230.0 7308.5 7514.8 9196.5 10960.0 11066.3 11906.0 12063.5 9700.8 9710.7 9874.9 9903.1 9959.3 10187.6 10307.8 10316.1 10645.5 10793.4 9672.7 9836.2 9975.6 10040.7 10171.4 7121.5 7184.5 7207.7 7413.0 7510.3 7144.4 8498.1 9143.2 9240.5 9438.5 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#3] mootools.html Cycles:180 Average:4981.51 Median:4935.26 stddev:2843.00 (57.6%) stddev-sans-first:2837.58 08:01:16 INFO - PROCESS | 30550 | Values: 1308.8 1381.8 1428.9 1561.9 1766.0 6660.6 7417.2 7530.0 7560.4 7909.5 7556.3 7658.7 7672.2 7692.9 7755.3 2205.1 2221.5 2228.7 2231.8 2234.2 2115.4 2173.3 2179.3 2186.2 2189.9 2137.2 2155.8 2186.1 2188.5 2188.5 2124.6 2127.3 2133.8 2136.4 2137.6 2103.5 2165.4 2166.9 2167.2 2169.0 7391.1 7645.7 7667.8 7668.4 7699.0 4343.0 4448.5 4453.4 4462.1 4463.2 2933.7 2949.1 2979.6 2988.9 2992.4 931.9 959.1 964.2 972.1 981.1 10676.6 10768.5 10799.1 10830.6 10845.3 3904.1 4005.8 4061.0 4133.2 4134.4 8430.8 8445.1 8469.8 8472.7 8489.4 4182.9 4220.6 4223.9 4224.0 4224.2 3355.4 3759.4 3830.2 3872.1 3886.7 3343.0 3360.7 3427.8 3447.3 3452.4 1026.2 1027.2 1029.4 1031.2 1038.8 612.5 632.8 644.4 705.9 754.0 4834.7 4953.2 4958.5 5074.1 5111.0 418.4 423.8 424.2 433.9 600.2 3345.3 3363.9 3434.3 3477.8 3540.9 9171.6 9395.6 9539.6 9545.9 9549.8 9357.7 9465.3 9465.7 9468.7 9500.8 7156.2 7246.9 7324.5 7330.3 7357.0 4928.4 4942.1 5008.3 5072.5 5086.6 8737.6 8773.4 8793.9 8836.1 8890.6 8666.2 8859.8 8866.2 8879.7 8949.3 6041.3 6122.9 6126.3 6127.0 6133.2 7023.8 7078.2 7080.5 7084.1 7093.8 6503.7 6672.8 6747.3 6780.9 6861.8 6610.4 6633.8 6676.9 6781.0 6785.5 6209.7 6222.7 6281.4 6293.1 6301.7 4432.6 4463.8 4516.0 4569.0 4579.3 4456.8 4477.6 4509.9 4512.4 4532.8 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#4] prototype.html Cycles:180 Average:3991.71 Median:4368.47 stddev:1159.97 (26.6%) stddev-sans-first:1129.18 08:01:16 INFO - PROCESS | 30550 | Values: 275.1 277.3 278.7 286.5 290.9 4686.4 4721.9 4727.5 4742.6 4746.5 4404.8 4521.4 4586.9 4658.0 4678.8 3683.0 3724.7 3735.0 3746.8 3747.0 3709.9 3722.4 3743.4 3743.9 3767.3 3497.5 3591.8 3664.7 3705.8 3734.2 3663.9 3673.2 3679.2 3713.8 3713.9 3237.2 3260.3 3269.0 3274.9 3276.1 4385.8 4514.9 4524.5 4545.6 4572.5 4152.5 4160.8 4172.5 4172.8 4173.1 4837.1 4862.8 4863.1 4865.6 4871.0 3510.8 3513.9 3516.6 3519.2 3519.7 4822.0 5104.0 5114.6 5120.2 5130.4 3484.1 3487.5 3491.5 3496.9 3501.4 3533.8 3541.1 3544.4 3552.9 3561.6 4014.2 4054.4 4117.2 4118.2 4119.2 4936.7 4950.8 4955.3 4957.4 4972.1 1132.7 1179.7 1206.1 1225.4 1236.3 818.1 822.7 823.0 834.8 839.5 4316.8 4344.4 4355.2 4371.0 4371.3 4948.9 4955.8 4972.4 4983.7 4996.3 4330.6 4333.8 4346.3 4359.6 4366.0 2318.0 2408.5 2410.2 2412.2 2412.3 4236.6 4259.8 4259.9 4271.9 4280.4 4592.0 4592.0 4595.6 4629.2 4665.6 3974.9 4281.4 4287.9 4288.2 4291.0 4479.7 4486.4 4499.9 4513.2 4522.7 4413.2 4413.8 4426.7 4452.6 4454.3 4261.4 4285.3 4318.1 4483.1 4883.5 3518.1 3531.9 3533.2 3535.2 3538.6 5156.3 5157.2 5179.3 5182.7 5196.6 4798.3 4858.7 4933.5 4954.8 4983.0 4943.5 4950.8 4965.7 4966.0 4976.3 4841.0 4877.6 4889.2 4891.2 4917.5 4724.6 5018.9 5021.1 5022.2 5029.3 4869.4 4891.6 4901.9 4906.4 4915.9 08:01:16 INFO - PROCESS | 30550 | 08:01:16 INFO - PROCESS | 30550 | [#5] yui.html Cycles:180 Average:12903.94 Median:45820.93 stddev:15117.38 (33.0%) stddev-sans-first:15131.97 08:01:16 INFO - PROCESS | 30550 | Values: 690.3 719.2 730.6 742.2 762.1 11678.4 12437.2 12661.1 12981.4 13109.6 11716.7 11766.8 11779.3 11790.7 11806.5 625.9 784.0 785.0 797.8 799.7 795.2 803.1 803.7 803.9 808.8 838.6 839.7 840.6 845.0 846.1 649.8 814.8 837.2 839.0 839.2 610.7 611.4 611.5 611.9 611.9 12333.3 12339.3 12387.9 12398.3 12411.3 11823.1 12208.3 12233.6 12237.6 12411.5 10442.4 10583.4 10703.3 10821.8 10886.4 4053.4 4064.0 4107.9 4114.6 4242.6 45377.3 45403.3 45423.5 45592.3 46661.3 9075.8 9317.4 9351.4 9394.5 9507.1 17301.7 17342.4 17386.8 17427.4 17469.7 6020.4 6169.7 6305.2 6325.9 6359.9 3748.8 3756.8 3783.3 3788.4 3884.2 2487.1 2580.9 2581.8 2588.1 2590.4 497.6 502.5 505.9 509.9 511.3 407.6 424.0 522.9 528.7 531.8 7369.4 7685.2 7689.5 7715.3 7801.3 440.5 513.8 521.7 523.5 524.2 3619.8 3633.8 3663.6 3737.3 3756.4 53088.0 53574.2 53720.7 53767.2 53815.2 48643.8 49005.0 49555.3 49678.3 50231.7 45046.3 45247.3 45350.5 45471.0 46049.5 6884.6 7007.5 7012.1 7078.6 7092.9 29749.6 30549.0 31821.0 31873.0 32179.2 41126.6 41203.8 41314.8 41574.8 41934.8 9734.6 9938.3 9982.7 10255.5 10305.3 10794.8 10817.0 10831.4 11204.8 11454.9 9978.1 10360.6 10531.1 10821.8 10910.3 10397.5 10442.1 10486.3 10530.3 10548.5 9946.3 10160.9 10380.1 10623.3 10677.9 8949.4 8981.6 9191.9 9269.9 9270.2 8597.0 8705.4 8846.9 8850.4 8915.4 08:01:16 INFO - PROCESS | 30550 | -------- Summary: end -------- 08:01:16 INFO - PROCESS | 30550 | 08:01:17 INFO - TEST-INFO | 30550: exit 0 08:01:17 INFO - TEST-OK | dromaeo_css | took 1117933ms 08:01:17 INFO - TEST-START | kraken 08:01:17 INFO - operating with platform_type : linux_ 08:01:17 INFO - Initialising browser for kraken test... 08:01:17 INFO - TEST-INFO | started process 30726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQSrFtO/profile http://localhost:60689/getInfo.html) 08:01:21 INFO - PROCESS | 30726 | __metrics Screen width/height:1600/1200 08:01:21 INFO - PROCESS | 30726 | colorDepth:24 08:01:21 INFO - PROCESS | 30726 | Browser inner width/height: 1024/697 08:01:21 INFO - PROCESS | 30726 | __metrics 08:01:22 ERROR - PROCESS | 30726 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:23 INFO - TEST-INFO | 30726: exit 0 08:01:23 INFO - Browser initialized. 08:01:23 INFO - Running cycle 1/1 for kraken test... 08:01:23 INFO - TEST-INFO | started process 30805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQSrFtO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:35 INFO - PROCESS | 30805 | RSS: Main: 156921856 08:01:35 INFO - PROCESS | 30805 | 08:01:38 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60689/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:39 INFO - PROCESS | 30805 | RSS: Main: 212439040 08:01:39 INFO - PROCESS | 30805 | 08:01:41 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60689/tests/kraken/driver.html?testName=audio-dft) 08:01:42 INFO - PROCESS | 30805 | RSS: Main: 200671232 08:01:42 INFO - PROCESS | 30805 | 08:01:45 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60689/tests/kraken/driver.html?testName=audio-fft) 08:01:46 INFO - PROCESS | 30805 | RSS: Main: 269819904 08:01:46 INFO - PROCESS | 30805 | 08:01:48 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60689/tests/kraken/driver.html?testName=audio-oscillator) 08:01:49 INFO - PROCESS | 30805 | RSS: Main: 177991680 08:01:49 INFO - PROCESS | 30805 | 08:01:51 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:51 INFO - PROCESS | 30805 | RSS: Main: 182652928 08:01:51 INFO - PROCESS | 30805 | 08:01:55 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60689/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:55 INFO - PROCESS | 30805 | RSS: Main: 218574848 08:01:55 INFO - PROCESS | 30805 | 08:01:59 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60689/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:59 INFO - PROCESS | 30805 | RSS: Main: 219840512 08:01:59 INFO - PROCESS | 30805 | 08:02:02 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60689/tests/kraken/driver.html?testName=json-parse-financial) 08:02:03 INFO - PROCESS | 30805 | RSS: Main: 219484160 08:02:03 INFO - PROCESS | 30805 | 08:02:04 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:02:05 INFO - PROCESS | 30805 | RSS: Main: 204435456 08:02:05 INFO - PROCESS | 30805 | 08:02:07 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:08 INFO - PROCESS | 30805 | RSS: Main: 207716352 08:02:08 INFO - PROCESS | 30805 | 08:02:10 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:10 INFO - PROCESS | 30805 | RSS: Main: 220323840 08:02:10 INFO - PROCESS | 30805 | 08:02:13 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:14 INFO - PROCESS | 30805 | RSS: Main: 227262464 08:02:14 INFO - PROCESS | 30805 | 08:02:17 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:17 INFO - PROCESS | 30805 | RSS: Main: 223621120 08:02:17 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | Cycle 1(1): loaded http://localhost:60689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60689/tests/kraken/driver.html?testName=ai-astar) 08:02:19 INFO - PROCESS | 30805 | RSS: Main: 269295616 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | __start_tp_report 08:02:19 INFO - PROCESS | 30805 | _x_x_mozilla_page_load 08:02:19 INFO - PROCESS | 30805 | _x_x_mozilla_page_load_details 08:02:19 INFO - PROCESS | 30805 | |i|pagename|runs| 08:02:19 INFO - PROCESS | 30805 | |0;ai-astar;115;110;113;113;113;113;111;112;113;114 08:02:19 INFO - PROCESS | 30805 | |1;audio-beat-detection;163;131;131;186;137;139;163;136;187;128 08:02:19 INFO - PROCESS | 30805 | |2;audio-dft;159;160;160;161;160;162;163;160;161;160 08:02:19 INFO - PROCESS | 30805 | |3;audio-fft;75;76;75;106;75;75;86;76;99;74 08:02:19 INFO - PROCESS | 30805 | |4;audio-oscillator;84;84;121;84;84;84;111;84;83;138 08:02:19 INFO - PROCESS | 30805 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 08:02:19 INFO - PROCESS | 30805 | |6;imaging-darkroom;146;146;147;145;145;147;146;146;145;146 08:02:19 INFO - PROCESS | 30805 | |7;imaging-desaturate;94;96;95;95;95;94;95;95;95;94 08:02:19 INFO - PROCESS | 30805 | |8;json-parse-financial;63;65;64;64;65;65;65;77;62;62 08:02:19 INFO - PROCESS | 30805 | |9;json-stringify-tinderbox;65;66;65;65;65;65;64;66;65;65 08:02:19 INFO - PROCESS | 30805 | |10;stanford-crypto-aes;88;84;84;81;83;83;84;84;89;83 08:02:19 INFO - PROCESS | 30805 | |11;stanford-crypto-ccm;152;133;130;135;131;130;130;142;172;143 08:02:19 INFO - PROCESS | 30805 | |12;stanford-crypto-pbkdf2;172;172;171;172;169;171;173;167;166;170 08:02:19 INFO - PROCESS | 30805 | |13;stanford-crypto-sha256-iterative;71;66;69;68;68;69;68;74;65;66 08:02:19 INFO - PROCESS | 30805 | __end_tp_report 08:02:19 INFO - PROCESS | 30805 | __start_cc_report 08:02:19 INFO - PROCESS | 30805 | _x_x_mozilla_cycle_collect,1883 08:02:19 INFO - PROCESS | 30805 | __end_cc_report 08:02:19 INFO - PROCESS | 30805 | __startTimestamp1464188539791__endTimestamp 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | ------- Summary: start ------- 08:02:19 INFO - PROCESS | 30805 | Number of tests: 14 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.42 (1.3%) stddev-sans-first:1.24 08:02:19 INFO - PROCESS | 30805 | Values: 115.0 110.0 113.0 113.0 113.0 113.0 111.0 112.0 113.0 114.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:151.00 stddev:22.84 (15.1%) stddev-sans-first:23.74 08:02:19 INFO - PROCESS | 30805 | Values: 163.0 131.0 131.0 186.0 137.0 139.0 163.0 136.0 187.0 128.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.09 08:02:19 INFO - PROCESS | 30805 | Values: 159.0 160.0 160.0 161.0 160.0 162.0 163.0 160.0 161.0 160.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:11.61 (15.4%) stddev-sans-first:12.05 08:02:19 INFO - PROCESS | 30805 | Values: 75.0 76.0 75.0 106.0 75.0 75.0 86.0 76.0 99.0 74.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:20.13 (24.0%) stddev-sans-first:20.90 08:02:19 INFO - PROCESS | 30805 | Values: 84.0 84.0 121.0 84.0 84.0 84.0 111.0 84.0 83.0 138.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:02:19 INFO - PROCESS | 30805 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:02:19 INFO - PROCESS | 30805 | Values: 146.0 146.0 147.0 145.0 145.0 147.0 146.0 146.0 145.0 146.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 08:02:19 INFO - PROCESS | 30805 | Values: 94.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:4.32 (6.6%) stddev-sans-first:4.50 08:02:19 INFO - PROCESS | 30805 | Values: 63.0 65.0 64.0 64.0 65.0 65.0 65.0 77.0 62.0 62.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:02:19 INFO - PROCESS | 30805 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 64.0 66.0 65.0 65.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.41 (2.9%) stddev-sans-first:2.15 08:02:19 INFO - PROCESS | 30805 | Values: 88.0 84.0 84.0 81.0 83.0 83.0 84.0 84.0 89.0 83.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.50 stddev:13.48 (9.7%) stddev-sans-first:13.56 08:02:19 INFO - PROCESS | 30805 | Values: 152.0 133.0 130.0 135.0 131.0 130.0 130.0 142.0 172.0 143.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:171.50 stddev:2.31 (1.3%) stddev-sans-first:2.37 08:02:19 INFO - PROCESS | 30805 | Values: 172.0 172.0 171.0 172.0 169.0 171.0 173.0 167.0 166.0 170.0 08:02:19 INFO - PROCESS | 30805 | 08:02:19 INFO - PROCESS | 30805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.63 (3.8%) stddev-sans-first:2.62 08:02:19 INFO - PROCESS | 30805 | Values: 71.0 66.0 69.0 68.0 68.0 69.0 68.0 74.0 65.0 66.0 08:02:19 INFO - PROCESS | 30805 | -------- Summary: end -------- 08:02:19 INFO - PROCESS | 30805 | 08:02:20 INFO - TEST-INFO | 30805: exit 0 08:02:20 INFO - TEST-OK | kraken | took 63455ms 08:02:20 INFO - SUITE-END | took 1181s 08:02:20 INFO - Completed test suite (00:19:41) 08:02:20 INFO - javascript benchmark 08:02:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.3223827923875, 2664.5203863304623, 2693.9326516837077, 2698.5412479878423, 2706.066407089553, 4558.407407037089, 4624.375709279255, 4634.814607415704, 4703.741294228812, 4756.738379389132, 4653.930191047137, 4677.812887484505, 4686.203345431276, 4702.0595880823885, 4705.058988202365, 4276.550962148976, 4335.891602709926, 4356.041670832427, 4395.208862404766, 4490.50604433512, 4453.332000199964, 4466.531014243506, 4478.574535419146, 4505.234110201273, 4529.388532548113, 4187.685923555715, 4222.19778242133, 4304.160688665712, 4342.435483387171, 4342.544032876565, 4277.743335399886, 4292.678049146327, 4294.119705460374, 4321.481422229353, 4339.370791235285, 4314.633256173229, 4323.005708687019, 4338.262495375794, 4366.8253269869165, 4370.562943705636, 4507.729536227804, 4538.205813982539, 4567.611753000999, 4589.426321709786, 4655.231886738684, 4965.030433243737, 4999.675021123651, 5043.344365232533, 5043.546080852704, 5051.494850514956, 5056.84829455117, 5068.797248110071, 5072.518110779507, 5076.695398276115, 5084.262781896641, 4594.74728889911, 4658.254679251338, 4706.10583989041, 4709.317149013374, 4799.256115302133, 5218.347706536683, 5225.16397376418, 5231.0, 5231.450697676765, 5233.790648374099, 4871.488493708181, 5019.42276638184, 5024.698518088926, 5025.597952163818, 5027.1705168647495, 4986.4514903360605, 5022.020705962375, 5025.39695236574, 5036.949630503721, 5064.063148317573, 5001.299818025479, 5009.824656137091, 5011.298418221452, 5011.323471331323, 5062.797488100508, 4765.451973023078, 4887.462379138292, 4982.77577509013, 4993.475685053089, 5051.696898186121, 4074.2869997750277, 4092.263392589303, 4098.385242213632, 4119.7940102994735, 4140.23405669952, 3583.104223944014, 3597.0647631615443, 3602.567691876939, 3630.146915474861, 3640.2719456108885, 4282.314829627245, 4284.464441944757, 4290.871273861789, 4327.718698284664, 4348.369486424514, 5050.368703912011, 5101.795928162906, 5106.259592359087, 5109.897802043938, 5140.820071297561, 4396.8461103861855, 4422.513523512411, 4422.7346359218545, 4465.26323156682, 4476.574725401082, 4421.690481666253, 4494.70784399013, 4509.278515437514, 4531.999999999934, 4545.36364908913, 4821.0, 4821.2045012572535, 4828.227483602606, 4861.80552777892, 4890.119778439915, 5183.766730497061, 5191.039657663345, 5191.32512773337, 5193.844184674465, 5195.74021298926, 4677.953220467752, 4681.485036646034, 4704.67067305299, 4731.337612734289, 4880.389951256093, 4948.851534453972, 4963.5780958618925, 4970.826021089245, 4980.800767969241, 5021.748912554431, 5009.223570346602, 5033.144365457808, 5036.84889453317, 5039.546440820343, 5084.41529224144, 4857.417109946829, 4863.10032643962, 4891.608671306358, 4893.657443978887, 4941.135301322182, 4905.5094490550655, 4923.5814955729165, 4933.777979990838, 4938.061768264019, 4981.900361992813, 4849.102915960559, 4868.634852386014, 4870.439899411472, 4909.091818013679, 4917.901641967069, 4842.201036829025, 4878.195097808822, 4912.0, 4923.08922849274, 4959.9008019838675, 4822.590079843252, 4829.468758436499, 4839.032193561372, 4844.442889067803, 4900.90198196027], "value": 4624.939218869671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6214511986728, 593.3028691287736, 594.7412875399202, 600.9008513595257, 605.6880706436185, 38697.41953870694, 40250.0, 40372.0, 44407.55592444075, 44429.99999999992, 40748.79625601868, 41262.38106428398, 41305.55430559931, 41317.58682413175, 41353.0, 7735.767926962186, 7912.0, 7914.169012253717, 7922.04935407749, 7935.365170786324, 7789.883151752728, 7845.68617255312, 7873.881891771628, 7887.566183859885, 7908.762737117896, 7602.2397760224085, 7610.695572177106, 7632.809179770495, 7648.541087534766, 7657.502262352957, 7810.882836757453, 7848.293653571206, 7865.764027079197, 7870.881936770953, 7873.133955264945, 7792.29869311759, 7878.09401918781, 7881.369490440751, 7882.369410447208, 7885.96057019717, 37976.81011594952, 38031.0, 38183.809080954416, 38295.42556861649, 38311.616883831084, 2800.327921298894, 2814.802963792535, 2831.0, 2988.0, 3294.96705032949, 29037.709622903712, 29219.269518262, 29407.0, 29438.70561294381, 30039.249018774488, 3442.621311655716, 3484.6515348465205, 3543.362194804934, 3610.6028336883182, 3620.674139327447, 263366.0, 265904.3409565899, 266024.0, 266704.0, 268448.0, 51755.741221293654, 51998.48001520012, 52075.0, 52081.47918520766, 52085.218721719204, 47682.0, 48832.26751598729, 48904.02191956212, 53289.0, 54661.45338546563, 12057.698557535956, 14039.78940315896, 14377.712445751027, 14378.784318235235, 14905.329260183318, 11284.32294062359, 11397.544098236143, 11401.94299028516, 11404.087672986141, 11406.42967851604, 15354.846451535564, 15439.922800385926, 15468.458603948808, 15517.146556939251, 15649.0, 5044.445111037783, 6310.0, 6457.580257283262, 6619.602823830585, 6669.099671544376, 836.3601844588894, 959.3764053365369, 1019.8776146862276, 1062.5696592879897, 1072.6567498400436, 27575.31061723473, 28022.439551208863, 28191.57712634312, 28700.0, 28706.71293287082, 900.293269783217, 940.7130825098274, 970.7039352997263, 981.0091807274562, 1027.972027972028, 14838.629034274014, 15060.774088388684, 15102.244887755569, 15330.463433779763, 15372.769408458658, 659585.0, 676822.0, 678773.0, 680326.0, 681059.0, 49123.50876491261, 50090.24864627034, 54828.45171548233, 54885.1767223492, 54904.72547637316, 1060.3531845574194, 1257.8616352201434, 1262.678017105632, 1267.3663168415792, 1269.3843485909326, 28121.156365309074, 28903.5664465029, 29225.85387073051, 29723.256918577208, 29803.0, 43036.0, 43247.0, 43254.351184732885, 43403.78298108489, 43519.78240108779, 254762.0, 254791.0, 256392.0, 256401.0, 257448.0, 32536.0, 33360.666393335756, 33704.0, 38418.42372364361, 38468.23063538769, 42126.578734212264, 42685.78657106694, 42731.1541961225, 42734.358984614635, 43022.13955720805, 34331.4850277251, 35941.46087808633, 36802.0, 36938.44592331063, 37498.2500349986, 36495.45256821097, 37018.0, 37122.25755484929, 37240.44139337966, 37295.44056839204, 35790.821045894605, 36268.0, 36269.27461450809, 36671.0, 36760.81619591885, 30953.0, 33235.83382083074, 33351.49972750362, 33581.99254022383, 33685.0, 22870.54258914779, 22963.6555451665, 23007.0, 23058.308250752503, 23066.538669226185], "value": 17870.21216226312, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.35901940429613, 355.0626346445383, 363.2752658446399, 365.2712837888411, 370.1468115992636, 16630.16849157542, 17199.226034828433, 17212.913935430322, 17696.20367083481, 17876.91061544692, 14589.197594132318, 14723.705525889476, 15026.17356045417, 15026.971358866549, 15057.548273551783, 4774.1645212087915, 4912.508749125094, 4999.825006124786, 5003.974980125095, 5059.544640982311, 3618.656227658368, 3771.264603402338, 4980.701157930535, 5483.259759932418, 5780.1907732917425, 5806.158107074471, 5808.070708686611, 5831.212786273841, 5842.47417732404, 5843.912341314863, 5732.31212254528, 5735.225744524478, 5880.676562789066, 5884.705764711769, 5912.17229587858, 3301.7853839500353, 4881.414230292352, 5142.820001299937, 5146.459621739701, 5175.146100893348, 19929.302474413325, 20510.0, 20525.17899284027, 20738.170473181053, 20744.06651700677, 1935.4677463697456, 1948.8733232339853, 1952.463072655017, 1956.2859556261863, 1989.6816509358578, 12045.457954392074, 12439.689007774787, 13095.803562946563, 13510.797338039938, 13583.864161358457, 1807.475832008716, 1841.2634946021565, 1848.2884089625456, 1851.278001579385, 1863.6459072776265, 66196.6690166546, 67200.0, 67364.32635673629, 67610.0, 69676.0, 8988.0, 9052.185303322602, 9189.908100918905, 9364.25085993119, 9462.952685236529, 12575.622731318075, 12673.556425525063, 12760.234385936874, 12762.744745105232, 12767.744645107046, 6942.548734332353, 6950.826229344307, 7064.0, 7089.61007144612, 7304.780856574312, 6304.306526282106, 6370.745170193233, 6434.903476447857, 6569.113169722026, 6644.800655980328, 5885.0, 6036.671932174914, 6037.63774173551, 6071.908921366183, 6179.084483810033, 1539.3611651164865, 1574.3623832347917, 1581.7152912475635, 1622.9107399092927, 1665.2107719569672, 870.8954925408991, 887.3389324952951, 917.738444543302, 923.4966943016072, 942.9905700942903, 16401.58996025085, 17108.144592770313, 17257.482275531755, 17290.0, 17386.04376759265, 823.1357075071152, 900.203320061737, 900.2258058070055, 915.8534634458455, 943.5046600534774, 9204.953975230215, 9401.10689484498, 9426.104520070583, 9477.431354118775, 9550.713478595653, 379567.0, 385012.0, 385340.0, 385688.0, 385819.0, 76029.0, 77225.61387193028, 77420.0, 78136.0, 78912.05439728106, 941.1576638908276, 947.346331031586, 965.9517024148764, 969.966051188205, 976.2385339435252, 14753.049390121803, 14826.925865370604, 15097.773533396788, 15098.924505377403, 15112.721656221522, 32236.677633224306, 32410.67589324171, 34102.82948585241, 35961.0, 36629.1085409959, 44096.55903440925, 49933.75033124811, 50043.49956500388, 50113.498865010886, 50241.24638130358, 7154.928450715634, 7201.639918003974, 7229.963850180716, 7308.451866109956, 7514.812129696583, 9196.540172991457, 10960.0, 11066.336019838835, 11906.0, 12063.517459301529, 9700.805983880142, 9710.660126895526, 9874.913759486308, 9903.108720215216, 9959.253056020683, 10187.643432479828, 10307.793844122925, 10316.123129534073, 10645.520951557044, 10793.40636265013, 9672.70981870545, 9836.163926066365, 9975.551100200364, 10040.748981275527, 10171.389716617026, 7121.501494895515, 7184.533005354635, 7207.6756545956605, 7413.036305280279, 7510.286522780327, 7144.428445724434, 8498.065212826708, 9143.177114059767, 9240.537973101184, 9438.48088355147], "value": 8127.338119675627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.8102225177342, 1381.8203633527644, 1428.8642578955003, 1561.859432651061, 1765.9735103973442, 6660.600363978165, 7417.18410974793, 7529.999999999993, 7560.432967527444, 7909.485883417574, 7556.282153195451, 7658.693652253917, 7672.232776722325, 7692.884606730903, 7755.302022817959, 2205.073868975034, 2221.4779526811185, 2228.721409823772, 2231.8214542836536, 2234.229190929127, 2115.3548167808813, 2173.261091228982, 2179.3461961411595, 2186.2348178137686, 2189.912403503866, 2137.21991473112, 2155.849090563653, 2186.0599942024924, 2188.485705859122, 2188.540406514634, 2124.617568837609, 2127.2767259131892, 2133.839962002856, 2136.3697709175754, 2137.593857167133, 2103.5056761661, 2165.404513758713, 2166.9349919502442, 2167.1548096242323, 2168.9891550542147, 7391.113066432009, 7645.694172233104, 7667.808304792425, 7668.38652907766, 7699.037620297463, 4342.956570434287, 4448.466184057901, 4453.4433195850515, 4462.085272519126, 4463.174312752151, 2933.7212964768314, 2949.0857834071508, 2979.6424429068434, 2988.865501052458, 2992.431438026768, 931.8555623878242, 959.1176117971413, 964.1659964131046, 972.1299437003912, 981.0581841432233, 10676.62631807883, 10768.515416806262, 10799.136069114453, 10830.620928267552, 10845.349279043203, 3904.06302487401, 4005.7997100144876, 4060.959390406117, 4133.21468920904, 4134.359174327984, 8430.789230269169, 8445.113263107409, 8469.788255293666, 8472.66109355619, 8489.363297752694, 4182.937255941163, 4220.641245494167, 4223.852165174204, 4223.978880105641, 4224.239636865394, 3355.412802759556, 3759.3797023491366, 3830.157365379612, 3872.0900588361715, 3886.689064874803, 3342.9665703343144, 3360.6975372216616, 3427.845746941394, 3447.3277710846146, 3452.37857185704, 1026.2457094035879, 1027.2398425165472, 1029.4492446541065, 1031.2368847053276, 1038.813013657549, 612.4732729852324, 632.7595513704763, 644.4039263681076, 705.8623568404215, 754.0084788503101, 4834.661573689808, 4953.18272485036, 4958.528939750718, 5074.06129865976, 5111.0, 418.4434701846537, 423.7923417525452, 424.23213982691425, 433.9002029533225, 600.1597763131564, 3345.347657206821, 3363.8654453822064, 3434.3303055903857, 3477.791332520057, 3540.8583656653445, 9171.58727857248, 9395.62417503306, 9539.61841526345, 9545.856812147824, 9549.809003820024, 9357.672481463253, 9465.290103242285, 9465.716028519155, 9468.715938521855, 9500.762480937894, 7156.177039640404, 7246.891296630555, 7324.523905946096, 7330.340269375782, 7357.0, 4928.383952005999, 4942.135126352802, 5008.273800299009, 5072.54347108762, 5086.593072554261, 8737.606807693795, 8773.38586298953, 8793.868091978498, 8836.072212417603, 8890.555472226491, 8666.176713212235, 8859.822803544022, 8866.202041816268, 8879.689210877588, 8949.32880034013, 6041.2750469943885, 6122.877542449215, 6126.295476020315, 6126.989046807405, 6133.202683651097, 7023.789286321418, 7078.1860086090755, 7080.468964827555, 7084.149902011792, 7093.751718689821, 6503.739850405931, 6672.799816005528, 6747.325267473213, 6780.93219067803, 6861.794146175623, 6610.438112760469, 6633.767818126343, 6676.9332306676315, 6781.0167525709485, 6785.457163427012, 6209.689515524115, 6222.719977601109, 6281.403266689657, 6293.118963345044, 6301.6534090625455, 4432.601065904084, 4463.776811159364, 4516.006478574708, 4569.017661202857, 4579.313103034438, 4456.777161141995, 4477.597016268552, 4509.864704058883, 4512.435945506812, 4532.796024178854], "value": 3936.7898049203327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.1017926470075, 277.2610991707101, 278.6572515805559, 286.4957674492892, 290.88655424384507, 4686.367340409048, 4721.858344249669, 4727.4563425206115, 4742.596879265262, 4746.549077837609, 4404.823807047715, 4521.41221641187, 4586.931196032062, 4657.975245446005, 4678.789454474549, 3682.9503591476437, 3724.7392682512236, 3734.9626503734885, 3746.8126593670345, 3746.9812650936706, 3709.9443508347395, 3722.3858063419502, 3743.4010558310674, 3743.850245990157, 3767.3030489359558, 3497.45789402643, 3591.8204089795536, 3664.725145614076, 3705.7591256568235, 3734.178480734248, 3663.8900832975055, 3673.1551743099103, 3679.1537946272238, 3713.7586056906216, 3713.8885833424906, 3237.190702324419, 3260.2827377976805, 3268.967310326914, 3274.8526316315583, 3276.0826968448873, 4385.802638881258, 4514.887127821798, 4524.45706515217, 4545.636349092065, 4572.497025327211, 4152.501699796014, 4160.771157586331, 4172.520160181588, 4172.7913604319665, 4173.08192197716, 4837.137701984761, 4862.759996200946, 4863.148948933923, 4865.6107511399005, 4871.0, 3510.8238740022125, 3513.875559820858, 3516.5955915069585, 3519.1554027033585, 3519.7360197985, 4822.035592881438, 5103.988646698429, 5114.590832733373, 5120.15517439622, 5130.410002849645, 3484.111551554388, 3487.459443786217, 3491.546099007164, 3496.947545786815, 3501.4047611906035, 3533.823308834548, 3541.13242255649, 3544.379733546619, 3552.946705799415, 3561.5726112866623, 4014.1570270243574, 4054.39184122384, 4117.197146556453, 4118.155778065489, 4119.237940980928, 4936.67911585753, 4950.8267210647455, 4955.281484184773, 4957.429895562056, 4972.129877271463, 1132.7338075552238, 1179.6814859987755, 1206.1135065726685, 1225.3689349984766, 1236.3076677060874, 818.1205204405288, 822.6791551294999, 822.9506229626242, 834.8121672623732, 839.4879123734516, 4316.827326906951, 4344.413504176896, 4355.192595073073, 4370.978145109318, 4371.344298355209, 4948.851534453972, 4955.801767929314, 4972.408829174702, 4983.6760610560195, 4996.300517927493, 4330.566943305707, 4333.826646934087, 4346.348047792793, 4359.6240049173275, 4365.956340436555, 2317.97682023181, 2408.5071950531114, 2410.2166795791436, 2412.1557454891, 2412.33660743297, 4236.597523235288, 4259.765712885821, 4259.936100958488, 4271.9359209611885, 4280.443542339538, 4592.0, 4592.012717265804, 4595.632349412039, 4629.189891768927, 4665.556772106713, 3974.9098631895854, 4281.37920001598, 4287.871363859089, 4288.24955632763, 4291.013066994608, 4479.731216127043, 4486.371907932958, 4499.932501012422, 4513.187626227311, 4522.660800439914, 4413.183561041217, 4413.779311034371, 4426.690131690751, 4452.5992660660695, 4454.26504626733, 4261.446012018542, 4285.335772955197, 4318.056874406592, 4483.108395085217, 4883.511648835088, 3518.1380561761507, 3531.9293614128087, 3533.1697051192436, 3535.151563624763, 3538.6107528172397, 5156.3499680103505, 5157.174852023658, 5179.326687530597, 5182.740862956913, 5196.636235463481, 4798.328234047306, 4858.732769697559, 4933.4819843915875, 4954.801807927786, 4982.950170498249, 4943.530364615356, 4950.8267210647455, 4965.677230979974, 4966.0, 4976.278439626161, 4841.0, 4877.634177436636, 4889.168841297059, 4891.168501354707, 4917.532834380728, 4724.598409135125, 5018.899622007466, 5021.112860105381, 5022.196448568212, 5029.295898574275, 4869.391326084239, 4891.63312751538, 4901.9019619608125, 4906.411230652345, 4915.877103072452], "value": 3621.0974866234965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3338278561191, 719.1621760648843, 730.6164263761525, 742.2243755275737, 762.0550517358478, 11678.416079196038, 12437.191582547139, 12661.113722039461, 12981.415836287366, 13109.60671179866, 11716.707082322924, 11766.823497647521, 11779.293242405462, 11790.705232369195, 11806.468708908098, 625.8904691678961, 783.9568823714721, 784.9921500784991, 797.8125140591957, 799.7360870912585, 795.1809636074823, 803.0884945586772, 803.7387848949086, 803.8512875118092, 808.7695006923028, 838.6310023589632, 839.7061028639957, 840.5839109640706, 845.0155568762384, 846.1327139681814, 649.8472858878159, 814.7515007922581, 837.2381133168788, 838.9622466988969, 839.1692224697566, 610.703808652803, 611.4283145259197, 611.4832966143601, 611.8562137897591, 611.911272865432, 12333.260004399765, 12339.259644421363, 12387.876121238853, 12398.31809250491, 12411.317377544232, 11823.11326650496, 12208.32854193019, 12233.571824986082, 12237.632871013884, 12411.503539858395, 10442.373457592568, 10583.417912014836, 10703.250772445932, 10821.783564328669, 10886.40124793136, 4053.43251944728, 4064.0, 4107.876763697094, 4114.629683328485, 4242.596953289432, 45377.31934020959, 45403.31895021578, 45423.54576454259, 45592.3161152583, 46661.30008049882, 9075.81848363029, 9317.39436936597, 9351.39215950961, 9394.483303418241, 9507.096825801538, 17301.653966920592, 17342.393016244623, 17386.826131738522, 17427.390041348746, 17469.65060698779, 6020.397960203944, 6169.722362493699, 6305.243370795534, 6325.873482530324, 6359.904601430982, 3748.8125593720206, 3756.7933763642714, 3783.319002579507, 3788.4127960165665, 3884.2425726982965, 2487.1046423287603, 2580.87095645217, 2581.767640912327, 2588.145911849085, 2590.430105376814, 497.6267799150637, 502.54770706364565, 505.89123338482403, 509.9337086178773, 511.3097318619833, 407.56390661991384, 424.00102788128237, 522.8745101175766, 528.6510902804131, 531.8085489223877, 7369.4472914531625, 7685.192552514415, 7689.538627682357, 7715.30562249389, 7801.258880406353, 440.46703488778934, 513.8458462461322, 521.7313083761866, 523.5131327865122, 524.1561086650489, 3619.800910949923, 3633.800140992271, 3663.6153203913204, 3737.3459644562095, 3756.436534519844, 53088.0, 53574.196387054224, 53720.731396342766, 53767.19349209765, 53815.192772107664, 48643.75678121587, 49005.0, 49555.25667114996, 49678.25482617764, 50231.74884125556, 45046.324305134796, 45247.32129018068, 45350.546494535294, 45471.0, 46049.53950460452, 6884.586924784328, 7007.509474336952, 7012.123484564429, 7078.610676412847, 7092.893606596009, 29749.5537566941, 30549.0, 31821.0, 31873.043808685776, 32179.195520112185, 41126.58873411227, 41203.7939810299, 41314.79342603388, 41574.79212604039, 41934.790326048176, 9734.561944712363, 9938.254630902567, 9982.650607228712, 10255.487225638837, 10305.330153539995, 10794.784104318027, 10817.031070195551, 10831.446840621114, 11204.83192752093, 11454.911783380565, 9978.101970822661, 10360.585576576852, 10531.104856087319, 10821.837672434762, 10910.290831095954, 10397.53211105487, 10442.112420444348, 10486.318389304672, 10530.31552949056, 10548.525316360628, 9946.254030947852, 10160.898391015995, 10380.06579407857, 10623.256372053882, 10677.89322106769, 8949.373543851867, 8981.595828187877, 9191.86212206804, 9269.907300927174, 9270.165685088374, 8596.957015215134, 8705.427892234498, 8846.911530884609, 8850.424722393023, 8915.375923685539], "value": 5804.100025140501, "unit": "score"}], "name": "dromaeo_css", "value": 6177.6891211911525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 113.0, 113.0, 113.0, 111.0, 112.0, 113.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 131.0, 186.0, 137.0, 139.0, 163.0, 136.0, 187.0, 128.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 161.0, 160.0, 162.0, 163.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 106.0, 75.0, 75.0, 86.0, 76.0, 99.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 121.0, 84.0, 84.0, 84.0, 111.0, 84.0, 83.0, 138.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 77.0, 62.0, 62.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 81.0, 83.0, 83.0, 84.0, 84.0, 89.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 130.0, 135.0, 131.0, 130.0, 130.0, 142.0, 172.0, 143.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 171.0, 172.0, 169.0, 171.0, 173.0, 167.0, 166.0, 170.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 69.0, 68.0, 68.0, 69.0, 68.0, 74.0, 65.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1551.3999999999999, "alertThreshold": 2.0}]} 08:02:21 INFO - Return code: 0 08:02:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:02:21 ERROR - # TBPL SUCCESS # 08:02:21 INFO - Running post-action listener: _resource_record_post_action 08:02:21 INFO - ##### 08:02:21 INFO - ##### Finished run-tests step (success) 08:02:21 INFO - ##### 08:02:21 INFO - Running post-run listener: _resource_record_post_run 08:02:21 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 521420800; Read time: 0; Write time: 524292 08:02:21 INFO - TinderboxPrint: CPU usage
13.1% 08:02:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:02:21 INFO - TinderboxPrint: I/O write bytes / time
521,420,800 / 524,292 08:02:21 INFO - TinderboxPrint: CPU idle
8,306.9 (86.9%) 08:02:21 INFO - TinderboxPrint: CPU user
1,212.3 (12.7%) 08:02:21 INFO - TinderboxPrint: Swap in / out
0 / 0 08:02:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236937216; Read time: 0; Write time: 350248 08:02:21 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284405760; Read time: 0; Write time: 173980 08:02:21 INFO - Running post-run listener: _upload_blobber_files 08:02:21 INFO - Blob upload gear active. 08:02:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:21 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:02:21 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:02:21 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:02:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:02:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:26 INFO - (blobuploader) - INFO - Done attempting. 08:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:27 INFO - (blobuploader) - INFO - Done attempting. 08:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:27 INFO - (blobuploader) - INFO - Done attempting. 08:02:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:27 INFO - Return code: 0 08:02:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78351ca6ef878a5f0a00c601faae2887b77fa017c888ebf2c00995c32491c5281a5c7b0eb6f34671e3a0f28cae272bae6ddb69fa5238bee0c004f4e468ac5e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e2f4686a4ec75e309888c91f82129ef86f68ec6a259846fe67bbea3c611cc5fca1c2b9b651f7ead57062ff8520c3093dffcc5755d733d19bfe3a44c703f9eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03056e5a45b638467d1a9ae9602d6ade65e3429767bc9ad94fe7b00d6c06b435c44945cd68f95ef4d80a784e15bd87eda388d4824ff5e8a50580d3670d3ec25c"} 08:02:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:27 INFO - Contents: 08:02:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78351ca6ef878a5f0a00c601faae2887b77fa017c888ebf2c00995c32491c5281a5c7b0eb6f34671e3a0f28cae272bae6ddb69fa5238bee0c004f4e468ac5e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e2f4686a4ec75e309888c91f82129ef86f68ec6a259846fe67bbea3c611cc5fca1c2b9b651f7ead57062ff8520c3093dffcc5755d733d19bfe3a44c703f9eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03056e5a45b638467d1a9ae9602d6ade65e3429767bc9ad94fe7b00d6c06b435c44945cd68f95ef4d80a784e15bd87eda388d4824ff5e8a50580d3670d3ec25c"} 08:02:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:27 INFO - Copying logs to upload dir... 08:02:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.928334 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-25 08:02:27.960230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 08:02:27.965849) ========= 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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 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/78351ca6ef878a5f0a00c601faae2887b77fa017c888ebf2c00995c32491c5281a5c7b0eb6f34671e3a0f28cae272bae6ddb69fa5238bee0c004f4e468ac5e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e2f4686a4ec75e309888c91f82129ef86f68ec6a259846fe67bbea3c611cc5fca1c2b9b651f7ead57062ff8520c3093dffcc5755d733d19bfe3a44c703f9eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03056e5a45b638467d1a9ae9602d6ade65e3429767bc9ad94fe7b00d6c06b435c44945cd68f95ef4d80a784e15bd87eda388d4824ff5e8a50580d3670d3ec25c"} build_url:https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/YX3fh2l9RXaJO29Ye9Xhrg/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/78351ca6ef878a5f0a00c601faae2887b77fa017c888ebf2c00995c32491c5281a5c7b0eb6f34671e3a0f28cae272bae6ddb69fa5238bee0c004f4e468ac5e1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e2f4686a4ec75e309888c91f82129ef86f68ec6a259846fe67bbea3c611cc5fca1c2b9b651f7ead57062ff8520c3093dffcc5755d733d19bfe3a44c703f9eaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03056e5a45b638467d1a9ae9602d6ade65e3429767bc9ad94fe7b00d6c06b435c44945cd68f95ef4d80a784e15bd87eda388d4824ff5e8a50580d3670d3ec25c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 08:02:27.994631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:02:27.994954) ========= 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=db0483c52d987ecb441a263b000001ad-1464187028.266376-711995325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 08:02:28.075332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 08:02:28.075815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 08:02:28.076124) ========= ========= Total master_lag: 0.22 =========