builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1463671390.46 results: success (0) buildid: 20160519074355 builduid: 322091999a014eb6bed730c7e879dee1 revision: e8112fba80d64c7c6615c9019178e68f60b5d718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.462764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.463168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.464314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.496257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.496603) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 08:23:10-- 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.4M=0s 2016-05-19 08:23:11 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.321376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.831519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.834903) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.884481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:10.887878) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e8112fba80d64c7c6615c9019178e68f60b5d718 --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 e8112fba80d64c7c6615c9019178e68f60b5d718 --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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 08:23:11,143 truncating revision to first 12 chars 2016-05-19 08:23:11,143 Setting DEBUG logging. 2016-05-19 08:23:11,143 attempt 1/10 2016-05-19 08:23:11,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e8112fba80d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 08:23:11,517 unpacking tar archive at: fx-team-e8112fba80d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:11.582578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:11.582884) ========= script_repo_revision: e8112fba80d64c7c6615c9019178e68f60b5d718 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:11.583267) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:11.583529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 08:23:11.592306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-19 08:23:11.592641) ========= /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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:11 INFO - MultiFileLogger online at 20160519 08:23:11 in /builds/slave/test 08:23:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:23:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:11 INFO - {'append_to_log': False, 08:23:11 INFO - 'base_work_dir': '/builds/slave/test', 08:23:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:23:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:11 INFO - 'branch': 'Fx-Team-Non-PGO', 08:23:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:11 INFO - 'config_files': ('talos/linux_config.py',), 08:23:11 INFO - 'default_actions': ('clobber', 08:23:11 INFO - 'read-buildbot-config', 08:23:11 INFO - 'download-and-extract', 08:23:11 INFO - 'populate-webroot', 08:23:11 INFO - 'create-virtualenv', 08:23:11 INFO - 'install', 08:23:11 INFO - 'run-tests'), 08:23:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:11 INFO - 'download_minidump_stackwalk': True, 08:23:11 INFO - 'download_symbols': 'ondemand', 08:23:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:11 INFO - 'installer_path': 'installer.exe', 08:23:11 INFO - 'log_level': 'info', 08:23:11 INFO - 'log_name': 'talos', 08:23:11 INFO - 'log_to_console': True, 08:23:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:11 INFO - 'opt_config_files': (), 08:23:11 INFO - 'pip_index': False, 08:23:11 INFO - 'sps_profile': False, 08:23:11 INFO - 'sps_profile_interval': 0, 08:23:11 INFO - 'suite': 'dromaeojs', 08:23:11 INFO - 'system_bits': '32', 08:23:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:11 INFO - 'title': 'talos-linux64-ix-001', 08:23:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:11 INFO - 'use_talos_json': True, 08:23:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:11 INFO - 'work_dir': 'build'} 08:23:11 INFO - ##### 08:23:11 INFO - ##### Running clobber step. 08:23:11 INFO - ##### 08:23:11 INFO - Running pre-action listener: _resource_record_pre_action 08:23:11 INFO - Running main action method: clobber 08:23:11 INFO - rmtree: /builds/slave/test/build 08:23:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:12 INFO - Running post-action listener: _resource_record_post_action 08:23:12 INFO - ##### 08:23:12 INFO - ##### Finished clobber step (success) 08:23:12 INFO - ##### 08:23:12 INFO - ##### 08:23:12 INFO - ##### Running read-buildbot-config step. 08:23:12 INFO - ##### 08:23:12 INFO - Running pre-action listener: _resource_record_pre_action 08:23:12 INFO - Running main action method: read_buildbot_config 08:23:12 INFO - Using buildbot properties: 08:23:12 INFO - { 08:23:12 INFO - "project": "", 08:23:12 INFO - "product": "firefox", 08:23:12 INFO - "script_repo_revision": "production", 08:23:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:23:12 INFO - "repository": "", 08:23:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:23:12 INFO - "buildid": "20160519074355", 08:23:12 INFO - "pgo_build": "False", 08:23:12 INFO - "basedir": "/builds/slave/test", 08:23:12 INFO - "buildnumber": 2991, 08:23:12 INFO - "slavename": "talos-linux64-ix-001", 08:23:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:12 INFO - "platform": "ubuntu64_hw", 08:23:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:23:12 INFO - "branch": "fx-team", 08:23:12 INFO - "repo_path": "integration/fx-team", 08:23:12 INFO - "revision": "e8112fba80d64c7c6615c9019178e68f60b5d718", 08:23:12 INFO - "stage_platform": "linux64", 08:23:12 INFO - "builduid": "322091999a014eb6bed730c7e879dee1", 08:23:12 INFO - "slavebuilddir": "test" 08:23:12 INFO - } 08:23:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:23:12 INFO - Running post-action listener: _resource_record_post_action 08:23:12 INFO - ##### 08:23:12 INFO - ##### Finished read-buildbot-config step (success) 08:23:12 INFO - ##### 08:23:12 INFO - ##### 08:23:12 INFO - ##### Running download-and-extract step. 08:23:12 INFO - ##### 08:23:12 INFO - Running pre-action listener: _resource_record_pre_action 08:23:12 INFO - Running main action method: download_and_extract 08:23:12 INFO - mkdir: /builds/slave/test/build/tests 08:23: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')]} 08:23:12 INFO - https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:23:15 INFO - Downloaded 1361 bytes. 08:23:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:15 INFO - Using the following test package requirements: 08:23:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:23:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'jsshell-linux-x86_64.zip'], 08:23:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:15 INFO - https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:17 INFO - Downloaded 22812201 bytes. 08:23:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:19 INFO - Return code: 0 08:23:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:19 INFO - https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:20 INFO - Downloaded 22812201 bytes. 08:23:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:21 INFO - Return code: 0 08:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:21 INFO - https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:30 INFO - Downloaded 10840194 bytes. 08:23:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:23:31 INFO - Return code: 0 08:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:31 INFO - https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:33 INFO - Downloaded 54801846 bytes. 08:23:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:33 INFO - mkdir: /builds/slave/test/properties 08:23:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:33 INFO - Contents: 08:23:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:33 INFO - Running post-action listener: _resource_record_post_action 08:23:33 INFO - Running post-action listener: set_extra_try_arguments 08:23:33 INFO - ##### 08:23:33 INFO - ##### Finished download-and-extract step (success) 08:23:33 INFO - ##### 08:23:33 INFO - ##### 08:23:33 INFO - ##### Running populate-webroot step. 08:23:33 INFO - ##### 08:23:33 INFO - Running pre-action listener: _resource_record_pre_action 08:23:33 INFO - Running main action method: populate_webroot 08:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:33 INFO - '--tppagecycles', 08:23:33 INFO - '7'], 08:23:33 INFO - 'tests': ['tsvgm']}}, 08:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['damp', 'tps']}, 08:23:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['damp', 'tps']}, 08:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['dromaeo_dom']}, 08:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tsvgx', 08:23:33 INFO - 'tsvgr_opacity', 08:23:33 INFO - 'tart', 08:23:33 INFO - 'tscrollx', 08:23:33 INFO - 'cart']}, 08:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:33 INFO - 'tsvgr_opacity', 08:23:33 INFO - 'tart', 08:23:33 INFO - 'tscrollx', 08:23:33 INFO - 'cart']}, 08:23:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tp5o']}, 08:23:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['tp5o']}, 08:23:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s', 08:23:33 INFO - '--xperf_path', 08:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:33 INFO - 'tests': ['tp5n']}, 08:23:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--xperf_path', 08:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:33 INFO - 'tests': ['tp5n']}}, 08:23:33 INFO - 'talos.zip': {'path': '', 08:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:33 INFO - Running post-action listener: _resource_record_post_action 08:23:33 INFO - ##### 08:23:33 INFO - ##### Finished populate-webroot step (success) 08:23:33 INFO - ##### 08:23:33 INFO - ##### 08:23:33 INFO - ##### Running create-virtualenv step. 08:23:33 INFO - ##### 08:23:33 INFO - Running pre-action listener: _resource_record_pre_action 08:23:33 INFO - Running main action method: create_virtualenv 08:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:33 INFO - Using real prefix '/usr' 08:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:36 INFO - Installing pip.................done. 08:23:36 INFO - Return code: 0 08:23:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:36 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:36 INFO - Using env: {'DISPLAY': ':0', 08:23:36 INFO - 'HOME': '/home/cltbld', 08:23:36 INFO - 'LANG': 'en_US.UTF-8', 08:23:36 INFO - 'LANGUAGE': 'en_US:en', 08:23:36 INFO - 'LOGNAME': 'cltbld', 08:23:36 INFO - 'MAIL': '/var/mail/cltbld', 08:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:36 INFO - 'MOZ_NO_REMOTE': '1', 08:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:36 INFO - 'NO_EM_RESTART': '1', 08:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:36 INFO - 'PWD': '/builds/slave/test', 08:23:36 INFO - 'SHELL': '/bin/bash', 08:23:36 INFO - 'SHLVL': '1', 08:23:36 INFO - 'TERM': 'linux', 08:23:36 INFO - 'TMOUT': '86400', 08:23:36 INFO - 'USER': 'cltbld', 08:23:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:36 INFO - '_': '/tools/buildbot/bin/python'} 08:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:36 INFO - Cleaning up... 08:23:36 INFO - Return code: 0 08:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:36 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:23:36 INFO - Using env: {'DISPLAY': ':0', 08:23:36 INFO - 'HOME': '/home/cltbld', 08:23:36 INFO - 'LANG': 'en_US.UTF-8', 08:23:36 INFO - 'LANGUAGE': 'en_US:en', 08:23:36 INFO - 'LOGNAME': 'cltbld', 08:23:36 INFO - 'MAIL': '/var/mail/cltbld', 08:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:36 INFO - 'MOZ_NO_REMOTE': '1', 08:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:36 INFO - 'NO_EM_RESTART': '1', 08:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:36 INFO - 'PWD': '/builds/slave/test', 08:23:36 INFO - 'SHELL': '/bin/bash', 08:23:36 INFO - 'SHLVL': '1', 08:23:36 INFO - 'TERM': 'linux', 08:23:36 INFO - 'TMOUT': '86400', 08:23:36 INFO - 'USER': 'cltbld', 08:23:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:36 INFO - '_': '/tools/buildbot/bin/python'} 08:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:36 INFO - Downloading/unpacking psutil>=3.1.1 08:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:38 INFO - Installing collected packages: psutil 08:23:38 INFO - Running setup.py install for psutil 08:23:38 INFO - building 'psutil._psutil_linux' extension 08:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:23:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:23:38 INFO - building 'psutil._psutil_posix' extension 08:23:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:23:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:23:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:39 INFO - Successfully installed psutil 08:23:39 INFO - Cleaning up... 08:23:39 INFO - Return code: 0 08:23:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:39 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:39 INFO - Using env: {'DISPLAY': ':0', 08:23:39 INFO - 'HOME': '/home/cltbld', 08:23:39 INFO - 'LANG': 'en_US.UTF-8', 08:23:39 INFO - 'LANGUAGE': 'en_US:en', 08:23:39 INFO - 'LOGNAME': 'cltbld', 08:23:39 INFO - 'MAIL': '/var/mail/cltbld', 08:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:39 INFO - 'MOZ_NO_REMOTE': '1', 08:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:39 INFO - 'NO_EM_RESTART': '1', 08:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:39 INFO - 'PWD': '/builds/slave/test', 08:23:39 INFO - 'SHELL': '/bin/bash', 08:23:39 INFO - 'SHLVL': '1', 08:23:39 INFO - 'TERM': 'linux', 08:23:39 INFO - 'TMOUT': '86400', 08:23:39 INFO - 'USER': 'cltbld', 08:23:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:39 INFO - '_': '/tools/buildbot/bin/python'} 08:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:41 INFO - Installing collected packages: mozsystemmonitor 08:23:41 INFO - Running setup.py install for mozsystemmonitor 08:23:41 INFO - Successfully installed mozsystemmonitor 08:23:41 INFO - Cleaning up... 08:23:41 INFO - Return code: 0 08:23:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:41 INFO - Using env: {'DISPLAY': ':0', 08:23:41 INFO - 'HOME': '/home/cltbld', 08:23:41 INFO - 'LANG': 'en_US.UTF-8', 08:23:41 INFO - 'LANGUAGE': 'en_US:en', 08:23:41 INFO - 'LOGNAME': 'cltbld', 08:23:41 INFO - 'MAIL': '/var/mail/cltbld', 08:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:41 INFO - 'MOZ_NO_REMOTE': '1', 08:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:41 INFO - 'NO_EM_RESTART': '1', 08:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:41 INFO - 'PWD': '/builds/slave/test', 08:23:41 INFO - 'SHELL': '/bin/bash', 08:23:41 INFO - 'SHLVL': '1', 08:23:41 INFO - 'TERM': 'linux', 08:23:41 INFO - 'TMOUT': '86400', 08:23:41 INFO - 'USER': 'cltbld', 08:23:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:41 INFO - '_': '/tools/buildbot/bin/python'} 08:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:44 INFO - Downloading docopt-0.6.1.tar.gz 08:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:44 INFO - Running setup.py install for blobuploader 08:23:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:44 INFO - Running setup.py install for requests 08:23:44 INFO - Running setup.py install for docopt 08:23:44 INFO - Successfully installed blobuploader requests docopt 08:23:44 INFO - Cleaning up... 08:23:44 INFO - Return code: 0 08:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:44 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:44 INFO - Using env: {'DISPLAY': ':0', 08:23:44 INFO - 'HOME': '/home/cltbld', 08:23:44 INFO - 'LANG': 'en_US.UTF-8', 08:23:44 INFO - 'LANGUAGE': 'en_US:en', 08:23:44 INFO - 'LOGNAME': 'cltbld', 08:23:44 INFO - 'MAIL': '/var/mail/cltbld', 08:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:44 INFO - 'MOZ_NO_REMOTE': '1', 08:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:44 INFO - 'NO_EM_RESTART': '1', 08:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:44 INFO - 'PWD': '/builds/slave/test', 08:23:44 INFO - 'SHELL': '/bin/bash', 08:23:44 INFO - 'SHLVL': '1', 08:23:44 INFO - 'TERM': 'linux', 08:23:44 INFO - 'TMOUT': '86400', 08:23:44 INFO - 'USER': 'cltbld', 08:23:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:44 INFO - '_': '/tools/buildbot/bin/python'} 08:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:45 INFO - Running setup.py (path:/tmp/pip-D5B8d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:45 INFO - Running setup.py (path:/tmp/pip-wmMBPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:45 INFO - Running setup.py (path:/tmp/pip-1TsQ80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:45 INFO - Running setup.py (path:/tmp/pip-4lrmfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:45 INFO - Running setup.py (path:/tmp/pip-7o9PU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:45 INFO - Running setup.py (path:/tmp/pip-2LeRRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:45 INFO - Running setup.py (path:/tmp/pip-jtxYRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:45 INFO - Running setup.py (path:/tmp/pip-C_TppY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:45 INFO - Running setup.py (path:/tmp/pip-Emh1Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:45 INFO - Running setup.py (path:/tmp/pip-Ul0NaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:45 INFO - Running setup.py (path:/tmp/pip-yKc7Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:46 INFO - Running setup.py (path:/tmp/pip-2pkJJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:46 INFO - Running setup.py (path:/tmp/pip-R267jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:46 INFO - Running setup.py (path:/tmp/pip-dfm3iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:46 INFO - Running setup.py (path:/tmp/pip-mGioEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:46 INFO - Running setup.py (path:/tmp/pip-e6VaGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:46 INFO - Running setup.py (path:/tmp/pip-ZDPKHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:46 INFO - Running setup.py install for manifestparser 08:23:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:46 INFO - Running setup.py install for mozcrash 08:23:46 INFO - Running setup.py install for mozdebug 08:23:46 INFO - Running setup.py install for mozdevice 08:23:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:46 INFO - Running setup.py install for mozfile 08:23:46 INFO - Running setup.py install for mozhttpd 08:23:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozinfo 08:23:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozInstall 08:23:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozleak 08:23:47 INFO - Running setup.py install for mozlog 08:23:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for moznetwork 08:23:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozprocess 08:23:47 INFO - Running setup.py install for mozprofile 08:23:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozrunner 08:23:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:47 INFO - Running setup.py install for mozscreenshot 08:23:47 INFO - Running setup.py install for moztest 08:23:48 INFO - Running setup.py install for mozversion 08:23:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:48 INFO - Cleaning up... 08:23:48 INFO - Return code: 0 08:23:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:48 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:48 INFO - Using env: {'DISPLAY': ':0', 08:23:48 INFO - 'HOME': '/home/cltbld', 08:23:48 INFO - 'LANG': 'en_US.UTF-8', 08:23:48 INFO - 'LANGUAGE': 'en_US:en', 08:23:48 INFO - 'LOGNAME': 'cltbld', 08:23:48 INFO - 'MAIL': '/var/mail/cltbld', 08:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:48 INFO - 'MOZ_NO_REMOTE': '1', 08:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:48 INFO - 'NO_EM_RESTART': '1', 08:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:48 INFO - 'PWD': '/builds/slave/test', 08:23:48 INFO - 'SHELL': '/bin/bash', 08:23:48 INFO - 'SHLVL': '1', 08:23:48 INFO - 'TERM': 'linux', 08:23:48 INFO - 'TMOUT': '86400', 08:23:48 INFO - 'USER': 'cltbld', 08:23:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:48 INFO - '_': '/tools/buildbot/bin/python'} 08:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:48 INFO - Running setup.py (path:/tmp/pip-UNdwcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:48 INFO - Running setup.py (path:/tmp/pip-5wTKSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:48 INFO - Running setup.py (path:/tmp/pip-MLqRki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:48 INFO - Running setup.py (path:/tmp/pip-ERIJ2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:48 INFO - Running setup.py (path:/tmp/pip-l_paXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:48 INFO - Running setup.py (path:/tmp/pip-RGinZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:48 INFO - Running setup.py (path:/tmp/pip-2I3zKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:48 INFO - Running setup.py (path:/tmp/pip-6puywk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:49 INFO - Running setup.py (path:/tmp/pip-JQ6q98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:49 INFO - Running setup.py (path:/tmp/pip-2_tyA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:49 INFO - Running setup.py (path:/tmp/pip-RKgl_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:49 INFO - Running setup.py (path:/tmp/pip-kCUpnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:49 INFO - Running setup.py (path:/tmp/pip-LohCAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:49 INFO - Running setup.py (path:/tmp/pip-h2mwtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:49 INFO - Running setup.py (path:/tmp/pip-6wpWXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:49 INFO - Running setup.py (path:/tmp/pip-D7Mstf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:49 INFO - Running setup.py (path:/tmp/pip-Nublqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:51 INFO - Downloading blessings-1.6.tar.gz 08:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:51 INFO - Installing collected packages: blessings 08:23:51 INFO - Running setup.py install for blessings 08:23:51 INFO - Successfully installed blessings 08:23:51 INFO - Cleaning up... 08:23:51 INFO - Return code: 0 08:23:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:52 INFO - Reading from file tmpfile_stdout 08:23:52 INFO - Current package versions: 08:23:52 INFO - argparse == 1.2.1 08:23:52 INFO - blessings == 1.6 08:23:52 INFO - blobuploader == 1.2.4 08:23:52 INFO - docopt == 0.6.1 08:23:52 INFO - manifestparser == 1.1 08:23:52 INFO - mozInstall == 1.12 08:23:52 INFO - mozcrash == 0.17 08:23:52 INFO - mozdebug == 0.1 08:23:52 INFO - mozdevice == 0.48 08:23:52 INFO - mozfile == 1.2 08:23:52 INFO - mozhttpd == 0.7 08:23:52 INFO - mozinfo == 0.9 08:23:52 INFO - mozleak == 0.1 08:23:52 INFO - mozlog == 3.2 08:23:52 INFO - moznetwork == 0.27 08:23:52 INFO - mozprocess == 0.22 08:23:52 INFO - mozprofile == 0.28 08:23:52 INFO - mozrunner == 6.11 08:23:52 INFO - mozscreenshot == 0.1 08:23:52 INFO - mozsystemmonitor == 0.3 08:23:52 INFO - moztest == 0.7 08:23:52 INFO - mozversion == 1.4 08:23:52 INFO - psutil == 3.1.1 08:23:52 INFO - requests == 1.2.3 08:23:52 INFO - wsgiref == 0.1.2 08:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:52 INFO - Using env: {'DISPLAY': ':0', 08:23:52 INFO - 'HOME': '/home/cltbld', 08:23:52 INFO - 'LANG': 'en_US.UTF-8', 08:23:52 INFO - 'LANGUAGE': 'en_US:en', 08:23:52 INFO - 'LOGNAME': 'cltbld', 08:23:52 INFO - 'MAIL': '/var/mail/cltbld', 08:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:52 INFO - 'MOZ_NO_REMOTE': '1', 08:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:52 INFO - 'NO_EM_RESTART': '1', 08:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:52 INFO - 'PWD': '/builds/slave/test', 08:23:52 INFO - 'SHELL': '/bin/bash', 08:23:52 INFO - 'SHLVL': '1', 08:23:52 INFO - 'TERM': 'linux', 08:23:52 INFO - 'TMOUT': '86400', 08:23:52 INFO - 'USER': 'cltbld', 08:23:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:52 INFO - '_': '/tools/buildbot/bin/python'} 08:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:52 INFO - Cleaning up... 08:23:52 INFO - Return code: 0 08:23:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:52 INFO - Using env: {'DISPLAY': ':0', 08:23:52 INFO - 'HOME': '/home/cltbld', 08:23:52 INFO - 'LANG': 'en_US.UTF-8', 08:23:52 INFO - 'LANGUAGE': 'en_US:en', 08:23:52 INFO - 'LOGNAME': 'cltbld', 08:23:52 INFO - 'MAIL': '/var/mail/cltbld', 08:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:52 INFO - 'MOZ_NO_REMOTE': '1', 08:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:52 INFO - 'NO_EM_RESTART': '1', 08:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:52 INFO - 'PWD': '/builds/slave/test', 08:23:52 INFO - 'SHELL': '/bin/bash', 08:23:52 INFO - 'SHLVL': '1', 08:23:52 INFO - 'TERM': 'linux', 08:23:52 INFO - 'TMOUT': '86400', 08:23:52 INFO - 'USER': 'cltbld', 08:23:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:52 INFO - '_': '/tools/buildbot/bin/python'} 08:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:52 INFO - Downloading/unpacking jsonschema 08:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:54 INFO - Downloading/unpacking functools32 (from jsonschema) 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:54 INFO - warning: no files found matching '*.txt' 08:23:54 INFO - no previously-included directories found matching 'build' 08:23:54 INFO - no previously-included directories found matching 'dist' 08:23:54 INFO - no previously-included directories found matching '.git*' 08:23:54 INFO - Installing collected packages: jsonschema, functools32 08:23:54 INFO - Running setup.py install for functools32 08:23:54 INFO - warning: no files found matching '*.txt' 08:23:54 INFO - no previously-included directories found matching 'build' 08:23:54 INFO - no previously-included directories found matching 'dist' 08:23:54 INFO - no previously-included directories found matching '.git*' 08:23:54 INFO - Successfully installed jsonschema functools32 08:23:54 INFO - Cleaning up... 08:23:54 INFO - Return code: 0 08:23:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 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 0x7f8da4a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:23:54 INFO - Using env: {'DISPLAY': ':0', 08:23:54 INFO - 'HOME': '/home/cltbld', 08:23:54 INFO - 'LANG': 'en_US.UTF-8', 08:23:54 INFO - 'LANGUAGE': 'en_US:en', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MAIL': '/var/mail/cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SHLVL': '1', 08:23:54 INFO - 'TERM': 'linux', 08:23:54 INFO - 'TMOUT': '86400', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - '_': '/tools/buildbot/bin/python'} 08:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:55 INFO - Downloading/unpacking flake8 08:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:23:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:23:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:57 INFO - no previously-included directories found matching 'docs/_build' 08:23:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:23:57 INFO - Running setup.py install for pep8 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:57 INFO - no previously-included directories found matching 'docs/_build' 08:23:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:23:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:23:57 INFO - Cleaning up... 08:23:57 INFO - Return code: 0 08:23:57 INFO - Running post-action listener: _resource_record_post_action 08:23:57 INFO - Running post-action listener: _start_resource_monitoring 08:23:57 INFO - Starting resource monitoring. 08:23:57 INFO - ##### 08:23:57 INFO - ##### Finished create-virtualenv step (success) 08:23:57 INFO - ##### 08:23:57 INFO - ##### 08:23:57 INFO - ##### Running install step. 08:23:57 INFO - ##### 08:23:57 INFO - Running pre-action listener: _resource_record_pre_action 08:23:57 INFO - Running main action method: install 08:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:58 INFO - Reading from file tmpfile_stdout 08:23:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:58 INFO - Reading from file tmpfile_stdout 08:23:58 INFO - Output received: 08:23:58 INFO - Usage: mozinstall [options] installer 08:23:58 INFO - Options: 08:23:58 INFO - -h, --help show this help message and exit 08:23:58 INFO - -d DEST, --destination=DEST 08:23:58 INFO - Directory to install application into. [default: 08:23:58 INFO - "/builds/slave/test"] 08:23:58 INFO - --app=APP Application being installed. [default: firefox] 08:23:58 INFO - mkdir: /builds/slave/test/build/application 08:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:24:14 INFO - Reading from file tmpfile_stdout 08:24:14 INFO - Output received: 08:24:14 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:14 INFO - Running post-action listener: _resource_record_post_action 08:24:14 INFO - ##### 08:24:14 INFO - ##### Finished install step (success) 08:24:14 INFO - ##### 08:24:14 INFO - ##### 08:24:14 INFO - ##### Running run-tests step. 08:24:14 INFO - ##### 08:24:14 INFO - Running pre-action listener: _resource_record_pre_action 08:24:14 INFO - Running main action method: run_tests 08:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:14 INFO - Python 2.7.3 08:24:14 INFO - Return code: 0 08:24:14 INFO - grabbing minidump binary from tooltool 08:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:14 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 0x27309c0>, '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 0x27318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2731d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:24:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:24:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:24:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:14 INFO - Return code: 0 08:24:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:24:15 INFO - Return code: 0 08:24:15 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/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:24:15 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/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:24:15 INFO - Using env: {'DISPLAY': ':0', 08:24:15 INFO - 'HOME': '/home/cltbld', 08:24:15 INFO - 'LANG': 'en_US.UTF-8', 08:24:15 INFO - 'LANGUAGE': 'en_US:en', 08:24:15 INFO - 'LOGNAME': 'cltbld', 08:24:15 INFO - 'MAIL': '/var/mail/cltbld', 08:24:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:15 INFO - 'MOZ_NO_REMOTE': '1', 08:24:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:15 INFO - 'NO_EM_RESTART': '1', 08:24:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:15 INFO - 'PWD': '/builds/slave/test', 08:24:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:15 INFO - 'SHELL': '/bin/bash', 08:24:15 INFO - 'SHLVL': '1', 08:24:15 INFO - 'TERM': 'linux', 08:24:15 INFO - 'TMOUT': '86400', 08:24:15 INFO - 'USER': 'cltbld', 08:24:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700', 08:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:15 INFO - '_': '/tools/buildbot/bin/python'} 08:24:15 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/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:24:15 INFO - mozversion application_buildid: 20160519074355 08:24:15 INFO - mozversion application_changeset: e8112fba80d64c7c6615c9019178e68f60b5d718 08:24:15 INFO - mozversion application_display_name: Nightly 08:24:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:15 INFO - mozversion application_name: Firefox 08:24:15 INFO - mozversion application_remotingname: firefox 08:24:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:24:15 INFO - mozversion application_vendor: Mozilla 08:24:15 INFO - mozversion application_version: 49.0a1 08:24:15 INFO - mozversion platform_buildid: 20160519074355 08:24:15 INFO - mozversion platform_changeset: e8112fba80d64c7c6615c9019178e68f60b5d718 08:24:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:24:15 INFO - mozversion platform_version: 49.0a1 08:24:15 INFO - using testdate: 1463671455 08:24:15 INFO - actual date: 1463671455 08:24:15 INFO - starting webserver on 'localhost:54745' 08:24:15 INFO - SUITE-START | Running 2 tests 08:24:15 INFO - TEST-START | dromaeo_css 08:24:15 INFO - operating with platform_type : linux_ 08:24:15 INFO - Initialising browser for dromaeo_css test... 08:24:15 INFO - TEST-INFO | started process 14813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMM3Z4W/profile http://localhost:54745/getInfo.html) 08:24:19 INFO - PROCESS | 14813 | __metrics Screen width/height:1600/1200 08:24:19 INFO - PROCESS | 14813 | colorDepth:24 08:24:19 INFO - PROCESS | 14813 | Browser inner width/height: 1024/697 08:24:19 INFO - PROCESS | 14813 | __metrics 08:24:20 ERROR - PROCESS | 14813 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:24:21 INFO - TEST-INFO | 14813: exit 0 08:24:21 INFO - Browser initialized. 08:24:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:21 INFO - TEST-INFO | started process 14891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMM3Z4W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:33 INFO - PROCESS | 14891 | RSS: Main: 154886144 08:24:33 INFO - PROCESS | 14891 | 08:25:24 INFO - PROCESS | 14891 | 1463671524798 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:27:37 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54745/tests/dromaeo/cssquery-ext.html) 08:27:38 INFO - PROCESS | 14891 | RSS: Main: 249860096 08:27:38 INFO - PROCESS | 14891 | 08:30:40 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-ext.html (next: http://localhost:54745/tests/dromaeo/cssquery-jquery.html) 08:30:41 INFO - PROCESS | 14891 | RSS: Main: 233398272 08:30:41 INFO - PROCESS | 14891 | 08:33:43 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54745/tests/dromaeo/cssquery-mootools.html) 08:33:44 INFO - PROCESS | 14891 | RSS: Main: 244170752 08:33:44 INFO - PROCESS | 14891 | 08:36:46 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54745/tests/dromaeo/cssquery-prototype.html) 08:36:47 INFO - PROCESS | 14891 | RSS: Main: 240558080 08:36:47 INFO - PROCESS | 14891 | 08:39:50 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54745/tests/dromaeo/cssquery-yui.html) 08:39:50 INFO - PROCESS | 14891 | RSS: Main: 224358400 08:39:50 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | Cycle 1(1): loaded http://localhost:54745/tests/dromaeo/cssquery-yui.html (next: http://localhost:54745/tests/dromaeo/cssquery-dojo.html) 08:42:53 INFO - PROCESS | 14891 | RSS: Main: 289742848 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | __start_tp_report 08:42:53 INFO - PROCESS | 14891 | _x_x_mozilla_page_load 08:42:53 INFO - PROCESS | 14891 | _x_x_mozilla_page_load_details 08:42:53 INFO - PROCESS | 14891 | |i|pagename|runs| 08:42:53 INFO - PROCESS | 14891 | |0;dojo.html;2672.532306846302;2675.5317819381603;2707.404371038372;2710.552758794798;2712.050782226221;4618.284165954283;4666.626669866411;4722.693024953375;4785.282207668852;4824.107540105078;4712.481627021033;4718.150732868083;4731.361266229058;4745.976270118653;4812.879678008052;4269.8292068317305;4288.549702281262;4338.110687309094;4426.800793964279;4436.068425630621;4424.513303536608;4435;4518.751468669222;4547.067851090518;4548.454185497745;4280.336547835091;4327.567243275647;4381.780910954471;4425.424694789689;4425.911481770347;4365.869023929287;4369.016971181491;4381.408509851161;4381.671374646914;4385.101054283896;4306.332518459643;4315.834724624366;4353.172897149531;4374.34384842273;4404.097160082176;4651.255799072166;4685.390899183119;4722.574968252839;4730.810767569293;4735.763211839394;5089.8727531812;5090.211017292326;5132.358455193101;5143.305653736735;5143.922841157386;4960.553550180501;5030.496950304941;5105.591552675777;5110.821121260738;5137.7944882204665;4763.118823017753;4768.5946694531;4798.184308667535;4799.880002999953;4815.085133824562;5137.768800403991;5277.973610131925;5287.814926477555;5291.973540132351;5293.497117773805;5006.324146240284;5043.9747801260755;5062.569681577033;5102.872428189325;5122.590192784568;5148.897022059537;5151.201563757623;5153.6907785532985;5155.845324640267;5157.613179011589;4912.312276281324;4919.581835543947;5087.31321271631;5101.591872650179;5144.074066667961;4897.608191344684;4903.509649035068;4924.630652701062;4970.577500912391;4977.90044199114;4187.309093999456;4195.727277726938;4200.789960501963;4228.090960443458;4239.40648309237;3667.504886840296;3675.503806986076;3675.5773086094905;3737.981310093432;3738.3084129436143;4447.888802779892;4461.420015398043;4467.039586488921;4516.977415112903;4519.050999290186;5055.620828437882;5157.9684063187515;5158.74206289684;5159.226116082617;5205.505476979681;4302.849400270976;4399.076193999232;4444.711093778894;4452.977735111369;4504.549545045469;4556.316552517149;4562.8631141065825;4564.885877853014;4570.908581828345;4585.977070114628;4888.828890988798;4890.608751299958;4892.461829198856;4898.314236006961;4951.603871690184;5006.774695138801;5091.847244582668;5093.414257360451;5129.435762066095;5169.638125331191;4888.682235654671;4911.8280860169725;4934.136526107845;4966.279889415942;4979;5033.823816166563;5034.84895453137;5040.873978150576;5071.797128114834;5125.7693403796175;4950.1584730596605;4979.053979743837;5041.42023667283;5104.642675012862;5123.180291153398;4909.4845041270155;4910.263460480956;4912.533309335608;4915.778789954389;4947.233178857283;4948.901021979612;4956.330895329229;4960.826371076995;4960.975195124001;4996.15065438869;4749.453812811433;4842.757862106951;4904.141775189256;4906.975465122651;4911.754412279443;5008.774605142705;5037.748112594282;5050.090983622983;5079.415867175322;5082.33929589151;4936.407631084293;4943.777530011086;4944.1100601892;4954.900901981868;5003.649744517848 08:42:53 INFO - PROCESS | 14891 | |1;ext.html;561.4245398466571;596.1891827115124;602.0547740048127;602.196068248888;606.3481757111107;27893;30222.54666180009;30323.241918952037;30351.392972140544;41991.370129448085;39658.60341396585;40007;40068.19863602734;40102.59897401025;40175.59824401755;7915.920840791576;8103.068147163063;8108.675652973874;8109.675612975474;8111.310538604226;7567.697292108309;7807.297343239107;7822.022247219098;7903.920960790376;7996.640151193181;10118.747031324203;10473.947630261839;10475.161987041056;10789.298695584763;10792.892071079306;10275.948620256926;10389.064984151388;10389.220808439322;10392;10392.532336044858;7484.625768711597;7734.2265773422205;7737.883931740972;10102.09081182697;10239.488025598765;42771;43505.12989740219;43598.12803743908;43653.12693746107;43658.56341436609;3271.2312606537444;3292.308615190813;3368.562086928708;3431.2108215110416;3893.6885049196;29961.550576741367;30245.69754302473;30745.231369215948;30863.228419289473;31693.36613267745;3498.860045598173;3564.697000754939;3608.2422691234874;3612.151144481045;3641.4901913732097;287032;288110.9999999979;288687;289553;290356;33102;33787.66212337845;33862.66137338644;55748.72125639346;56303.71848140733;35514.11214719652;35561.8221908894;35611.643883560835;35621.8218908909;35628;13738.862611373957;13848.030637855254;13870.722585548232;13880.167189968432;13884.652883677787;11226.158038147172;11308.151888608387;11317.773644527064;11336.263142895685;11350.602728904449;7672.65473053714;8034.919650803534;8271.048829384577;8319.126491718403;8322.375821813388;3188.091393952712;3231.1922019495128;3236.093893709765;3247.8376081195847;3284.3267130238723;864.7362554420836;943.0710749911332;943.127606963556;963.0946909904667;977.8239916814899;28115.43769124647;29564.260893477403;29764.55353169704;29859.40281194364;30047.549286760717;973.2749101919115;981.7300242433245;1000.8740167311774;1105.90599799018;1127.5151684775626;14937.925310373379;15398.769018464733;15457.613559661098;15472.303746331441;15495.767563486557;421295;424667;424957;424979;425401;49501.50498495041;49769.25346119811;49847.75076124596;49973.25040124401;50032.24951625729;1108.894655007773;1174.2719513901436;1239.20690757915;1240.789065858788;1249.2067537113817;27350;28886.566701499072;29652.851735741184;30101;30248.5462718055;42802.78598606987;43146.13707725765;43430.78284608557;43536.129277414904;43541.78229108834;327830;328908;329651;330612;331759;22614.434639134153;24795;25371.87314063418;25718.742812571636;25774.226773196835;42195.57804422039;42363.57636423596;42756;42892.78553607212;43556.34665480084;36254.274914502086;36429.45355819612;36634.084147896516;36826.26347472982;36922.815385923976;36578.26843463169;36699.26601468009;36711;36771;37021.62978370182;35938.64061359457;37767.43348849715;38660.420093698056;39097;42227.57772422236;32758.00035979079;34753.30493390169;34992.65007349996;35368.823155884056;35374.29251415009;26290.868545657147;26555.33611659724;26614.467710646066;26820.8658956704;26856 08:42:53 INFO - PROCESS | 14891 | |2;jquery.html;375.8045816175589;376.58387481832557;378.8105947026487;383.61255132316353;392.6525025352562;16275.430359937389;17070;17730.734038989427;17933.551661208476;17950.0127492988;10304.124149447287;10380.532876020578;10502;10518.31630943988;11119.666410007712;4568.908621827562;4735.92896106557;4839.346688197101;5555.611107222496;5563.471470210324;5481.369642491105;5541.196526503654;5553.972230138844;5588.077967135418;5599.272094627693;5246.947530524703;5542.806001789938;5546;5589.80435684749;5607.943920560783;5502.119660854264;5516.200150978106;5516.503514683657;5517.917231241535;5520.530754885819;4637.373954516131;4961.851144465636;4970.577500912426;5010.048090862724;5012.649114561982;20129.597408051904;20203.39389818308;20492.590148196952;20758.896205519028;20801.58396832055;1850.7223916412645;1893.6307420053095;1939.4957311099074;1942.5920556683113;1987.1653905359783;8835.55822208887;8942.86585701215;9165.404248723811;9273.675421360287;13022.609321720363;1753.114677088075;1845.2250054976942;1845.5847434327304;1849.2048419179748;1862.7112797516406;73297.2670273301;74026.25973740302;74249;75901.62049189719;75920.86118708168;9726.562304696306;9741.220702343795;9801.277396600559;9811.116999470081;9853;13172;13229.933850330686;13231.139975901535;13236.13965092266;13265.403056862464;6820.419279878104;6883.931160688329;7126.572405655677;7226.277372262732;7250.274972502813;6849.417799487;6899.344562266577;6912.792616221522;7009.579425234502;7029.683664235122;4197.97901010493;4211.768352740629;4217.240896638573;4239.576042395735;4362.847300344472;1725.55998220453;1730.7490413889916;1742.0766993493469;1743.808181100078;1756.1482680899753;843.5529169540154;861.8362511122866;885.3758100539104;901.783571942729;953.952302384878;16487.670246595;16998.490045298662;17446.127693615268;17547.64904701899;17985.10074496296;853.5049671190694;896.5427631907644;908.2143945487238;920.9493477858782;929.846575315079;9572.32993690435;9684.225261979025;9705;9975.501224938724;10101.494925253708;149018.25490872693;304940;366455.01269923354;371946;376894;52335.47664523382;72120.63939680268;76489;77709;81288;954.3796532253951;1000.4097582426404;1010.3735683876043;1013.1995723378449;1017.6489111256604;16139.354425823305;16244.837551624805;16289.348426062825;16331;16587.253573588976;36117.45823812697;37490.25019499649;37529.62470375261;37627.24745505129;37826.43260351152;47231.763841180575;49675;50981.23528147155;53165.4683453176;53600;7606.619669016416;7790.337821285254;7798.766037018899;7854.2145785421;7923.286904178421;6783.05037294789;10130.949345253226;11386.715332116763;11869.169158158846;11877.703057423634;10196.643117491149;10493.422861742678;10512.42181680015;10683.732906677395;10710.785784284426;6097.603655762361;10511.632092876713;10536.947315263375;10668.413237271714;10805.081568066802;10017.14854237398;10129.848052279369;10446.738831529272;10823.783524329312;10971.83542246851;7727.729529466442;7742.7677169685;7776.339011183886;7797;7906.051273847175;9840.901590983998;10355.844662330222;10359.119474844723;10539.314944528582;10575.682729518127 08:42:53 INFO - PROCESS | 14891 | |3;mootools.html;1306.7713150198713;1492.3582859370474;1532.4176812811133;1682.1421075251626;1855.8979256140915;6847.691853866576;7634.770956871296;7767.184445633205;7780.961095194531;8010.719624813133;7848.4113691473085;7920.762377128681;7948;7993.880091798627;8025.558594277312;1937.5543624966267;2176.3906106290265;2247.191011235958;2255.086689890589;2270.318904328703;2239.193890199527;2297.4945511987335;2304.83866129371;2304.976950230493;2305.5158416732424;2243.6971008913833;2249.347689170139;2262.1856131792542;2307.2962746362355;2310.1683393978155;1877.2115711401245;2156.8813715245656;2206.2719302630176;2231.9218827340965;2240.215924426446;2224.7663995280423;2250.5723912456583;2256.808171305441;2256.9435764105865;2257.2663884237522;7958.761237162895;7993.960030199812;7995.160508146619;8014.959925200395;8015.198480151997;4631.976840115778;4755.595774359183;4756.453007904101;4767.809287628491;4770.022145460172;2884.2356775454523;3121.453745594512;3122.656507784142;3123.8757644801526;3136.1218858719594;980.8871979722352;998.9450580218086;1002.6039714312878;1010.3331801011298;1036.233257203269;10876.075533579655;10877.83683244752;10881.347119172875;10890.945545272301;10892.346459212473;4253.532111467736;4311.827526898952;4406.603405693503;4430.335449682573;4439.66702497314;9300.906990930003;9313.767155821159;9350.392224505522;9357.625694972261;9360.251179905592;4726.881827954328;4730.692504987165;4732.526747325309;4738.147133515931;4741.83403580873;3732.1602639405914;4187.476565429321;4245.448091748053;4338.848140315074;4348.695591308641;3763.397856342972;3788.659020688096;3829.7127715421457;3860.208657225262;3912.197999410114;1235.209465941798;1255.3911352993791;1256.616731896762;1259.6284096191646;1272.2684456437585;751.1812124784012;845.146402133837;874.8556488179506;883.3992884838243;924.426855349674;5335.919961200585;5426.538744206708;5461.0716178249795;5478.753456094485;5484.232207490954;858.6822875536092;904.9502277374676;945.1021529546958;949.0746522140857;955.8518429643416;3740.4202348636004;3820.6370394812448;3846.3653497173214;3847.8653247136217;3857.3056849767313;9574.234061275081;9637.855432168522;9879.802403952024;9900.65347712841;9911.801763964824;9631.229501639851;9734.464604446823;9781.462019588991;9815;9823.214142868554;7458.172747676854;7519.548827070394;7537.472376933562;7681.500702454323;7689.115751688628;5256.237845512455;5306.575473962151;5312.920306195488;5353.197020446964;5476.698781567052;9075.183233509017;9139.908600913906;9167.495787731472;9192.356535042483;9200.355975081948;8537.658493660432;8813.823723525365;8832.735017949472;9141.177294043568;9195.954020229856;6034.306054803754;6610.768623098168;6808.829779255559;6917.619530925847;6999.930000699927;7518.661660225193;7528.397728181622;7574.734884279023;7591.962040189764;7598.772036838904;6748.0552722617895;6825.658717064028;6942.444604431533;6950.895736563854;6968.895466568107;6800.557963732342;6843.726250949906;6864.931350686629;6885.724571017103;7005.54463959841;6130.325664177026;6372.713227904663;6502.479801615765;6579.736810527525;6584.703688333941;4364.236258654786;4463.642908567372;4487.730736155841;4536.024754677628;4537.841175558971;4550.749708765918;4639.884002899955;4642.558956899089;4656.604188643868;4721.811127554996 08:42:53 INFO - PROCESS | 14891 | |4;prototype.html;308.6465996434083;313.64244760972497;314.8960842921836;316.6247996124592;319.6324227138792;4791.353167322415;4869.610431165507;4877.731724755137;4880.902381952359;4892.804287828482;4779.139754844126;4794.280857871321;4814.494478079804;4826;4829.855104346875;3566.3402270579895;3647.4528820676846;3691.870784522542;3704.74066815323;3709.4435834624887;3679.981600091996;3708.9814550927344;3837.079101015764;3893.6885049196;3904.3362628353248;3796.6013568575318;3825.5600605930395;3861.343571592836;3872.593377695344;3874.767513949158;3582.17609949713;3797.316483033053;3841.750286231386;3843.538775346962;3860.6332398422105;3324.8337583120747;3329.1344250494803;3330.333933213343;3333.916652083693;3338.562849120156;4572.199865023607;4608.861734147981;4624.676272660915;4640.976795116003;4648.628109751246;4271.9786401067795;4285.35719642053;4309.288967320388;4327.221100201994;4348.4999225089205;4905.2642103684375;4947.332110165117;4990.625703072248;5047.293378926953;5054.9241761373605;3595.63365920951;3624.4200927851416;3635.1275693833554;3641.817909104561;3649.489071529988;5303.946960530384;5310.459966609678;5324.787008519655;5334.573234141299;5351.277577527023;3493.7554371194283;3687.797171155612;3691.686206672463;3727;3745.438184272381;3757.9436308455397;3759.9696164071643;3786.6213378661914;3797.335466293443;3801.2777572261184;4275.273203555403;4284.871453856389;4297.841086801199;4315.309550471972;4325.740455572675;4875.390576177978;5062.114130027304;5064.34163558735;5081.441041485434;5084.13569693153;1288.4008935844877;1303.0162227518163;1303.1594621469098;1305.9934700326628;1309.6987692830703;816.8243827577099;823.3660081737029;825.6903661127077;846.5936350551647;848.520585868982;4454.175977444183;4527.728336299832;4534.637229021736;4535.342375355555;4537.228671125917;5210.166373380241;5213.504717051874;5241.528262456397;5252.474752524793;5268.1834315681135;4486.1252055849445;4503.909921801611;4534.730275522859;4553.430821147356;4570.108828778356;2642.6960899496803;2760.7653349465118;2794.4271424357958;2794.5249307617755;2794.9301267468477;4988.730127791846;4989.875253118701;4992.377477319886;5002.449730529639;5003.324551185616;5173.551405606437;5259.973700131475;5309.681419114865;5359.598030147755;5363.919541206885;4954.405471343462;4956.801727930914;4961.255811628284;4971.4282857471135;4978.452370239271;5191.792328306826;5202.375714914235;5223.0935708466895;5223.634345595772;5245.947540524546;4842.58837998774;5062.241078612239;5083.847484575469;5097.1844504879045;5121.231815227746;4988.176950803077;4998.200287954055;5006.849794506171;5013.523715247045;5028.723420211777;3718.2935242303874;3721.1255354991013;3738.158914244273;3743.139078012127;3757.1922036761134;5115.5396014358885;5200.5059519345605;5308.389535203347;5334.359876814807;5338.733063346895;5045.470225626256;5064.34163558735;5069.6197785167;5072.315237443046;5090.371081253963;5068.898622027465;5076.324812811689;5085.669431486942;5086.787247547329;5086.821961231339;4753.239481682914;4945.23348880924;4985.4266759323145;4989.401271847401;4998.4501704813165;4904.828331008541;5019.7490125494305;5035.974820125876;5044.9243261350375;5134.84465995163;4851.175300198904;4939.431965324034;4965.801367945386;4996.225585034325;5019.791291831582 08:42:53 INFO - PROCESS | 14891 | |5;yui.html;679.9354061364172;695.4505940307157;706;755.2032605601096;757.0839284465796;12082.456289466973;12618.116731828775;12627.494900204003;12629.11596188266;12639.55761548346;12925.935370323159;12977.156484828503;12998.285094319808;13034.283114428703;13035.34823258838;678.2640834694363;817.5912043978011;848.9405741598091;854.3122786157141;855.6064210463195;856.6787454704486;858.3305022082754;862.2110768646712;862.5945805471418;864.8010957479784;718.3355396258466;917.3440989692368;917.4541148016953;917.9082091790801;918.912703293186;730.9926900730978;732.0300601702738;732.2567593892204;876.662484943295;909.3180114913814;666.7299743603849;667.206024830455;667.3393340592778;667.346000919102;667.5227212543007;12257;12340.259584424963;12366.876331236663;12404.705129551063;12434.502619895193;11767.352795596238;12108.15242932995;12175.147739658227;12310.790168032136;12417.44121514534;11146.498407571678;11192.496337664825;11529.769404611945;11633.650990470214;11926.463309151022;4172.002930169268;4172.728772629769;4191.874243772691;4203.054312779631;4312.116016216668;46942.76528617335;46986.76506617479;47343.76328118372;47453.52546474525;47507.28739068917;9714.659986900424;10047.547860346302;10107.191424686007;10249.282550221562;10547.419891905865;17169.141542922804;17346.739798903025;17364.479065628053;17404.912975435043;17407.3037078518;6702.262751097375;6721.22705888829;6786.966065169642;6915.273896240923;6983.790486285419;3856.633619806114;3866;3912.0415498203124;3963.801809909493;3977.2642061218767;2844.5306524423654;2911.4177164567172;2922.605448264457;2923.9122826315242;2924.692907244751;528.8598521391834;529.8595872093898;534.7914313417771;536.5761048771427;547.4087984976217;507.4443484384593;518.5488624896365;580.9832792612928;598.643806934873;602.8388228201945;8478.279346255636;8534.27458666008;8570.700025499202;8706.347023973227;8823.69117080899;387.1482737976407;516.8061777294462;598.9820305390846;627.2567008095422;627.4627163449476;3862.4013277941403;3864.265789499986;3945.4834858734125;4107.753534787922;4119.443875076886;50994;52345.21482177771;52428.47571524312;56687;57534.84930301454;49150.26274605884;49864.75067624639;50324;50902.49097508978;52416.47583524116;45620.31569526393;46507.767461162475;47019.52980470152;47269;47543.04913901772;8668.39321247532;8723.345749068718;8989.235914947303;9063.365564410427;9196.218321442751;31327.84336078305;31946.52080218845;32663.510047349784;32972;33182;39175.608243917195;39451.80274098611;42015.159696806506;42100.57899420967;42495.3625695621;11004.834927475935;11078.224524283223;11101.614862129574;11159.21885468042;11211.439428028729;11509.53961841517;12086.879131208576;12238.877611223774;12642.936785316382;13024.869751302745;10759.838602420814;11455.535679584085;11659.300441973508;12177.147599667938;12309.295746687038;11401.834880574117;11506.94246528762;11696.239744416585;11768.235064720766;12279.44742486608;11594.71013224676;11638.41807909618;11794.233374830608;12185.817212741638;12283.938580307042;9545.474998875128;9549.188318992963;9767.413955162712;9925.845397377818;10255;9437.732945631687;9828;9847;9928;10023.348482348916 08:42:53 INFO - PROCESS | 14891 | __end_tp_report 08:42:53 INFO - PROCESS | 14891 | __start_cc_report 08:42:53 INFO - PROCESS | 14891 | _x_x_mozilla_cycle_collect,940 08:42:53 INFO - PROCESS | 14891 | __end_cc_report 08:42:53 INFO - PROCESS | 14891 | __startTimestamp1463672573871__endTimestamp 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | ------- Summary: start ------- 08:42:53 INFO - PROCESS | 14891 | Number of tests: 6 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#0] dojo.html Cycles:165 Average:4713.88 Median:4898.31 stddev:498.17 (10.2%) stddev-sans-first:473.27 08:42:53 INFO - PROCESS | 14891 | Values: 2672.5 2675.5 2707.4 2710.6 2712.1 4618.3 4666.6 4722.7 4785.3 4824.1 4712.5 4718.2 4731.4 4746.0 4812.9 4269.8 4288.5 4338.1 4426.8 4436.1 4424.5 4435.0 4518.8 4547.1 4548.5 4280.3 4327.6 4381.8 4425.4 4425.9 4365.9 4369.0 4381.4 4381.7 4385.1 4306.3 4315.8 4353.2 4374.3 4404.1 4651.3 4685.4 4722.6 4730.8 4735.8 5089.9 5090.2 5132.4 5143.3 5143.9 4960.6 5030.5 5105.6 5110.8 5137.8 4763.1 4768.6 4798.2 4799.9 4815.1 5137.8 5278.0 5287.8 5292.0 5293.5 5006.3 5044.0 5062.6 5102.9 5122.6 5148.9 5151.2 5153.7 5155.8 5157.6 4912.3 4919.6 5087.3 5101.6 5144.1 4897.6 4903.5 4924.6 4970.6 4977.9 4187.3 4195.7 4200.8 4228.1 4239.4 3667.5 3675.5 3675.6 3738.0 3738.3 4447.9 4461.4 4467.0 4517.0 4519.1 5055.6 5158.0 5158.7 5159.2 5205.5 4302.8 4399.1 4444.7 4453.0 4504.5 4556.3 4562.9 4564.9 4570.9 4586.0 4888.8 4890.6 4892.5 4898.3 4951.6 5006.8 5091.8 5093.4 5129.4 5169.6 4888.7 4911.8 4934.1 4966.3 4979.0 5033.8 5034.8 5040.9 5071.8 5125.8 4950.2 4979.1 5041.4 5104.6 5123.2 4909.5 4910.3 4912.5 4915.8 4947.2 4948.9 4956.3 4960.8 4961.0 4996.2 4749.5 4842.8 4904.1 4907.0 4911.8 5008.8 5037.7 5050.1 5079.4 5082.3 4936.4 4943.8 4944.1 4954.9 5003.6 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#1] ext.html Cycles:180 Average:49115.40 Median:35371.56 stddev:93006.30 (262.9%) stddev-sans-first:93195.76 08:42:53 INFO - PROCESS | 14891 | Values: 561.4 596.2 602.1 602.2 606.3 27893.0 30222.5 30323.2 30351.4 41991.4 39658.6 40007.0 40068.2 40102.6 40175.6 7915.9 8103.1 8108.7 8109.7 8111.3 7567.7 7807.3 7822.0 7903.9 7996.6 10118.7 10473.9 10475.2 10789.3 10792.9 10275.9 10389.1 10389.2 10392.0 10392.5 7484.6 7734.2 7737.9 10102.1 10239.5 42771.0 43505.1 43598.1 43653.1 43658.6 3271.2 3292.3 3368.6 3431.2 3893.7 29961.6 30245.7 30745.2 30863.2 31693.4 3498.9 3564.7 3608.2 3612.2 3641.5 287032.0 288111.0 288687.0 289553.0 290356.0 33102.0 33787.7 33862.7 55748.7 56303.7 35514.1 35561.8 35611.6 35621.8 35628.0 13738.9 13848.0 13870.7 13880.2 13884.7 11226.2 11308.2 11317.8 11336.3 11350.6 7672.7 8034.9 8271.0 8319.1 8322.4 3188.1 3231.2 3236.1 3247.8 3284.3 864.7 943.1 943.1 963.1 977.8 28115.4 29564.3 29764.6 29859.4 30047.5 973.3 981.7 1000.9 1105.9 1127.5 14937.9 15398.8 15457.6 15472.3 15495.8 421295.0 424667.0 424957.0 424979.0 425401.0 49501.5 49769.3 49847.8 49973.3 50032.2 1108.9 1174.3 1239.2 1240.8 1249.2 27350.0 28886.6 29652.9 30101.0 30248.5 42802.8 43146.1 43430.8 43536.1 43541.8 327830.0 328908.0 329651.0 330612.0 331759.0 22614.4 24795.0 25371.9 25718.7 25774.2 42195.6 42363.6 42756.0 42892.8 43556.3 36254.3 36429.5 36634.1 36826.3 36922.8 36578.3 36699.3 36711.0 36771.0 37021.6 35938.6 37767.4 38660.4 39097.0 42227.6 32758.0 34753.3 34992.7 35368.8 35374.3 26290.9 26555.3 26614.5 26820.9 26856.0 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#2] jquery.html Cycles:180 Average:22055.26 Median:4228.41 stddev:54444.15 (1287.6%) stddev-sans-first:54572.54 08:42:53 INFO - PROCESS | 14891 | Values: 375.8 376.6 378.8 383.6 392.7 16275.4 17070.0 17730.7 17933.6 17950.0 10304.1 10380.5 10502.0 10518.3 11119.7 4568.9 4735.9 4839.3 5555.6 5563.5 5481.4 5541.2 5554.0 5588.1 5599.3 5246.9 5542.8 5546.0 5589.8 5607.9 5502.1 5516.2 5516.5 5517.9 5520.5 4637.4 4961.9 4970.6 5010.0 5012.6 20129.6 20203.4 20492.6 20758.9 20801.6 1850.7 1893.6 1939.5 1942.6 1987.2 8835.6 8942.9 9165.4 9273.7 13022.6 1753.1 1845.2 1845.6 1849.2 1862.7 73297.3 74026.3 74249.0 75901.6 75920.9 9726.6 9741.2 9801.3 9811.1 9853.0 13172.0 13229.9 13231.1 13236.1 13265.4 6820.4 6883.9 7126.6 7226.3 7250.3 6849.4 6899.3 6912.8 7009.6 7029.7 4198.0 4211.8 4217.2 4239.6 4362.8 1725.6 1730.7 1742.1 1743.8 1756.1 843.6 861.8 885.4 901.8 954.0 16487.7 16998.5 17446.1 17547.6 17985.1 853.5 896.5 908.2 920.9 929.8 9572.3 9684.2 9705.0 9975.5 10101.5 149018.3 304940.0 366455.0 371946.0 376894.0 52335.5 72120.6 76489.0 77709.0 81288.0 954.4 1000.4 1010.4 1013.2 1017.6 16139.4 16244.8 16289.3 16331.0 16587.3 36117.5 37490.3 37529.6 37627.2 37826.4 47231.8 49675.0 50981.2 53165.5 53600.0 7606.6 7790.3 7798.8 7854.2 7923.3 6783.1 10130.9 11386.7 11869.2 11877.7 10196.6 10493.4 10512.4 10683.7 10710.8 6097.6 10511.6 10536.9 10668.4 10805.1 10017.1 10129.8 10446.7 10823.8 10971.8 7727.7 7742.8 7776.3 7797.0 7906.1 9840.9 10355.8 10359.1 10539.3 10575.7 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#3] mootools.html Cycles:180 Average:5243.64 Median:5324.42 stddev:2903.74 (54.5%) stddev-sans-first:2896.81 08:42:53 INFO - PROCESS | 14891 | Values: 1306.8 1492.4 1532.4 1682.1 1855.9 6847.7 7634.8 7767.2 7781.0 8010.7 7848.4 7920.8 7948.0 7993.9 8025.6 1937.6 2176.4 2247.2 2255.1 2270.3 2239.2 2297.5 2304.8 2305.0 2305.5 2243.7 2249.3 2262.2 2307.3 2310.2 1877.2 2156.9 2206.3 2231.9 2240.2 2224.8 2250.6 2256.8 2256.9 2257.3 7958.8 7994.0 7995.2 8015.0 8015.2 4632.0 4755.6 4756.5 4767.8 4770.0 2884.2 3121.5 3122.7 3123.9 3136.1 980.9 998.9 1002.6 1010.3 1036.2 10876.1 10877.8 10881.3 10890.9 10892.3 4253.5 4311.8 4406.6 4430.3 4439.7 9300.9 9313.8 9350.4 9357.6 9360.3 4726.9 4730.7 4732.5 4738.1 4741.8 3732.2 4187.5 4245.4 4338.8 4348.7 3763.4 3788.7 3829.7 3860.2 3912.2 1235.2 1255.4 1256.6 1259.6 1272.3 751.2 845.1 874.9 883.4 924.4 5335.9 5426.5 5461.1 5478.8 5484.2 858.7 905.0 945.1 949.1 955.9 3740.4 3820.6 3846.4 3847.9 3857.3 9574.2 9637.9 9879.8 9900.7 9911.8 9631.2 9734.5 9781.5 9815.0 9823.2 7458.2 7519.5 7537.5 7681.5 7689.1 5256.2 5306.6 5312.9 5353.2 5476.7 9075.2 9139.9 9167.5 9192.4 9200.4 8537.7 8813.8 8832.7 9141.2 9196.0 6034.3 6610.8 6808.8 6917.6 6999.9 7518.7 7528.4 7574.7 7592.0 7598.8 6748.1 6825.7 6942.4 6950.9 6968.9 6800.6 6843.7 6864.9 6885.7 7005.5 6130.3 6372.7 6502.5 6579.7 6584.7 4364.2 4463.6 4487.7 4536.0 4537.8 4550.7 4639.9 4642.6 4656.6 4721.8 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#4] prototype.html Cycles:180 Average:4217.45 Median:4827.93 stddev:1223.86 (25.3%) stddev-sans-first:1191.61 08:42:53 INFO - PROCESS | 14891 | Values: 308.6 313.6 314.9 316.6 319.6 4791.4 4869.6 4877.7 4880.9 4892.8 4779.1 4794.3 4814.5 4826.0 4829.9 3566.3 3647.5 3691.9 3704.7 3709.4 3680.0 3709.0 3837.1 3893.7 3904.3 3796.6 3825.6 3861.3 3872.6 3874.8 3582.2 3797.3 3841.8 3843.5 3860.6 3324.8 3329.1 3330.3 3333.9 3338.6 4572.2 4608.9 4624.7 4641.0 4648.6 4272.0 4285.4 4309.3 4327.2 4348.5 4905.3 4947.3 4990.6 5047.3 5054.9 3595.6 3624.4 3635.1 3641.8 3649.5 5303.9 5310.5 5324.8 5334.6 5351.3 3493.8 3687.8 3691.7 3727.0 3745.4 3757.9 3760.0 3786.6 3797.3 3801.3 4275.3 4284.9 4297.8 4315.3 4325.7 4875.4 5062.1 5064.3 5081.4 5084.1 1288.4 1303.0 1303.2 1306.0 1309.7 816.8 823.4 825.7 846.6 848.5 4454.2 4527.7 4534.6 4535.3 4537.2 5210.2 5213.5 5241.5 5252.5 5268.2 4486.1 4503.9 4534.7 4553.4 4570.1 2642.7 2760.8 2794.4 2794.5 2794.9 4988.7 4989.9 4992.4 5002.4 5003.3 5173.6 5260.0 5309.7 5359.6 5363.9 4954.4 4956.8 4961.3 4971.4 4978.5 5191.8 5202.4 5223.1 5223.6 5245.9 4842.6 5062.2 5083.8 5097.2 5121.2 4988.2 4998.2 5006.8 5013.5 5028.7 3718.3 3721.1 3738.2 3743.1 3757.2 5115.5 5200.5 5308.4 5334.4 5338.7 5045.5 5064.3 5069.6 5072.3 5090.4 5068.9 5076.3 5085.7 5086.8 5086.8 4753.2 4945.2 4985.4 4989.4 4998.5 4904.8 5019.7 5036.0 5044.9 5134.8 4851.2 4939.4 4965.8 4996.2 5019.8 08:42:53 INFO - PROCESS | 14891 | 08:42:53 INFO - PROCESS | 14891 | [#5] yui.html Cycles:180 Average:13475.59 Median:23403.74 stddev:15325.59 (65.5%) stddev-sans-first:15338.46 08:42:53 INFO - PROCESS | 14891 | Values: 679.9 695.5 706.0 755.2 757.1 12082.5 12618.1 12627.5 12629.1 12639.6 12925.9 12977.2 12998.3 13034.3 13035.3 678.3 817.6 848.9 854.3 855.6 856.7 858.3 862.2 862.6 864.8 718.3 917.3 917.5 917.9 918.9 731.0 732.0 732.3 876.7 909.3 666.7 667.2 667.3 667.3 667.5 12257.0 12340.3 12366.9 12404.7 12434.5 11767.4 12108.2 12175.1 12310.8 12417.4 11146.5 11192.5 11529.8 11633.7 11926.5 4172.0 4172.7 4191.9 4203.1 4312.1 46942.8 46986.8 47343.8 47453.5 47507.3 9714.7 10047.5 10107.2 10249.3 10547.4 17169.1 17346.7 17364.5 17404.9 17407.3 6702.3 6721.2 6787.0 6915.3 6983.8 3856.6 3866.0 3912.0 3963.8 3977.3 2844.5 2911.4 2922.6 2923.9 2924.7 528.9 529.9 534.8 536.6 547.4 507.4 518.5 581.0 598.6 602.8 8478.3 8534.3 8570.7 8706.3 8823.7 387.1 516.8 599.0 627.3 627.5 3862.4 3864.3 3945.5 4107.8 4119.4 50994.0 52345.2 52428.5 56687.0 57534.8 49150.3 49864.8 50324.0 50902.5 52416.5 45620.3 46507.8 47019.5 47269.0 47543.0 8668.4 8723.3 8989.2 9063.4 9196.2 31327.8 31946.5 32663.5 32972.0 33182.0 39175.6 39451.8 42015.2 42100.6 42495.4 11004.8 11078.2 11101.6 11159.2 11211.4 11509.5 12086.9 12238.9 12642.9 13024.9 10759.8 11455.5 11659.3 12177.1 12309.3 11401.8 11506.9 11696.2 11768.2 12279.4 11594.7 11638.4 11794.2 12185.8 12283.9 9545.5 9549.2 9767.4 9925.8 10255.0 9437.7 9828.0 9847.0 9928.0 10023.3 08:42:53 INFO - PROCESS | 14891 | -------- Summary: end -------- 08:42:53 INFO - PROCESS | 14891 | 08:42:54 INFO - TEST-INFO | 14891: exit 0 08:42:54 INFO - TEST-OK | dromaeo_css | took 1119388ms 08:42:54 INFO - TEST-START | kraken 08:42:54 INFO - operating with platform_type : linux_ 08:42:54 INFO - Initialising browser for kraken test... 08:42:54 INFO - TEST-INFO | started process 15067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MT3mc/profile http://localhost:54745/getInfo.html) 08:42:58 INFO - PROCESS | 15067 | __metrics Screen width/height:1600/1200 08:42:58 INFO - PROCESS | 15067 | colorDepth:24 08:42:58 INFO - PROCESS | 15067 | Browser inner width/height: 1024/697 08:42:58 INFO - PROCESS | 15067 | __metrics 08:42:59 ERROR - PROCESS | 15067 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:00 INFO - TEST-INFO | 15067: exit 0 08:43:00 INFO - Browser initialized. 08:43:00 INFO - Running cycle 1/1 for kraken test... 08:43:00 INFO - TEST-INFO | started process 15148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MT3mc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:12 INFO - PROCESS | 15148 | RSS: Main: 155041792 08:43:12 INFO - PROCESS | 15148 | 08:43:15 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54745/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:16 INFO - PROCESS | 15148 | RSS: Main: 209756160 08:43:16 INFO - PROCESS | 15148 | 08:43:19 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54745/tests/kraken/driver.html?testName=audio-dft) 08:43:19 INFO - PROCESS | 15148 | RSS: Main: 198729728 08:43:19 INFO - PROCESS | 15148 | 08:43:23 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54745/tests/kraken/driver.html?testName=audio-fft) 08:43:23 INFO - PROCESS | 15148 | RSS: Main: 267034624 08:43:23 INFO - PROCESS | 15148 | 08:43:26 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54745/tests/kraken/driver.html?testName=audio-oscillator) 08:43:26 INFO - PROCESS | 15148 | RSS: Main: 176422912 08:43:26 INFO - PROCESS | 15148 | 08:43:29 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:29 INFO - PROCESS | 15148 | RSS: Main: 179953664 08:43:29 INFO - PROCESS | 15148 | 08:43:32 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54745/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:33 INFO - PROCESS | 15148 | RSS: Main: 216403968 08:43:33 INFO - PROCESS | 15148 | 08:43:37 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54745/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:37 INFO - PROCESS | 15148 | RSS: Main: 215482368 08:43:37 INFO - PROCESS | 15148 | 08:43:40 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54745/tests/kraken/driver.html?testName=json-parse-financial) 08:43:41 INFO - PROCESS | 15148 | RSS: Main: 215834624 08:43:41 INFO - PROCESS | 15148 | 08:43:43 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:43 INFO - PROCESS | 15148 | RSS: Main: 208183296 08:43:43 INFO - PROCESS | 15148 | 08:43:45 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:46 INFO - PROCESS | 15148 | RSS: Main: 212586496 08:43:46 INFO - PROCESS | 15148 | 08:43:48 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:49 INFO - PROCESS | 15148 | RSS: Main: 216592384 08:43:49 INFO - PROCESS | 15148 | 08:43:52 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:52 INFO - PROCESS | 15148 | RSS: Main: 219602944 08:43:52 INFO - PROCESS | 15148 | 08:43:55 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:56 INFO - PROCESS | 15148 | RSS: Main: 218882048 08:43:56 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | Cycle 1(1): loaded http://localhost:54745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54745/tests/kraken/driver.html?testName=ai-astar) 08:43:58 INFO - PROCESS | 15148 | RSS: Main: 264671232 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | __start_tp_report 08:43:58 INFO - PROCESS | 15148 | _x_x_mozilla_page_load 08:43:58 INFO - PROCESS | 15148 | _x_x_mozilla_page_load_details 08:43:58 INFO - PROCESS | 15148 | |i|pagename|runs| 08:43:58 INFO - PROCESS | 15148 | |0;ai-astar;113;107;114;116;114;113;112;112;113;112 08:43:58 INFO - PROCESS | 15148 | |1;audio-beat-detection;160;137;153;222;130;160;163;138;181;133 08:43:58 INFO - PROCESS | 15148 | |2;audio-dft;161;162;162;161;166;164;161;164;162;160 08:43:58 INFO - PROCESS | 15148 | |3;audio-fft;75;76;77;157;75;74;75;74;127;77 08:43:58 INFO - PROCESS | 15148 | |4;audio-oscillator;96;93;148;99;95;94;132;93;93;117 08:43:58 INFO - PROCESS | 15148 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;116;117;117 08:43:58 INFO - PROCESS | 15148 | |6;imaging-darkroom;145;146;146;146;145;146;146;146;145;147 08:43:58 INFO - PROCESS | 15148 | |7;imaging-desaturate;95;94;95;95;94;94;95;94;95;95 08:43:58 INFO - PROCESS | 15148 | |8;json-parse-financial;63;65;64;64;64;65;64;65;63;63 08:43:58 INFO - PROCESS | 15148 | |9;json-stringify-tinderbox;64;65;65;65;64;65;64;65;66;65 08:43:58 INFO - PROCESS | 15148 | |10;stanford-crypto-aes;88;82;82;82;81;81;83;82;145;83 08:43:58 INFO - PROCESS | 15148 | |11;stanford-crypto-ccm;127;134;136;129;128;125;126;128;147;132 08:43:58 INFO - PROCESS | 15148 | |12;stanford-crypto-pbkdf2;170;166;167;167;166;171;168;168;166;171 08:43:58 INFO - PROCESS | 15148 | |13;stanford-crypto-sha256-iterative;67;67;66;69;67;67;66;65;64;64 08:43:58 INFO - PROCESS | 15148 | __end_tp_report 08:43:58 INFO - PROCESS | 15148 | __start_cc_report 08:43:58 INFO - PROCESS | 15148 | _x_x_mozilla_cycle_collect,2122 08:43:58 INFO - PROCESS | 15148 | __end_cc_report 08:43:58 INFO - PROCESS | 15148 | __startTimestamp1463672638481__endTimestamp 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | ------- Summary: start ------- 08:43:58 INFO - PROCESS | 15148 | Number of tests: 14 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:2.46 08:43:58 INFO - PROCESS | 15148 | Values: 113.0 107.0 114.0 116.0 114.0 113.0 112.0 112.0 113.0 112.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:160.00 stddev:27.75 (17.3%) stddev-sans-first:29.42 08:43:58 INFO - PROCESS | 15148 | Values: 160.0 137.0 153.0 222.0 130.0 160.0 163.0 138.0 181.0 133.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.88 08:43:58 INFO - PROCESS | 15148 | Values: 161.0 162.0 162.0 161.0 166.0 164.0 161.0 164.0 162.0 160.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.00 stddev:28.99 (38.6%) stddev-sans-first:30.32 08:43:58 INFO - PROCESS | 15148 | Values: 75.0 76.0 77.0 157.0 75.0 74.0 75.0 74.0 127.0 77.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.50 stddev:19.67 (21.0%) stddev-sans-first:20.53 08:43:58 INFO - PROCESS | 15148 | Values: 96.0 93.0 148.0 99.0 95.0 94.0 132.0 93.0 93.0 117.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:43:58 INFO - PROCESS | 15148 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:43:58 INFO - PROCESS | 15148 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 147.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:43:58 INFO - PROCESS | 15148 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 08:43:58 INFO - PROCESS | 15148 | Values: 63.0 65.0 64.0 64.0 64.0 65.0 64.0 65.0 63.0 63.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 08:43:58 INFO - PROCESS | 15148 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 66.0 65.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:82.00 stddev:19.81 (24.2%) stddev-sans-first:21.01 08:43:58 INFO - PROCESS | 15148 | Values: 88.0 82.0 82.0 82.0 81.0 81.0 83.0 82.0 145.0 83.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.50 stddev:6.58 (5.0%) stddev-sans-first:6.80 08:43:58 INFO - PROCESS | 15148 | Values: 127.0 134.0 136.0 129.0 128.0 125.0 126.0 128.0 147.0 132.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:2.00 (1.2%) stddev-sans-first:1.99 08:43:58 INFO - PROCESS | 15148 | Values: 170.0 166.0 167.0 167.0 166.0 171.0 168.0 168.0 166.0 171.0 08:43:58 INFO - PROCESS | 15148 | 08:43:58 INFO - PROCESS | 15148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 08:43:58 INFO - PROCESS | 15148 | Values: 67.0 67.0 66.0 69.0 67.0 67.0 66.0 65.0 64.0 64.0 08:43:58 INFO - PROCESS | 15148 | -------- Summary: end -------- 08:43:58 INFO - PROCESS | 15148 | 08:43:59 INFO - TEST-INFO | 15148: exit 0 08:43:59 INFO - TEST-OK | kraken | took 64874ms 08:43:59 INFO - SUITE-END | took 1184s 08:43:59 INFO - Completed test suite (00:19:44) 08:43:59 INFO - javascript benchmark 08:43:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.532306846302, 2675.5317819381603, 2707.404371038372, 2710.552758794798, 2712.050782226221, 4618.284165954283, 4666.626669866411, 4722.693024953375, 4785.282207668852, 4824.107540105078, 4712.481627021033, 4718.150732868083, 4731.361266229058, 4745.976270118653, 4812.879678008052, 4269.8292068317305, 4288.549702281262, 4338.110687309094, 4426.800793964279, 4436.068425630621, 4424.513303536608, 4435.0, 4518.751468669222, 4547.067851090518, 4548.454185497745, 4280.336547835091, 4327.567243275647, 4381.780910954471, 4425.424694789689, 4425.911481770347, 4365.869023929287, 4369.016971181491, 4381.408509851161, 4381.671374646914, 4385.101054283896, 4306.332518459643, 4315.834724624366, 4353.172897149531, 4374.34384842273, 4404.097160082176, 4651.255799072166, 4685.390899183119, 4722.574968252839, 4730.810767569293, 4735.763211839394, 5089.8727531812, 5090.211017292326, 5132.358455193101, 5143.305653736735, 5143.922841157386, 4960.553550180501, 5030.496950304941, 5105.591552675777, 5110.821121260738, 5137.7944882204665, 4763.118823017753, 4768.5946694531, 4798.184308667535, 4799.880002999953, 4815.085133824562, 5137.768800403991, 5277.973610131925, 5287.814926477555, 5291.973540132351, 5293.497117773805, 5006.324146240284, 5043.9747801260755, 5062.569681577033, 5102.872428189325, 5122.590192784568, 5148.897022059537, 5151.201563757623, 5153.6907785532985, 5155.845324640267, 5157.613179011589, 4912.312276281324, 4919.581835543947, 5087.31321271631, 5101.591872650179, 5144.074066667961, 4897.608191344684, 4903.509649035068, 4924.630652701062, 4970.577500912391, 4977.90044199114, 4187.309093999456, 4195.727277726938, 4200.789960501963, 4228.090960443458, 4239.40648309237, 3667.504886840296, 3675.503806986076, 3675.5773086094905, 3737.981310093432, 3738.3084129436143, 4447.888802779892, 4461.420015398043, 4467.039586488921, 4516.977415112903, 4519.050999290186, 5055.620828437882, 5157.9684063187515, 5158.74206289684, 5159.226116082617, 5205.505476979681, 4302.849400270976, 4399.076193999232, 4444.711093778894, 4452.977735111369, 4504.549545045469, 4556.316552517149, 4562.8631141065825, 4564.885877853014, 4570.908581828345, 4585.977070114628, 4888.828890988798, 4890.608751299958, 4892.461829198856, 4898.314236006961, 4951.603871690184, 5006.774695138801, 5091.847244582668, 5093.414257360451, 5129.435762066095, 5169.638125331191, 4888.682235654671, 4911.8280860169725, 4934.136526107845, 4966.279889415942, 4979.0, 5033.823816166563, 5034.84895453137, 5040.873978150576, 5071.797128114834, 5125.7693403796175, 4950.1584730596605, 4979.053979743837, 5041.42023667283, 5104.642675012862, 5123.180291153398, 4909.4845041270155, 4910.263460480956, 4912.533309335608, 4915.778789954389, 4947.233178857283, 4948.901021979612, 4956.330895329229, 4960.826371076995, 4960.975195124001, 4996.15065438869, 4749.453812811433, 4842.757862106951, 4904.141775189256, 4906.975465122651, 4911.754412279443, 5008.774605142705, 5037.748112594282, 5050.090983622983, 5079.415867175322, 5082.33929589151, 4936.407631084293, 4943.777530011086, 4944.1100601892, 4954.900901981868, 5003.649744517848], "value": 4682.051195428377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.4245398466571, 596.1891827115124, 602.0547740048127, 602.196068248888, 606.3481757111107, 27893.0, 30222.54666180009, 30323.241918952037, 30351.392972140544, 41991.370129448085, 39658.60341396585, 40007.0, 40068.19863602734, 40102.59897401025, 40175.59824401755, 7915.920840791576, 8103.068147163063, 8108.675652973874, 8109.675612975474, 8111.310538604226, 7567.697292108309, 7807.297343239107, 7822.022247219098, 7903.920960790376, 7996.640151193181, 10118.747031324203, 10473.947630261839, 10475.161987041056, 10789.298695584763, 10792.892071079306, 10275.948620256926, 10389.064984151388, 10389.220808439322, 10392.0, 10392.532336044858, 7484.625768711597, 7734.2265773422205, 7737.883931740972, 10102.09081182697, 10239.488025598765, 42771.0, 43505.12989740219, 43598.12803743908, 43653.12693746107, 43658.56341436609, 3271.2312606537444, 3292.308615190813, 3368.562086928708, 3431.2108215110416, 3893.6885049196, 29961.550576741367, 30245.69754302473, 30745.231369215948, 30863.228419289473, 31693.36613267745, 3498.860045598173, 3564.697000754939, 3608.2422691234874, 3612.151144481045, 3641.4901913732097, 287032.0, 288110.9999999979, 288687.0, 289553.0, 290356.0, 33102.0, 33787.66212337845, 33862.66137338644, 55748.72125639346, 56303.71848140733, 35514.11214719652, 35561.8221908894, 35611.643883560835, 35621.8218908909, 35628.0, 13738.862611373957, 13848.030637855254, 13870.722585548232, 13880.167189968432, 13884.652883677787, 11226.158038147172, 11308.151888608387, 11317.773644527064, 11336.263142895685, 11350.602728904449, 7672.65473053714, 8034.919650803534, 8271.048829384577, 8319.126491718403, 8322.375821813388, 3188.091393952712, 3231.1922019495128, 3236.093893709765, 3247.8376081195847, 3284.3267130238723, 864.7362554420836, 943.0710749911332, 943.127606963556, 963.0946909904667, 977.8239916814899, 28115.43769124647, 29564.260893477403, 29764.55353169704, 29859.40281194364, 30047.549286760717, 973.2749101919115, 981.7300242433245, 1000.8740167311774, 1105.90599799018, 1127.5151684775626, 14937.925310373379, 15398.769018464733, 15457.613559661098, 15472.303746331441, 15495.767563486557, 421295.0, 424667.0, 424957.0, 424979.0, 425401.0, 49501.50498495041, 49769.25346119811, 49847.75076124596, 49973.25040124401, 50032.24951625729, 1108.894655007773, 1174.2719513901436, 1239.20690757915, 1240.789065858788, 1249.2067537113817, 27350.0, 28886.566701499072, 29652.851735741184, 30101.0, 30248.5462718055, 42802.78598606987, 43146.13707725765, 43430.78284608557, 43536.129277414904, 43541.78229108834, 327830.0, 328908.0, 329651.0, 330612.0, 331759.0, 22614.434639134153, 24795.0, 25371.87314063418, 25718.742812571636, 25774.226773196835, 42195.57804422039, 42363.57636423596, 42756.0, 42892.78553607212, 43556.34665480084, 36254.274914502086, 36429.45355819612, 36634.084147896516, 36826.26347472982, 36922.815385923976, 36578.26843463169, 36699.26601468009, 36711.0, 36771.0, 37021.62978370182, 35938.64061359457, 37767.43348849715, 38660.420093698056, 39097.0, 42227.57772422236, 32758.00035979079, 34753.30493390169, 34992.65007349996, 35368.823155884056, 35374.29251415009, 26290.868545657147, 26555.33611659724, 26614.467710646066, 26820.8658956704, 26856.0], "value": 17236.31142923871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.8045816175589, 376.58387481832557, 378.8105947026487, 383.61255132316353, 392.6525025352562, 16275.430359937389, 17070.0, 17730.734038989427, 17933.551661208476, 17950.0127492988, 10304.124149447287, 10380.532876020578, 10502.0, 10518.31630943988, 11119.666410007712, 4568.908621827562, 4735.92896106557, 4839.346688197101, 5555.611107222496, 5563.471470210324, 5481.369642491105, 5541.196526503654, 5553.972230138844, 5588.077967135418, 5599.272094627693, 5246.947530524703, 5542.806001789938, 5546.0, 5589.80435684749, 5607.943920560783, 5502.119660854264, 5516.200150978106, 5516.503514683657, 5517.917231241535, 5520.530754885819, 4637.373954516131, 4961.851144465636, 4970.577500912426, 5010.048090862724, 5012.649114561982, 20129.597408051904, 20203.39389818308, 20492.590148196952, 20758.896205519028, 20801.58396832055, 1850.7223916412645, 1893.6307420053095, 1939.4957311099074, 1942.5920556683113, 1987.1653905359783, 8835.55822208887, 8942.86585701215, 9165.404248723811, 9273.675421360287, 13022.609321720363, 1753.114677088075, 1845.2250054976942, 1845.5847434327304, 1849.2048419179748, 1862.7112797516406, 73297.2670273301, 74026.25973740302, 74249.0, 75901.62049189719, 75920.86118708168, 9726.562304696306, 9741.220702343795, 9801.277396600559, 9811.116999470081, 9853.0, 13172.0, 13229.933850330686, 13231.139975901535, 13236.13965092266, 13265.403056862464, 6820.419279878104, 6883.931160688329, 7126.572405655677, 7226.277372262732, 7250.274972502813, 6849.417799487, 6899.344562266577, 6912.792616221522, 7009.579425234502, 7029.683664235122, 4197.97901010493, 4211.768352740629, 4217.240896638573, 4239.576042395735, 4362.847300344472, 1725.55998220453, 1730.7490413889916, 1742.0766993493469, 1743.808181100078, 1756.1482680899753, 843.5529169540154, 861.8362511122866, 885.3758100539104, 901.783571942729, 953.952302384878, 16487.670246595, 16998.490045298662, 17446.127693615268, 17547.64904701899, 17985.10074496296, 853.5049671190694, 896.5427631907644, 908.2143945487238, 920.9493477858782, 929.846575315079, 9572.32993690435, 9684.225261979025, 9705.0, 9975.501224938724, 10101.494925253708, 149018.25490872693, 304940.0, 366455.01269923354, 371946.0, 376894.0, 52335.47664523382, 72120.63939680268, 76489.0, 77709.0, 81288.0, 954.3796532253951, 1000.4097582426404, 1010.3735683876043, 1013.1995723378449, 1017.6489111256604, 16139.354425823305, 16244.837551624805, 16289.348426062825, 16331.0, 16587.253573588976, 36117.45823812697, 37490.25019499649, 37529.62470375261, 37627.24745505129, 37826.43260351152, 47231.763841180575, 49675.0, 50981.23528147155, 53165.4683453176, 53600.0, 7606.619669016416, 7790.337821285254, 7798.766037018899, 7854.2145785421, 7923.286904178421, 6783.05037294789, 10130.949345253226, 11386.715332116763, 11869.169158158846, 11877.703057423634, 10196.643117491149, 10493.422861742678, 10512.42181680015, 10683.732906677395, 10710.785784284426, 6097.603655762361, 10511.632092876713, 10536.947315263375, 10668.413237271714, 10805.081568066802, 10017.14854237398, 10129.848052279369, 10446.738831529272, 10823.783524329312, 10971.83542246851, 7727.729529466442, 7742.7677169685, 7776.339011183886, 7797.0, 7906.051273847175, 9840.901590983998, 10355.844662330222, 10359.119474844723, 10539.314944528582, 10575.682729518127], "value": 8091.89608669283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.7713150198713, 1492.3582859370474, 1532.4176812811133, 1682.1421075251626, 1855.8979256140915, 6847.691853866576, 7634.770956871296, 7767.184445633205, 7780.961095194531, 8010.719624813133, 7848.4113691473085, 7920.762377128681, 7948.0, 7993.880091798627, 8025.558594277312, 1937.5543624966267, 2176.3906106290265, 2247.191011235958, 2255.086689890589, 2270.318904328703, 2239.193890199527, 2297.4945511987335, 2304.83866129371, 2304.976950230493, 2305.5158416732424, 2243.6971008913833, 2249.347689170139, 2262.1856131792542, 2307.2962746362355, 2310.1683393978155, 1877.2115711401245, 2156.8813715245656, 2206.2719302630176, 2231.9218827340965, 2240.215924426446, 2224.7663995280423, 2250.5723912456583, 2256.808171305441, 2256.9435764105865, 2257.2663884237522, 7958.761237162895, 7993.960030199812, 7995.160508146619, 8014.959925200395, 8015.198480151997, 4631.976840115778, 4755.595774359183, 4756.453007904101, 4767.809287628491, 4770.022145460172, 2884.2356775454523, 3121.453745594512, 3122.656507784142, 3123.8757644801526, 3136.1218858719594, 980.8871979722352, 998.9450580218086, 1002.6039714312878, 1010.3331801011298, 1036.233257203269, 10876.075533579655, 10877.83683244752, 10881.347119172875, 10890.945545272301, 10892.346459212473, 4253.532111467736, 4311.827526898952, 4406.603405693503, 4430.335449682573, 4439.66702497314, 9300.906990930003, 9313.767155821159, 9350.392224505522, 9357.625694972261, 9360.251179905592, 4726.881827954328, 4730.692504987165, 4732.526747325309, 4738.147133515931, 4741.83403580873, 3732.1602639405914, 4187.476565429321, 4245.448091748053, 4338.848140315074, 4348.695591308641, 3763.397856342972, 3788.659020688096, 3829.7127715421457, 3860.208657225262, 3912.197999410114, 1235.209465941798, 1255.3911352993791, 1256.616731896762, 1259.6284096191646, 1272.2684456437585, 751.1812124784012, 845.146402133837, 874.8556488179506, 883.3992884838243, 924.426855349674, 5335.919961200585, 5426.538744206708, 5461.0716178249795, 5478.753456094485, 5484.232207490954, 858.6822875536092, 904.9502277374676, 945.1021529546958, 949.0746522140857, 955.8518429643416, 3740.4202348636004, 3820.6370394812448, 3846.3653497173214, 3847.8653247136217, 3857.3056849767313, 9574.234061275081, 9637.855432168522, 9879.802403952024, 9900.65347712841, 9911.801763964824, 9631.229501639851, 9734.464604446823, 9781.462019588991, 9815.0, 9823.214142868554, 7458.172747676854, 7519.548827070394, 7537.472376933562, 7681.500702454323, 7689.115751688628, 5256.237845512455, 5306.575473962151, 5312.920306195488, 5353.197020446964, 5476.698781567052, 9075.183233509017, 9139.908600913906, 9167.495787731472, 9192.356535042483, 9200.355975081948, 8537.658493660432, 8813.823723525365, 8832.735017949472, 9141.177294043568, 9195.954020229856, 6034.306054803754, 6610.768623098168, 6808.829779255559, 6917.619530925847, 6999.930000699927, 7518.661660225193, 7528.397728181622, 7574.734884279023, 7591.962040189764, 7598.772036838904, 6748.0552722617895, 6825.658717064028, 6942.444604431533, 6950.895736563854, 6968.895466568107, 6800.557963732342, 6843.726250949906, 6864.931350686629, 6885.724571017103, 7005.54463959841, 6130.325664177026, 6372.713227904663, 6502.479801615765, 6579.736810527525, 6584.703688333941, 4364.236258654786, 4463.642908567372, 4487.730736155841, 4536.024754677628, 4537.841175558971, 4550.749708765918, 4639.884002899955, 4642.558956899089, 4656.604188643868, 4721.811127554996], "value": 4252.08224271816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.6465996434083, 313.64244760972497, 314.8960842921836, 316.6247996124592, 319.6324227138792, 4791.353167322415, 4869.610431165507, 4877.731724755137, 4880.902381952359, 4892.804287828482, 4779.139754844126, 4794.280857871321, 4814.494478079804, 4826.0, 4829.855104346875, 3566.3402270579895, 3647.4528820676846, 3691.870784522542, 3704.74066815323, 3709.4435834624887, 3679.981600091996, 3708.9814550927344, 3837.079101015764, 3893.6885049196, 3904.3362628353248, 3796.6013568575318, 3825.5600605930395, 3861.343571592836, 3872.593377695344, 3874.767513949158, 3582.17609949713, 3797.316483033053, 3841.750286231386, 3843.538775346962, 3860.6332398422105, 3324.8337583120747, 3329.1344250494803, 3330.333933213343, 3333.916652083693, 3338.562849120156, 4572.199865023607, 4608.861734147981, 4624.676272660915, 4640.976795116003, 4648.628109751246, 4271.9786401067795, 4285.35719642053, 4309.288967320388, 4327.221100201994, 4348.4999225089205, 4905.2642103684375, 4947.332110165117, 4990.625703072248, 5047.293378926953, 5054.9241761373605, 3595.63365920951, 3624.4200927851416, 3635.1275693833554, 3641.817909104561, 3649.489071529988, 5303.946960530384, 5310.459966609678, 5324.787008519655, 5334.573234141299, 5351.277577527023, 3493.7554371194283, 3687.797171155612, 3691.686206672463, 3727.0, 3745.438184272381, 3757.9436308455397, 3759.9696164071643, 3786.6213378661914, 3797.335466293443, 3801.2777572261184, 4275.273203555403, 4284.871453856389, 4297.841086801199, 4315.309550471972, 4325.740455572675, 4875.390576177978, 5062.114130027304, 5064.34163558735, 5081.441041485434, 5084.13569693153, 1288.4008935844877, 1303.0162227518163, 1303.1594621469098, 1305.9934700326628, 1309.6987692830703, 816.8243827577099, 823.3660081737029, 825.6903661127077, 846.5936350551647, 848.520585868982, 4454.175977444183, 4527.728336299832, 4534.637229021736, 4535.342375355555, 4537.228671125917, 5210.166373380241, 5213.504717051874, 5241.528262456397, 5252.474752524793, 5268.1834315681135, 4486.1252055849445, 4503.909921801611, 4534.730275522859, 4553.430821147356, 4570.108828778356, 2642.6960899496803, 2760.7653349465118, 2794.4271424357958, 2794.5249307617755, 2794.9301267468477, 4988.730127791846, 4989.875253118701, 4992.377477319886, 5002.449730529639, 5003.324551185616, 5173.551405606437, 5259.973700131475, 5309.681419114865, 5359.598030147755, 5363.919541206885, 4954.405471343462, 4956.801727930914, 4961.255811628284, 4971.4282857471135, 4978.452370239271, 5191.792328306826, 5202.375714914235, 5223.0935708466895, 5223.634345595772, 5245.947540524546, 4842.58837998774, 5062.241078612239, 5083.847484575469, 5097.1844504879045, 5121.231815227746, 4988.176950803077, 4998.200287954055, 5006.849794506171, 5013.523715247045, 5028.723420211777, 3718.2935242303874, 3721.1255354991013, 3738.158914244273, 3743.139078012127, 3757.1922036761134, 5115.5396014358885, 5200.5059519345605, 5308.389535203347, 5334.359876814807, 5338.733063346895, 5045.470225626256, 5064.34163558735, 5069.6197785167, 5072.315237443046, 5090.371081253963, 5068.898622027465, 5076.324812811689, 5085.669431486942, 5086.787247547329, 5086.821961231339, 4753.239481682914, 4945.23348880924, 4985.4266759323145, 4989.401271847401, 4998.4501704813165, 4904.828331008541, 5019.7490125494305, 5035.974820125876, 5044.9243261350375, 5134.84465995163, 4851.175300198904, 4939.431965324034, 4965.801367945386, 4996.225585034325, 5019.791291831582], "value": 3830.117237867215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.9354061364172, 695.4505940307157, 706.0, 755.2032605601096, 757.0839284465796, 12082.456289466973, 12618.116731828775, 12627.494900204003, 12629.11596188266, 12639.55761548346, 12925.935370323159, 12977.156484828503, 12998.285094319808, 13034.283114428703, 13035.34823258838, 678.2640834694363, 817.5912043978011, 848.9405741598091, 854.3122786157141, 855.6064210463195, 856.6787454704486, 858.3305022082754, 862.2110768646712, 862.5945805471418, 864.8010957479784, 718.3355396258466, 917.3440989692368, 917.4541148016953, 917.9082091790801, 918.912703293186, 730.9926900730978, 732.0300601702738, 732.2567593892204, 876.662484943295, 909.3180114913814, 666.7299743603849, 667.206024830455, 667.3393340592778, 667.346000919102, 667.5227212543007, 12257.0, 12340.259584424963, 12366.876331236663, 12404.705129551063, 12434.502619895193, 11767.352795596238, 12108.15242932995, 12175.147739658227, 12310.790168032136, 12417.44121514534, 11146.498407571678, 11192.496337664825, 11529.769404611945, 11633.650990470214, 11926.463309151022, 4172.002930169268, 4172.728772629769, 4191.874243772691, 4203.054312779631, 4312.116016216668, 46942.76528617335, 46986.76506617479, 47343.76328118372, 47453.52546474525, 47507.28739068917, 9714.659986900424, 10047.547860346302, 10107.191424686007, 10249.282550221562, 10547.419891905865, 17169.141542922804, 17346.739798903025, 17364.479065628053, 17404.912975435043, 17407.3037078518, 6702.262751097375, 6721.22705888829, 6786.966065169642, 6915.273896240923, 6983.790486285419, 3856.633619806114, 3866.0, 3912.0415498203124, 3963.801809909493, 3977.2642061218767, 2844.5306524423654, 2911.4177164567172, 2922.605448264457, 2923.9122826315242, 2924.692907244751, 528.8598521391834, 529.8595872093898, 534.7914313417771, 536.5761048771427, 547.4087984976217, 507.4443484384593, 518.5488624896365, 580.9832792612928, 598.643806934873, 602.8388228201945, 8478.279346255636, 8534.27458666008, 8570.700025499202, 8706.347023973227, 8823.69117080899, 387.1482737976407, 516.8061777294462, 598.9820305390846, 627.2567008095422, 627.4627163449476, 3862.4013277941403, 3864.265789499986, 3945.4834858734125, 4107.753534787922, 4119.443875076886, 50994.0, 52345.21482177771, 52428.47571524312, 56687.0, 57534.84930301454, 49150.26274605884, 49864.75067624639, 50324.0, 50902.49097508978, 52416.47583524116, 45620.31569526393, 46507.767461162475, 47019.52980470152, 47269.0, 47543.04913901772, 8668.39321247532, 8723.345749068718, 8989.235914947303, 9063.365564410427, 9196.218321442751, 31327.84336078305, 31946.52080218845, 32663.510047349784, 32972.0, 33182.0, 39175.608243917195, 39451.80274098611, 42015.159696806506, 42100.57899420967, 42495.3625695621, 11004.834927475935, 11078.224524283223, 11101.614862129574, 11159.21885468042, 11211.439428028729, 11509.53961841517, 12086.879131208576, 12238.877611223774, 12642.936785316382, 13024.869751302745, 10759.838602420814, 11455.535679584085, 11659.300441973508, 12177.147599667938, 12309.295746687038, 11401.834880574117, 11506.94246528762, 11696.239744416585, 11768.235064720766, 12279.44742486608, 11594.71013224676, 11638.41807909618, 11794.233374830608, 12185.817212741638, 12283.938580307042, 9545.474998875128, 9549.188318992963, 9767.413955162712, 9925.845397377818, 10255.0, 9437.732945631687, 9828.0, 9847.0, 9928.0, 10023.348482348916], "value": 6198.66393644282, "unit": "score"}], "name": "dromaeo_css", "value": 6355.9670673733235, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 116.0, 114.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 137.0, 153.0, 222.0, 130.0, 160.0, 163.0, 138.0, 181.0, 133.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 166.0, 164.0, 161.0, 164.0, 162.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 157.0, 75.0, 74.0, 75.0, 74.0, 127.0, 77.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 148.0, 99.0, 95.0, 94.0, 132.0, 93.0, 93.0, 117.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 63.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 82.0, 81.0, 81.0, 83.0, 82.0, 145.0, 83.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 136.0, 129.0, 128.0, 125.0, 126.0, 128.0, 147.0, 132.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 167.0, 167.0, 166.0, 171.0, 168.0, 168.0, 166.0, 171.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 69.0, 67.0, 67.0, 66.0, 65.0, 64.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1567.5000000000002, "alertThreshold": 2.0}]} 08:43:59 INFO - Return code: 0 08:43:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:43:59 ERROR - # TBPL SUCCESS # 08:43:59 INFO - Running post-action listener: _resource_record_post_action 08:43:59 INFO - ##### 08:43:59 INFO - ##### Finished run-tests step (success) 08:43:59 INFO - ##### 08:43:59 INFO - Running post-run listener: _resource_record_post_run 08:43:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389447680; Read time: 12; Write time: 205576 08:43:59 INFO - TinderboxPrint: CPU usage
13.1% 08:43:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:43:59 INFO - TinderboxPrint: I/O write bytes / time
389,447,680 / 205,576 08:43:59 INFO - TinderboxPrint: CPU idle
8,330.7 (86.9%) 08:43:59 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 08:43:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94871552; Read time: 0; Write time: 56904 08:43:59 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294576128; Read time: 12; Write time: 148672 08:44:00 INFO - Running post-run listener: _upload_blobber_files 08:44:00 INFO - Blob upload gear active. 08:44:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:00 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:44:00 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:44:00 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:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:07 INFO - (blobuploader) - INFO - Done attempting. 08:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:08 INFO - (blobuploader) - INFO - Done attempting. 08:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:09 INFO - (blobuploader) - INFO - Done attempting. 08:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:09 INFO - Return code: 0 08:44:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b2875784d537af780b9d807e56b7f28c595f1bf1f587419985d56e59ad3671aeb8f21359d5d49c16a8672752f6cc0d4d31bd427e119381b99041d98a028b2c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc3eb6a92911db7170839b2d4612955527e1b4c2899c7bcd3036246e8f81ade577cca0e06e6060d9d4de39b6ce8a8e9c9a406249f7a2025436fb8ef4bfa06a10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e98c35e467af24169dcb5be7bc830235d714bbe699655c8a1b0e09154987b07b755a8ac5c41bb72fc2514c1c363be5d9bb05747da7f6202469ea9e1dd044f77c"} 08:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:09 INFO - Contents: 08:44:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b2875784d537af780b9d807e56b7f28c595f1bf1f587419985d56e59ad3671aeb8f21359d5d49c16a8672752f6cc0d4d31bd427e119381b99041d98a028b2c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc3eb6a92911db7170839b2d4612955527e1b4c2899c7bcd3036246e8f81ade577cca0e06e6060d9d4de39b6ce8a8e9c9a406249f7a2025436fb8ef4bfa06a10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e98c35e467af24169dcb5be7bc830235d714bbe699655c8a1b0e09154987b07b755a8ac5c41bb72fc2514c1c363be5d9bb05747da7f6202469ea9e1dd044f77c"} 08:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:09 INFO - Copying logs to upload dir... 08:44:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.637239 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-19 08:44:09.247478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 08:44:09.251111) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 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/7b2875784d537af780b9d807e56b7f28c595f1bf1f587419985d56e59ad3671aeb8f21359d5d49c16a8672752f6cc0d4d31bd427e119381b99041d98a028b2c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc3eb6a92911db7170839b2d4612955527e1b4c2899c7bcd3036246e8f81ade577cca0e06e6060d9d4de39b6ce8a8e9c9a406249f7a2025436fb8ef4bfa06a10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e98c35e467af24169dcb5be7bc830235d714bbe699655c8a1b0e09154987b07b755a8ac5c41bb72fc2514c1c363be5d9bb05747da7f6202469ea9e1dd044f77c"} build_url:https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/bsMKqkxKRy-yvlj_jRlnmQ/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/7b2875784d537af780b9d807e56b7f28c595f1bf1f587419985d56e59ad3671aeb8f21359d5d49c16a8672752f6cc0d4d31bd427e119381b99041d98a028b2c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc3eb6a92911db7170839b2d4612955527e1b4c2899c7bcd3036246e8f81ade577cca0e06e6060d9d4de39b6ce8a8e9c9a406249f7a2025436fb8ef4bfa06a10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e98c35e467af24169dcb5be7bc830235d714bbe699655c8a1b0e09154987b07b755a8ac5c41bb72fc2514c1c363be5d9bb05747da7f6202469ea9e1dd044f77c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 08:44:09.283845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:44:09.284131) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463671386.264707-981731700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 08:44:09.386038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 08:44:09.386349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 08:44:09.386621) ========= ========= Total master_lag: 0.19 =========