builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1464386192.8 results: success (0) buildid: 20160527053644 builduid: 70899685370c4d899c113fabe58a40e2 revision: df3281895c93b96241347e8c6a699256bcb3970c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.804142) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.805020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.805343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.821260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.821824) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 14:56:33-- 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.7M=0s 2016-05-27 14:56:33 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.907685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.908216) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.961134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:32.961916) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df3281895c93b96241347e8c6a699256bcb3970c --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 df3281895c93b96241347e8c6a699256bcb3970c --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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 14:56:33,580 truncating revision to first 12 chars 2016-05-27 14:56:33,580 Setting DEBUG logging. 2016-05-27 14:56:33,580 attempt 1/10 2016-05-27 14:56:33,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df3281895c93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 14:56:33,908 unpacking tar archive at: fx-team-df3281895c93/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:33.634489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:33.634948) ========= script_repo_revision: df3281895c93b96241347e8c6a699256bcb3970c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:33.635406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:33.635745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 14:56:33.647295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 14:56:33.647864) ========= /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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:56:34 INFO - MultiFileLogger online at 20160527 14:56:34 in /builds/slave/test 14:56:34 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 14:56:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:56:34 INFO - {'append_to_log': False, 14:56:34 INFO - 'base_work_dir': '/builds/slave/test', 14:56:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:56:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:56:34 INFO - 'branch': 'Fx-Team-Non-PGO', 14:56:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:56:34 INFO - 'config_files': ('talos/linux_config.py',), 14:56:34 INFO - 'default_actions': ('clobber', 14:56:34 INFO - 'read-buildbot-config', 14:56:34 INFO - 'download-and-extract', 14:56:34 INFO - 'populate-webroot', 14:56:34 INFO - 'create-virtualenv', 14:56:34 INFO - 'install', 14:56:34 INFO - 'run-tests'), 14:56:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:56:34 INFO - 'download_minidump_stackwalk': True, 14:56:34 INFO - 'download_symbols': 'ondemand', 14:56:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:56:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:56:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:56:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:56:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:56:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:56:34 INFO - 'installer_path': 'installer.exe', 14:56:34 INFO - 'log_level': 'info', 14:56:34 INFO - 'log_name': 'talos', 14:56:34 INFO - 'log_to_console': True, 14:56:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:56:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:56:34 INFO - 'opt_config_files': (), 14:56:34 INFO - 'pip_index': False, 14:56:34 INFO - 'sps_profile': False, 14:56:34 INFO - 'sps_profile_interval': 0, 14:56:34 INFO - 'suite': 'dromaeojs', 14:56:34 INFO - 'system_bits': '32', 14:56:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:56:34 INFO - 'title': 'talos-linux64-ix-037', 14:56:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:56:34 INFO - 'use_talos_json': True, 14:56:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:56:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:56:34 INFO - 'work_dir': 'build'} 14:56:34 INFO - ##### 14:56:34 INFO - ##### Running clobber step. 14:56:34 INFO - ##### 14:56:34 INFO - Running pre-action listener: _resource_record_pre_action 14:56:34 INFO - Running main action method: clobber 14:56:34 INFO - rmtree: /builds/slave/test/build 14:56:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:56:34 INFO - Running post-action listener: _resource_record_post_action 14:56:34 INFO - ##### 14:56:34 INFO - ##### Finished clobber step (success) 14:56:34 INFO - ##### 14:56:34 INFO - ##### 14:56:34 INFO - ##### Running read-buildbot-config step. 14:56:34 INFO - ##### 14:56:34 INFO - Running pre-action listener: _resource_record_pre_action 14:56:34 INFO - Running main action method: read_buildbot_config 14:56:34 INFO - Using buildbot properties: 14:56:34 INFO - { 14:56:34 INFO - "project": "", 14:56:34 INFO - "product": "firefox", 14:56:34 INFO - "script_repo_revision": "production", 14:56:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:56:34 INFO - "repository": "", 14:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:56:34 INFO - "buildid": "20160527053644", 14:56:34 INFO - "pgo_build": "False", 14:56:34 INFO - "basedir": "/builds/slave/test", 14:56:34 INFO - "buildnumber": 1734, 14:56:34 INFO - "slavename": "talos-linux64-ix-037", 14:56:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:56:34 INFO - "platform": "ubuntu64_hw", 14:56:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:56:34 INFO - "branch": "fx-team", 14:56:34 INFO - "repo_path": "integration/fx-team", 14:56:34 INFO - "revision": "df3281895c93b96241347e8c6a699256bcb3970c", 14:56:34 INFO - "stage_platform": "linux64", 14:56:34 INFO - "builduid": "70899685370c4d899c113fabe58a40e2", 14:56:34 INFO - "slavebuilddir": "test" 14:56:34 INFO - } 14:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:56:34 INFO - Running post-action listener: _resource_record_post_action 14:56:34 INFO - ##### 14:56:34 INFO - ##### Finished read-buildbot-config step (success) 14:56:34 INFO - ##### 14:56:34 INFO - ##### 14:56:34 INFO - ##### Running download-and-extract step. 14:56:34 INFO - ##### 14:56:34 INFO - Running pre-action listener: _resource_record_pre_action 14:56:34 INFO - Running main action method: download_and_extract 14:56:34 INFO - mkdir: /builds/slave/test/build/tests 14:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:34 INFO - https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:35 INFO - Downloaded 1361 bytes. 14:56:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:56:35 INFO - Using the following test package requirements: 14:56:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:56:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:56:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:56:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'jsshell-linux-x86_64.zip'], 14:56:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:56:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:56:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:56:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:56:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:56:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:56:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:56:35 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')]} 14:56:35 INFO - https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:36 INFO - Downloaded 22837963 bytes. 14:56:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:56:38 INFO - Return code: 0 14:56:38 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 14:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:38 INFO - https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:39 INFO - Downloaded 22837963 bytes. 14:56:39 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'] 14:56:39 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 14:56:40 INFO - Return code: 0 14:56:40 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')]} 14:56:40 INFO - https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:42 INFO - Downloaded 10834034 bytes. 14:56:42 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'] 14:56:42 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 14:56:42 INFO - Return code: 0 14:56:42 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')]} 14:56:42 INFO - https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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 14:56:43 INFO - Downloaded 54830250 bytes. 14:56:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:56:43 INFO - mkdir: /builds/slave/test/properties 14:56:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:56:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:56:43 INFO - Contents: 14:56:43 INFO - build_url:https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:56:44 INFO - Running post-action listener: _resource_record_post_action 14:56:44 INFO - Running post-action listener: set_extra_try_arguments 14:56:44 INFO - ##### 14:56:44 INFO - ##### Finished download-and-extract step (success) 14:56:44 INFO - ##### 14:56:44 INFO - ##### 14:56:44 INFO - ##### Running populate-webroot step. 14:56:44 INFO - ##### 14:56:44 INFO - Running pre-action listener: _resource_record_pre_action 14:56:44 INFO - Running main action method: populate_webroot 14:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:56:44 INFO - '--tppagecycles', 14:56:44 INFO - '7'], 14:56:44 INFO - 'tests': ['tsvgm']}}, 14:56:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:56:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:56:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:56:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:56:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['damp', 'tps']}, 14:56:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'tests': ['damp', 'tps']}, 14:56:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['dromaeo_dom']}, 14:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:56:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['a11yr', 14:56:44 INFO - 'ts_paint', 14:56:44 INFO - 'tpaint', 14:56:44 INFO - 'sessionrestore', 14:56:44 INFO - 'sessionrestore_no_auto_restore', 14:56:44 INFO - 'tabpaint']}, 14:56:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['tsvgx', 14:56:44 INFO - 'tsvgr_opacity', 14:56:44 INFO - 'tart', 14:56:44 INFO - 'tscrollx', 14:56:44 INFO - 'cart']}, 14:56:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:56:44 INFO - 'tsvgr_opacity', 14:56:44 INFO - 'tart', 14:56:44 INFO - 'tscrollx', 14:56:44 INFO - 'cart']}, 14:56:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'talos_options': ['--disable-e10s'], 14:56:44 INFO - 'tests': ['tp5o']}, 14:56:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'tests': ['tp5o']}, 14:56:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'talos_options': ['--disable-e10s', 14:56:44 INFO - '--xperf_path', 14:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:44 INFO - 'tests': ['tp5n']}, 14:56:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:56:44 INFO - 'talos_options': ['--xperf_path', 14:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:44 INFO - 'tests': ['tp5n']}}, 14:56:44 INFO - 'talos.zip': {'path': '', 14:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:56:44 INFO - Running post-action listener: _resource_record_post_action 14:56:44 INFO - ##### 14:56:44 INFO - ##### Finished populate-webroot step (success) 14:56:44 INFO - ##### 14:56:44 INFO - ##### 14:56:44 INFO - ##### Running create-virtualenv step. 14:56:44 INFO - ##### 14:56:44 INFO - Running pre-action listener: _resource_record_pre_action 14:56:44 INFO - Running main action method: create_virtualenv 14:56:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:56:44 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 14:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:56:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:56:44 INFO - Using real prefix '/usr' 14:56:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:56:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:56:47 INFO - Installing pip.................done. 14:56:47 INFO - Return code: 0 14:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:56:47 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')]} 14:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:47 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')]} 14:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:47 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56:47 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 14:56:47 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 14:56:47 INFO - Using env: {'DISPLAY': ':0', 14:56:47 INFO - 'HOME': '/home/cltbld', 14:56:47 INFO - 'LANG': 'en_US.UTF-8', 14:56:47 INFO - 'LANGUAGE': 'en_US:en', 14:56:47 INFO - 'LOGNAME': 'cltbld', 14:56:47 INFO - 'MAIL': '/var/mail/cltbld', 14:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:47 INFO - 'MOZ_NO_REMOTE': '1', 14:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:47 INFO - 'NO_EM_RESTART': '1', 14:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:47 INFO - 'PWD': '/builds/slave/test', 14:56:47 INFO - 'SHELL': '/bin/bash', 14:56:47 INFO - 'SHLVL': '1', 14:56:47 INFO - 'TERM': 'linux', 14:56:47 INFO - 'TMOUT': '86400', 14:56:47 INFO - 'USER': 'cltbld', 14:56:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:47 INFO - '_': '/tools/buildbot/bin/python'} 14:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:47 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 14:56:47 INFO - Cleaning up... 14:56:47 INFO - Return code: 0 14:56:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:56:47 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')]} 14:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:47 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')]} 14:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:47 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56:47 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 14:56:47 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 14:56:47 INFO - Using env: {'DISPLAY': ':0', 14:56:47 INFO - 'HOME': '/home/cltbld', 14:56:47 INFO - 'LANG': 'en_US.UTF-8', 14:56:47 INFO - 'LANGUAGE': 'en_US:en', 14:56:47 INFO - 'LOGNAME': 'cltbld', 14:56:47 INFO - 'MAIL': '/var/mail/cltbld', 14:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:47 INFO - 'MOZ_NO_REMOTE': '1', 14:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:47 INFO - 'NO_EM_RESTART': '1', 14:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:47 INFO - 'PWD': '/builds/slave/test', 14:56:47 INFO - 'SHELL': '/bin/bash', 14:56:47 INFO - 'SHLVL': '1', 14:56:47 INFO - 'TERM': 'linux', 14:56:47 INFO - 'TMOUT': '86400', 14:56:47 INFO - 'USER': 'cltbld', 14:56:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:47 INFO - '_': '/tools/buildbot/bin/python'} 14:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:47 INFO - Downloading/unpacking psutil>=3.1.1 14:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:49 INFO - Installing collected packages: psutil 14:56:49 INFO - Running setup.py install for psutil 14:56:49 INFO - building 'psutil._psutil_linux' extension 14:56:49 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 14:56:49 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 14:56:50 INFO - building 'psutil._psutil_posix' extension 14:56:50 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 14:56:50 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 14:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:50 INFO - Successfully installed psutil 14:56:50 INFO - Cleaning up... 14:56:50 INFO - Return code: 0 14:56:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:56:50 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')]} 14:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:50 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')]} 14:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:50 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56:50 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 14:56:50 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 14:56:50 INFO - Using env: {'DISPLAY': ':0', 14:56:50 INFO - 'HOME': '/home/cltbld', 14:56:50 INFO - 'LANG': 'en_US.UTF-8', 14:56:50 INFO - 'LANGUAGE': 'en_US:en', 14:56:50 INFO - 'LOGNAME': 'cltbld', 14:56:50 INFO - 'MAIL': '/var/mail/cltbld', 14:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:50 INFO - 'MOZ_NO_REMOTE': '1', 14:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:50 INFO - 'NO_EM_RESTART': '1', 14:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:50 INFO - 'PWD': '/builds/slave/test', 14:56:50 INFO - 'SHELL': '/bin/bash', 14:56:50 INFO - 'SHLVL': '1', 14:56:50 INFO - 'TERM': 'linux', 14:56:50 INFO - 'TMOUT': '86400', 14:56:50 INFO - 'USER': 'cltbld', 14:56:50 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:50 INFO - '_': '/tools/buildbot/bin/python'} 14:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:56:50 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 14:56:50 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 14:56:50 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 14:56:50 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 14:56:50 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 14:56:50 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 14:56:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:56:52 INFO - Installing collected packages: mozsystemmonitor 14:56:52 INFO - Running setup.py install for mozsystemmonitor 14:56:52 INFO - Successfully installed mozsystemmonitor 14:56:52 INFO - Cleaning up... 14:56:52 INFO - Return code: 0 14:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:56: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')]} 14:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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')]} 14:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56: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', '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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:56: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 blobuploader==1.2.4 14:56:52 INFO - Using env: {'DISPLAY': ':0', 14:56:52 INFO - 'HOME': '/home/cltbld', 14:56:52 INFO - 'LANG': 'en_US.UTF-8', 14:56:52 INFO - 'LANGUAGE': 'en_US:en', 14:56:52 INFO - 'LOGNAME': 'cltbld', 14:56:52 INFO - 'MAIL': '/var/mail/cltbld', 14:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:52 INFO - 'MOZ_NO_REMOTE': '1', 14:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:52 INFO - 'NO_EM_RESTART': '1', 14:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:52 INFO - 'PWD': '/builds/slave/test', 14:56:52 INFO - 'SHELL': '/bin/bash', 14:56:52 INFO - 'SHLVL': '1', 14:56:52 INFO - 'TERM': 'linux', 14:56:52 INFO - 'TMOUT': '86400', 14:56:52 INFO - 'USER': 'cltbld', 14:56:52 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:52 INFO - '_': '/tools/buildbot/bin/python'} 14:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:56:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:56:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:55 INFO - Downloading docopt-0.6.1.tar.gz 14:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:56:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:56:55 INFO - Running setup.py install for blobuploader 14:56:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:56:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:56:55 INFO - Running setup.py install for requests 14:56:55 INFO - Running setup.py install for docopt 14:56:56 INFO - Successfully installed blobuploader requests docopt 14:56:56 INFO - Cleaning up... 14:56:56 INFO - Return code: 0 14:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:56 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')]} 14:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:56 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')]} 14:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:56 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56:56 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 14:56:56 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 14:56:56 INFO - Using env: {'DISPLAY': ':0', 14:56:56 INFO - 'HOME': '/home/cltbld', 14:56:56 INFO - 'LANG': 'en_US.UTF-8', 14:56:56 INFO - 'LANGUAGE': 'en_US:en', 14:56:56 INFO - 'LOGNAME': 'cltbld', 14:56:56 INFO - 'MAIL': '/var/mail/cltbld', 14:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:56 INFO - 'MOZ_NO_REMOTE': '1', 14:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:56 INFO - 'NO_EM_RESTART': '1', 14:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:56 INFO - 'PWD': '/builds/slave/test', 14:56:56 INFO - 'SHELL': '/bin/bash', 14:56:56 INFO - 'SHLVL': '1', 14:56:56 INFO - 'TERM': 'linux', 14:56:56 INFO - 'TMOUT': '86400', 14:56:56 INFO - 'USER': 'cltbld', 14:56:56 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:56 INFO - '_': '/tools/buildbot/bin/python'} 14:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:56 INFO - Running setup.py (path:/tmp/pip-fysbdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:56 INFO - Running setup.py (path:/tmp/pip-nbUiWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:56 INFO - Running setup.py (path:/tmp/pip-VPSlP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:56 INFO - Running setup.py (path:/tmp/pip-I5Xd65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:56 INFO - Running setup.py (path:/tmp/pip-_u1GVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:56 INFO - Running setup.py (path:/tmp/pip-FGNQ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:56 INFO - Running setup.py (path:/tmp/pip-yejGve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:56 INFO - Running setup.py (path:/tmp/pip-7P1uvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:56 INFO - Running setup.py (path:/tmp/pip-DF_ub6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:56 INFO - Running setup.py (path:/tmp/pip-fWMxXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:56 INFO - Running setup.py (path:/tmp/pip-GPMZKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:57 INFO - Running setup.py (path:/tmp/pip-EthgBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:57 INFO - Running setup.py (path:/tmp/pip-AyI5v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:57 INFO - Running setup.py (path:/tmp/pip-Rd9jAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:57 INFO - Running setup.py (path:/tmp/pip-V9kGqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:57 INFO - Running setup.py (path:/tmp/pip-xtbLAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:57 INFO - Running setup.py (path:/tmp/pip-KLFOsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:56:57 INFO - Running setup.py install for manifestparser 14:56:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:56:57 INFO - Running setup.py install for mozcrash 14:56:57 INFO - Running setup.py install for mozdebug 14:56:57 INFO - Running setup.py install for mozdevice 14:56:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:56:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:56:57 INFO - Running setup.py install for mozfile 14:56:58 INFO - Running setup.py install for mozhttpd 14:56:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozinfo 14:56:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozInstall 14:56:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozleak 14:56:58 INFO - Running setup.py install for mozlog 14:56:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for moznetwork 14:56:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozprocess 14:56:58 INFO - Running setup.py install for mozprofile 14:56:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozrunner 14:56:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:56:58 INFO - Running setup.py install for mozscreenshot 14:56:59 INFO - Running setup.py install for moztest 14:56:59 INFO - Running setup.py install for mozversion 14:56:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:56:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:56:59 INFO - Cleaning up... 14:56:59 INFO - Return code: 0 14:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:59 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:56:59 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 14:56:59 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 14:56:59 INFO - Using env: {'DISPLAY': ':0', 14:56:59 INFO - 'HOME': '/home/cltbld', 14:56:59 INFO - 'LANG': 'en_US.UTF-8', 14:56:59 INFO - 'LANGUAGE': 'en_US:en', 14:56:59 INFO - 'LOGNAME': 'cltbld', 14:56:59 INFO - 'MAIL': '/var/mail/cltbld', 14:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:59 INFO - 'MOZ_NO_REMOTE': '1', 14:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:59 INFO - 'NO_EM_RESTART': '1', 14:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:59 INFO - 'PWD': '/builds/slave/test', 14:56:59 INFO - 'SHELL': '/bin/bash', 14:56:59 INFO - 'SHLVL': '1', 14:56:59 INFO - 'TERM': 'linux', 14:56:59 INFO - 'TMOUT': '86400', 14:56:59 INFO - 'USER': 'cltbld', 14:56:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:59 INFO - '_': '/tools/buildbot/bin/python'} 14:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:59 INFO - Running setup.py (path:/tmp/pip-986CXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:59 INFO - Running setup.py (path:/tmp/pip-5_sBJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:59 INFO - Running setup.py (path:/tmp/pip-hlwZEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:59 INFO - Running setup.py (path:/tmp/pip-P9o1uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:59 INFO - Running setup.py (path:/tmp/pip-UQpE98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:59 INFO - Running setup.py (path:/tmp/pip-pXyjAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:59 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)) 14:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:59 INFO - Running setup.py (path:/tmp/pip-Cd5nCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:00 INFO - Running setup.py (path:/tmp/pip-VOnuDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:00 INFO - Running setup.py (path:/tmp/pip-JJyfz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:00 INFO - Running setup.py (path:/tmp/pip-GFwGRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:00 INFO - Running setup.py (path:/tmp/pip-axYUVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:00 INFO - Running setup.py (path:/tmp/pip-WNyneM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:00 INFO - Running setup.py (path:/tmp/pip-Ye_RZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:00 INFO - Running setup.py (path:/tmp/pip-2iCWFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:00 INFO - Running setup.py (path:/tmp/pip-YY1abR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:00 INFO - Running setup.py (path:/tmp/pip-ecLsP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:00 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)) 14:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:00 INFO - Running setup.py (path:/tmp/pip-zF7fZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:00 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)) 14:57:00 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)) 14:57:00 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)) 14:57:00 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)) 14:57:00 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)) 14:57:00 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)) 14:57:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:02 INFO - Downloading blessings-1.6.tar.gz 14:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:02 INFO - Installing collected packages: blessings 14:57:02 INFO - Running setup.py install for blessings 14:57:02 INFO - Successfully installed blessings 14:57:02 INFO - Cleaning up... 14:57:02 INFO - Return code: 0 14:57:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:03 INFO - Reading from file tmpfile_stdout 14:57:03 INFO - Current package versions: 14:57:03 INFO - argparse == 1.2.1 14:57:03 INFO - blessings == 1.6 14:57:03 INFO - blobuploader == 1.2.4 14:57:03 INFO - docopt == 0.6.1 14:57:03 INFO - manifestparser == 1.1 14:57:03 INFO - mozInstall == 1.12 14:57:03 INFO - mozcrash == 0.17 14:57:03 INFO - mozdebug == 0.1 14:57:03 INFO - mozdevice == 0.48 14:57:03 INFO - mozfile == 1.2 14:57:03 INFO - mozhttpd == 0.7 14:57:03 INFO - mozinfo == 0.9 14:57:03 INFO - mozleak == 0.1 14:57:03 INFO - mozlog == 3.2 14:57:03 INFO - moznetwork == 0.27 14:57:03 INFO - mozprocess == 0.22 14:57:03 INFO - mozprofile == 0.28 14:57:03 INFO - mozrunner == 6.11 14:57:03 INFO - mozscreenshot == 0.1 14:57:03 INFO - mozsystemmonitor == 0.3 14:57:03 INFO - moztest == 0.7 14:57:03 INFO - mozversion == 1.4 14:57:03 INFO - psutil == 3.1.1 14:57:03 INFO - requests == 1.2.3 14:57:03 INFO - wsgiref == 0.1.2 14:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:03 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 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:57:03 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 14:57:03 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 14:57:03 INFO - Using env: {'DISPLAY': ':0', 14:57:03 INFO - 'HOME': '/home/cltbld', 14:57:03 INFO - 'LANG': 'en_US.UTF-8', 14:57:03 INFO - 'LANGUAGE': 'en_US:en', 14:57:03 INFO - 'LOGNAME': 'cltbld', 14:57:03 INFO - 'MAIL': '/var/mail/cltbld', 14:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:03 INFO - 'MOZ_NO_REMOTE': '1', 14:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:03 INFO - 'NO_EM_RESTART': '1', 14:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:03 INFO - 'PWD': '/builds/slave/test', 14:57:03 INFO - 'SHELL': '/bin/bash', 14:57:03 INFO - 'SHLVL': '1', 14:57:03 INFO - 'TERM': 'linux', 14:57:03 INFO - 'TMOUT': '86400', 14:57:03 INFO - 'USER': 'cltbld', 14:57:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:03 INFO - '_': '/tools/buildbot/bin/python'} 14:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 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)) 14:57:03 INFO - Cleaning up... 14:57:03 INFO - Return code: 0 14:57:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:57:03 INFO - Using env: {'DISPLAY': ':0', 14:57:03 INFO - 'HOME': '/home/cltbld', 14:57:03 INFO - 'LANG': 'en_US.UTF-8', 14:57:03 INFO - 'LANGUAGE': 'en_US:en', 14:57:03 INFO - 'LOGNAME': 'cltbld', 14:57:03 INFO - 'MAIL': '/var/mail/cltbld', 14:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:03 INFO - 'MOZ_NO_REMOTE': '1', 14:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:03 INFO - 'NO_EM_RESTART': '1', 14:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:03 INFO - 'PWD': '/builds/slave/test', 14:57:03 INFO - 'SHELL': '/bin/bash', 14:57:03 INFO - 'SHLVL': '1', 14:57:03 INFO - 'TERM': 'linux', 14:57:03 INFO - 'TMOUT': '86400', 14:57:03 INFO - 'USER': 'cltbld', 14:57:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:03 INFO - '_': '/tools/buildbot/bin/python'} 14:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:03 INFO - Downloading/unpacking jsonschema 14:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:05 INFO - warning: no files found matching '*.txt' 14:57:05 INFO - no previously-included directories found matching 'build' 14:57:05 INFO - no previously-included directories found matching 'dist' 14:57:05 INFO - no previously-included directories found matching '.git*' 14:57:05 INFO - Installing collected packages: jsonschema, functools32 14:57:05 INFO - Running setup.py install for functools32 14:57:05 INFO - warning: no files found matching '*.txt' 14:57:05 INFO - no previously-included directories found matching 'build' 14:57:05 INFO - no previously-included directories found matching 'dist' 14:57:05 INFO - no previously-included directories found matching '.git*' 14:57:05 INFO - Successfully installed jsonschema functools32 14:57:05 INFO - Cleaning up... 14:57:05 INFO - Return code: 0 14:57:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f090f3aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2463770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', '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 14:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:57:05 INFO - Using env: {'DISPLAY': ':0', 14:57:05 INFO - 'HOME': '/home/cltbld', 14:57:05 INFO - 'LANG': 'en_US.UTF-8', 14:57:05 INFO - 'LANGUAGE': 'en_US:en', 14:57:05 INFO - 'LOGNAME': 'cltbld', 14:57:05 INFO - 'MAIL': '/var/mail/cltbld', 14:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:05 INFO - 'MOZ_NO_REMOTE': '1', 14:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:05 INFO - 'NO_EM_RESTART': '1', 14:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:05 INFO - 'PWD': '/builds/slave/test', 14:57:05 INFO - 'SHELL': '/bin/bash', 14:57:05 INFO - 'SHLVL': '1', 14:57:05 INFO - 'TERM': 'linux', 14:57:05 INFO - 'TMOUT': '86400', 14:57:05 INFO - 'USER': 'cltbld', 14:57:05 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:05 INFO - '_': '/tools/buildbot/bin/python'} 14:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:06 INFO - Downloading/unpacking flake8 14:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:57:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:57:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:08 INFO - no previously-included directories found matching 'docs/_build' 14:57:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:57:08 INFO - Running setup.py install for pep8 14:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:08 INFO - no previously-included directories found matching 'docs/_build' 14:57:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:57:08 INFO - Cleaning up... 14:57:08 INFO - Return code: 0 14:57:08 INFO - Running post-action listener: _resource_record_post_action 14:57:08 INFO - Running post-action listener: _start_resource_monitoring 14:57:09 INFO - Starting resource monitoring. 14:57:09 INFO - ##### 14:57:09 INFO - ##### Finished create-virtualenv step (success) 14:57:09 INFO - ##### 14:57:09 INFO - ##### 14:57:09 INFO - ##### Running install step. 14:57:09 INFO - ##### 14:57:09 INFO - Running pre-action listener: _resource_record_pre_action 14:57:09 INFO - Running main action method: install 14:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:09 INFO - Reading from file tmpfile_stdout 14:57:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:09 INFO - Reading from file tmpfile_stdout 14:57:09 INFO - Output received: 14:57:09 INFO - Usage: mozinstall [options] installer 14:57:09 INFO - Options: 14:57:09 INFO - -h, --help show this help message and exit 14:57:09 INFO - -d DEST, --destination=DEST 14:57:09 INFO - Directory to install application into. [default: 14:57:09 INFO - "/builds/slave/test"] 14:57:09 INFO - --app=APP Application being installed. [default: firefox] 14:57:09 INFO - mkdir: /builds/slave/test/build/application 14:57:09 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'] 14:57:09 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 14:57:25 INFO - Reading from file tmpfile_stdout 14:57:25 INFO - Output received: 14:57:25 INFO - /builds/slave/test/build/application/firefox/firefox 14:57:25 INFO - Running post-action listener: _resource_record_post_action 14:57:25 INFO - ##### 14:57:25 INFO - ##### Finished install step (success) 14:57:25 INFO - ##### 14:57:25 INFO - ##### 14:57:25 INFO - ##### Running run-tests step. 14:57:25 INFO - ##### 14:57:25 INFO - Running pre-action listener: _resource_record_pre_action 14:57:25 INFO - Running main action method: run_tests 14:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:57:25 INFO - Python 2.7.3 14:57:25 INFO - Return code: 0 14:57:25 INFO - grabbing minidump binary from tooltool 14:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:25 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 0x24f29c0>, '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 0x24f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:57:25 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 14:57:25 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 14:57:25 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 14:57:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:57:25 INFO - Return code: 0 14:57:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:57:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:57:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:57:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:57:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:57:26 INFO - Return code: 0 14:57:26 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/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:57:26 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/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 14:57:26 INFO - Using env: {'DISPLAY': ':0', 14:57:26 INFO - 'HOME': '/home/cltbld', 14:57:26 INFO - 'LANG': 'en_US.UTF-8', 14:57:26 INFO - 'LANGUAGE': 'en_US:en', 14:57:26 INFO - 'LOGNAME': 'cltbld', 14:57:26 INFO - 'MAIL': '/var/mail/cltbld', 14:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:26 INFO - 'MOZ_NO_REMOTE': '1', 14:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:26 INFO - 'NO_EM_RESTART': '1', 14:57:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:26 INFO - 'PWD': '/builds/slave/test', 14:57:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:57:26 INFO - 'SHELL': '/bin/bash', 14:57:26 INFO - 'SHLVL': '1', 14:57:26 INFO - 'TERM': 'linux', 14:57:26 INFO - 'TMOUT': '86400', 14:57:26 INFO - 'USER': 'cltbld', 14:57:26 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987', 14:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:26 INFO - '_': '/tools/buildbot/bin/python'} 14:57:26 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/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 14:57:26 INFO - mozversion application_buildid: 20160527053644 14:57:26 INFO - mozversion application_changeset: df3281895c93b96241347e8c6a699256bcb3970c 14:57:26 INFO - mozversion application_display_name: Nightly 14:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:57:26 INFO - mozversion application_name: Firefox 14:57:26 INFO - mozversion application_remotingname: firefox 14:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:57:26 INFO - mozversion application_vendor: Mozilla 14:57:26 INFO - mozversion application_version: 49.0a1 14:57:26 INFO - mozversion platform_buildid: 20160527053644 14:57:26 INFO - mozversion platform_changeset: df3281895c93b96241347e8c6a699256bcb3970c 14:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:57:26 INFO - mozversion platform_version: 49.0a1 14:57:26 INFO - using testdate: 1464386246 14:57:26 INFO - actual date: 1464386246 14:57:26 INFO - starting webserver on 'localhost:42591' 14:57:26 INFO - SUITE-START | Running 2 tests 14:57:26 INFO - TEST-START | dromaeo_css 14:57:26 INFO - operating with platform_type : linux_ 14:57:26 INFO - Initialising browser for dromaeo_css test... 14:57:26 INFO - TEST-INFO | started process 16993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu5fHcn/profile http://localhost:42591/getInfo.html) 14:57:30 INFO - PROCESS | 16993 | __metrics Screen width/height:1600/1200 14:57:30 INFO - PROCESS | 16993 | colorDepth:24 14:57:30 INFO - PROCESS | 16993 | Browser inner width/height: 1024/697 14:57:30 INFO - PROCESS | 16993 | __metrics 14:57:31 ERROR - PROCESS | 16993 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:57:32 INFO - TEST-INFO | 16993: exit 0 14:57:32 INFO - Browser initialized. 14:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:57:32 INFO - TEST-INFO | started process 17073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu5fHcn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:44 INFO - PROCESS | 17073 | RSS: Main: 157069312 14:57:44 INFO - PROCESS | 17073 | 14:58:36 INFO - PROCESS | 17073 | 1464386316311 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] 15:00:47 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42591/tests/dromaeo/cssquery-ext.html) 15:00:49 INFO - PROCESS | 17073 | RSS: Main: 240717824 15:00:49 INFO - PROCESS | 17073 | 15:03:51 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-ext.html (next: http://localhost:42591/tests/dromaeo/cssquery-jquery.html) 15:03:52 INFO - PROCESS | 17073 | RSS: Main: 235114496 15:03:52 INFO - PROCESS | 17073 | 15:06:54 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42591/tests/dromaeo/cssquery-mootools.html) 15:06:54 INFO - PROCESS | 17073 | RSS: Main: 234545152 15:06:54 INFO - PROCESS | 17073 | 15:09:57 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42591/tests/dromaeo/cssquery-prototype.html) 15:09:57 INFO - PROCESS | 17073 | RSS: Main: 240484352 15:09:57 INFO - PROCESS | 17073 | 15:13:00 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42591/tests/dromaeo/cssquery-yui.html) 15:13:01 INFO - PROCESS | 17073 | RSS: Main: 224735232 15:13:01 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | Cycle 1(1): loaded http://localhost:42591/tests/dromaeo/cssquery-yui.html (next: http://localhost:42591/tests/dromaeo/cssquery-dojo.html) 15:16:04 INFO - PROCESS | 17073 | RSS: Main: 273670144 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | __start_tp_report 15:16:04 INFO - PROCESS | 17073 | _x_x_mozilla_page_load 15:16:04 INFO - PROCESS | 17073 | _x_x_mozilla_page_load_details 15:16:04 INFO - PROCESS | 17073 | |i|pagename|runs| 15:16:04 INFO - PROCESS | 17073 | |0;dojo.html;2696.191142657203;2709.512287788197;2724.9727502724977;2746.080063178835;2772.708865569115;4703.106409782139;4750.501197374273;4791;4818.759062046896;4869.245266983615;4805.975970120145;4813.205821039524;4870.780814863331;4878.756062196885;4884.169691152504;4392.538783427742;4396.36252743352;4451.577100175478;4523.705959112664;4597.057603191354;4513.255312873372;4545.045540436512;4562.977185114087;4568.908621827578;4584.472785629645;4324.243257429937;4363.47638283408;4371.562843715635;4436.179306828247;4457.665675074366;4377.737335759864;4378.737275763432;4386.934195987063;4447.644188464915;4466;4444.933326000112;4450.46594408673;4452.844150454718;4506.053728716974;4507.661925355578;4597.839075632371;4669.229577119771;4745.83389581363;4754.595859351959;4758.547937945889;5253.238280449352;5266.078436273637;5267.736613169326;5269.894602107975;5273.129933560957;5226.216067589854;5266.104762190437;5306.602004849652;5319.494648008433;5324.467553244684;4725.29120631908;4832.226843704991;4894.657373983858;4907.705537667752;4908.11653902301;5333.86665333362;5369.328833895763;5376.139817629239;5389.487998640123;5391.083515802323;4978.303037574742;5153.665011774297;5164.147915593885;5166.250893620404;5172.224166375074;5109.20807274873;5113.309703190096;5135.845924622267;5155.922661160085;5170.948290517047;5105.795768169306;5127.6154288428515;5134.666246693953;5137.717425541631;5188.455212202664;4978.90042199154;4992.500749925051;5125.8718532037;5140.151874940593;5145.176771716508;4291.463567054118;4295.892602684958;4310.181065597527;4354.608085272277;4358.128374325148;3770.792606406619;3778.301014312361;3782.6973842093116;3803.1633040730994;3817.4846395736777;4309.375140604658;4356.803943822536;4394.055278115221;4394.428724265825;4431.180231657154;5087.669301495391;5089.440161582223;5146.30524879144;5161.096808058574;5177.352830896138;4409.052053808383;4421.756803375781;4426.911461770746;4474.753888536162;4479.014616784368;4512.165249428866;4573.679842411066;4599.241125214302;4617.561331673485;4622.214223581999;4848.5636292733825;4877.853664390074;4880.243562247857;4915.803367865316;4920.72935988524;5181.145111056633;5182.274481572507;5187.714675692722;5193.766280517461;5198.272241886063;4718.551737584924;4832.395950506187;4876.097921884463;4877.517152552392;4893.755312234445;5106.617003724661;5119.46245644202;5136.101182293009;5144.485551444825;5185.974070129625;5210.921836172536;5217.139172036572;5226.320578324793;5231.136862417658;5231.633785634969;4895.241237608177;4981.651284410056;5030.471800461045;5040.042391945519;5050.419201791841;5019.924701129413;5055.115354812967;5057.494250574913;5058.671186372874;5109.412417571878;4836.95163048365;4988.152014157675;5001.049800537886;5004.799808007784;5050.570701490415;5041.495850414929;5077.7461126944245;5095.87260318495;5103.948960510495;5118.769655365443;5001.749912504433;5002.774875130555;5012.273220383097;5023.7739301732245;5064.240363945438 15:16:04 INFO - PROCESS | 17073 | |1;ext.html;599.5473417569734;599.6701814002299;601.8495376155961;608.1880689279811;614.2260751453169;26760.86619566902;29763.40473190535;40202.396964045525;41344.17311653773;41460.17079658413;41805.16389672205;42073.789631051804;42168.36747448783;42173;42323.788381058126;7668.079830420357;7834.490758100734;7840.882386764203;7849.882251766228;7851.45039847211;7636.236376362347;7751.728689495869;7754.263344982218;7758.961205193966;7760.417968652346;7769.2619201176085;7787.922120778805;7799;7805.726799562017;7819.98340215774;7718.073831140243;7752.26353496417;7760.029996250469;7762.184970578092;7786.4938778979185;7649.617519124077;7791.10402303731;7806;7806.882896756553;7809.570473623949;38707;39089.60910390888;39107;39183.41224881601;39221.80389098065;3022.2897619059504;3029.2578318311935;3033.4084853453587;3204.871805127792;3356.110630682871;28220.15339539817;28265;29138.271543211376;29352.8532357339;29770.255743606365;3472.70482009027;3517.8065206413635;3539.2213712983103;3550.804705741183;3551.804650744208;263701;265648;266249;266687;266916;55962.60093497695;56399;56528;56577.43422565804;56669.14996275059;50959;56559.71720141373;58203.70898145482;58502;64092;13165.53920612774;13411.262380569162;13417.25575675156;13423.798643020362;13426.932865335611;8981.14679105484;9965.950170249102;10056.69829905104;10058.597656093674;10061.64784232563;18016.459506214833;18260.36088736888;18622.906885465756;19016.42950711453;19186.616267674846;6696.933030669728;6908.861822763517;6964.651767411609;7082.256363081905;7125.394341481032;737.3032484302283;825.8802473641289;857.9013413457533;934.9672761453317;951.4909523404945;27959.301017474318;28608.71391286102;28763.712362876104;28966.855165724035;29277.85361073181;862.2799962031648;953.4755884263627;960.6061514778908;1021.581151727788;1029.8249297619423;15096.39614415411;15134.394624215129;15218.847811521964;15412.537623871302;15444.382224710886;388192;422684;429276;429432;642816;48038.27942580864;48169.277460838115;48621.270680939815;54404.183937240974;54464.45535544673;1119.6193294279822;1182.1193211057816;1215.9513619455122;1219.3842109734528;1237.5111830826952;26056.218313450627;29965.550516742704;30138.84930575333;30368.69631303747;30680.232994175323;42647;42911.78544107259;43456.34815477707;43540.78229608832;43597;308955;309883;313425;313998;314286;32846.67153328532;38823;39174.412383813695;39327;39747.60252397439;42298.577014230694;42459;42605.57394426016;43280;43334.34998474962;37123.628763713095;37336.253274933806;37488.625113748516;37615.81192094022;37758.81120594379;36446.27107457889;37189.44215836819;37259;37288.254234915694;37451.250974979805;35699.64300356963;36332.63667363292;36419.817900910326;36860.26279474449;37121.07197320089;31857;32882.1779455506;33043.66956330406;33591.83204083964;33631.66368336285;25280.747192528575;25382.619260710733;25444.491110178064;25614.87192564025;25993.480130397664 15:16:04 INFO - PROCESS | 17073 | |2;jquery.html;379.45548138421367;379.86324923027706;381.9369803982343;387.6666067182221;396.21351617040153;15584.273735112021;16312.91843540782;16788.160591970383;16803.831961680396;16810.15949202541;16159.919200403981;16487.505374838773;17428.912855435705;17448.651026979453;17456.603471722232;4786.688865223749;5027.371578552681;5052.4947505249365;5054;5065.214891691794;4964.4787297333805;4996.050750357439;5040.899182016357;5043.319151914499;5058.671186372892;4859.635527335447;4994.825181118662;5011.473795251501;5033.144365457881;5035.597152227831;4933.753312334405;5007.273945277932;5013.949860501403;5014.097462456756;5254.527092561688;5140.7172605506685;5156.690598564061;5164.974175129138;5170;5176.223566465061;11778.764424711459;13669.453221871114;20373.592528149504;20395.082221300076;20396.898015509974;1732.5322163015915;1825.3611236067402;1851.1022154255174;1852.3331600623765;1907.2847682119204;8437.620307086196;8768;9160.083991600854;9266;9336;1672.5902153972233;1684.7978242610843;1698.906560139192;1737.5742942978925;1811.112554848115;61984.69007654978;63998.68000660014;65163;65597;66117.66941165263;9663;10277.612522309393;10625.884282150417;10919.853415391428;10952.288101273392;13855;14074.2962851857;14146;14151.363188656534;14155.221462819438;6676.332366763382;6754.966225168842;6900.137482814648;6972.337627925339;7008.824779380557;6121.204243448412;6159.414855588712;6258.436740693269;6363.872722545523;6368.713407896656;4354.433923589913;4394.12117576486;4409.691321607456;4411.536788637211;4484;1721.7761690980092;1745.1099939030933;1777.8933264004202;1788.928442862297;1799.7570328005552;781.7263957614903;865.1651156633752;927.5733162745078;928.7817362919709;938;15725.842741572667;16521.173941302888;16889;16972.74540881888;17395.7390639138;851.6252848746532;881.0836729800935;889.9421537600035;967.7000129959735;975.6926568131016;9088.863667045;9431.90568094324;9532.809343813085;9541.61833526665;9785.559649815776;365606;368091;376814;378567;379103;54883.45116548863;69148;72781;74306;74537;855.3157474020759;881.9538670285006;885.4819930340694;891.1667590802621;892.1791951404723;11675.824862627238;14689.265536722907;15383.61540961485;15548.766768498255;15805.920970395075;25738.87130564335;35087.64912350844;35420.822895886384;35995.46006809952;36253.27493450064;42635.573644264405;46185;47340.52659473361;47755.52244477511;48410.75794621004;7106.111736032996;7260.382867456326;7341.816454588678;7374;7427.517211381243;7906.893034975223;7975.481593696623;10828.566857325619;10887.292325998786;11163.162762792985;8907.777305567413;8928.821423571622;8997.910020899708;9214.769630759285;9266.397684150777;4460.264056430653;7012.509124361246;8690.91309086901;9465.763355916157;9928.354656947275;8787.165219304155;8855.690050848189;8985.326100542356;9194.54027298619;9300.162985331353;6729.663516824237;6784.728610855511;6842.418394436529;7013.754518591825;7170.282971702788;8413.242808147295;8443.66225350979;8496.660133594587;8752.124787521452;9134.771630709285 15:16:04 INFO - PROCESS | 17073 | |3;mootools.html;1272.5736878145822;1421.673015206503;1454.1711224601977;1574.7716581095742;1767.1076106566181;6734.629595372253;7625.237476252379;7849.058113026431;7858.489198202113;8103.716369927054;7873.921260787405;8059.597020148998;8066.516009039447;8068.031836179666;8080.757577272691;2246.539459410821;2272.5454909018263;2272.9318120456414;2274.715660542432;2275.1468199425217;2172.641514150171;2195.1548653768336;2217.5675743230076;2218.9889050554725;2219.6892435059103;2181.3455963211054;2192.48476607997;2198.505336299336;2201.878896660683;2212.4911270407815;2147.5919575280645;2176.7170267865235;2178.237616834111;2179.825613950888;2181.5091604389045;2137.241279345825;2138.1233694185307;2140.4006878074165;2156.579467003935;2157.0832396231694;7654.196309387546;7894.131645519045;7914.366850651992;7977.3618110551015;7981.720639777638;4836;4970.329005584236;4973.005398920194;4976.377952755905;4980.950190498085;2911.5923770672125;3094.7833651644396;3138.0585824252635;3141.3141763792087;3143.654198038214;976.3702411944256;983.8179936711731;989.4656885281939;999.7300728803256;1009.7172791618359;10402.739931501697;10477.528511217013;10497.212709046775;10503.897090805433;10513.106385957126;4004.3993400989502;4255.170241802881;4256.063665993476;4257.127288905767;4260.339647354665;8380.078191398941;8415.452995555392;8416.621252043673;8425.831483370299;8430.452020618763;4626.3523106764405;4626.421697287839;4631.980964187874;4634.420697412824;4639.536046395334;3753.662170404622;3843.0584506795453;4225.809838557211;4294.957050429518;4307.956920430755;3441.7074548663645;3452.7410444216785;3524.964750352515;3529.4529347951107;3536.2397084626414;1051.3925464847068;1083.550326614462;1090.8854570270166;1093.3221402730358;1104.5195340027115;654.6726636681659;801.4069588504465;882.5851849630664;891.8350105230553;906.089380172922;5334.67991920486;5437.673739575638;5710.114932185518;5759.712014399263;5772.769089236467;399.048269876347;403.45936445163034;405.6511400195829;421.6647765026811;429.0624984409014;3749.1189570450924;3840.116773142193;3878.108035151931;3893.3575959966856;3898.2203559288255;9535.52322383878;9751.658691945748;9971.202303815677;10034.598616055277;10050.447225402528;9676.854847177297;9811.607535698493;9878.407295562289;9969.451680157661;9978.700638980843;6993.125859267591;7331.523450975669;7344;7459.440541959266;7524.473286869867;5657.12314591239;5761.251037365116;5834.15404766315;5906.734196961061;5917.792877249276;8661.523616200917;8822.07368226327;8862.291016718777;8875.201231889161;8902.910970890209;8858.11418858109;8978.551072446482;9045.77385565366;9208.861867071866;9334.159925606727;6924.792256232321;6931.514793964374;7043.401310888632;7118.5017048806085;7142.607156606437;7909.406794490551;7919.802004949692;8023.358131349595;8032.83934321322;8032.87950680752;6908.171019477494;6927.3419025192525;6995.195552511323;7061.6469176542;7110.182329032021;6844.28135045813;6896.793096207121;6899.586024838526;6996.790096296915;7005.194402643558;6589.670516474253;6612.23959244693;6613.272540020497;6774.051632771318;6782.118324617768;4725.40932383452;4865.70805751656;4894.559489645807;4915.139850526215;4926.48271931442;4767.427908650984;4774.689645173192;4805.927911081267;5012.448630650699;5146.125158722951 15:16:04 INFO - PROCESS | 17073 | |4;prototype.html;290.36410261527254;295.5625674002475;312.28486765307446;312.85921335399064;315.2921690804145;4617.8614641560725;4772.928406073903;4824.975875120619;4848.127337079324;4880.389951256093;4596.49438561758;4752.667313288071;4756.429228492586;4766.7378294193895;4782.426108866941;3808.447775072613;3816.656500914917;3825.751326163804;3830.7550046234946;3834.559025712051;3601.621829707882;3668.284684486526;3807.714421418391;3813.561440434344;3852.9614703852885;3780.7164462665273;3795.430685397199;3827.5598306194725;3834.060655139495;3840.5967373425806;3784.7161462890394;3791.7345785795005;3811.8094095295123;3839.5968423315708;3839.9808000959815;3399.5410619566287;3406.8466918988706;3406.9608769325346;3410.181556426465;3411.4541673332396;4537.795799189044;4582.6104781093645;4591.6097131743845;4592.219322715113;4598.609118224955;4260.1905637929;4275.503573749163;4287.742735435852;4299.634531064863;4352.194843953847;4977.626677999128;4992.151334273182;5003.474635163292;5007.574356179729;5043.344365232533;3582.8925132245813;3654.5979942206336;3657.359962006665;3667.431548110047;3695.3902606069964;5217.739113044333;5225.477452254782;5231.398389185254;5238.271370447743;5258.81594144207;3734.1598140418187;3735.1969326594913;3739.495168152319;3752.9061773455337;3789.109559253573;3650.6714395703984;3811.5235595550557;3812.961870381316;3813.9618603813606;3815.141593141521;4238.512571054306;4270.039241170712;4282.379055037064;4283.2932566126865;4293.8711838644895;4979.875503112451;5001.174806156943;5014.6991180529285;5019.598432125421;5057.873553161126;1257.8930790882694;1266.645339304996;1293.9611811645666;1315.9736805263842;1317.2820812657126;837.7570504553734;865.5845194306768;871.3203701113142;878.2622597018535;885.685581618529;3919.92160156801;3947.585503522146;3994.720369574102;4010.6590939770444;4032.536258330271;4607.401037865056;4611.723296602215;4612.238980568169;4654.348391225231;4655.557722016403;4042.5957404259925;4047.392891066305;4059.350503919418;4066.552679205285;4080.10237747695;2392.3301475586863;2499.187763976715;2508.41052352697;2515.735847735998;2523.3691577105724;4400.669949753781;4414.757188354607;4448.243798554254;4465.709728867678;4473.70262623842;4779.375012495768;4797.129119643342;4799.472058073609;4812.326274321597;4824.758762061883;4152.730072545275;4434.445694288214;4459.862735002618;4466;4473.619742321874;4583.289590113538;4652.116097941381;4660.906781864276;4680.438347398334;4690.390249267573;4512.684112112121;4566.611837993808;4569.588737013684;4581.358609794698;4596.2186428306595;4417.3214178611925;4437.38035617004;4454.866354009385;4520.706154099973;4931.2001119591805;3685.281370132798;3685.3182161299173;3718.9070273243387;3724.7206459516187;3730.198007428416;4928.507149285187;5186.4035635902355;5235.712035838065;5248.396434409939;5250.343707036621;4892.461829198856;5043.36957880265;5055.7472126392795;5056.494350564914;5075.5178258065425;5039.672421292605;5042.647014708935;5045.31888195089;5049.368828896388;5071.340725705634;4877.6829506081995;4987.301777751045;4992.925106123484;5012.649114561946;5016.344606279992;5067.69593824357;5086.059079070384;5091.796328146833;5121.385433747974;5124.180131178993;4993.80024799004;5006.849794506171;5009.574186194214;5015.774290157025;5023.723695196799 15:16:04 INFO - PROCESS | 17073 | |5;yui.html;565.2284631478033;612.3692596625476;708.1421448860817;716.4912911832598;742.0909386002148;11498.080153587714;12125;12127.514899404014;12140.575079872206;12141.332226727527;12373.50505979762;12381.07141964354;12384.071194660413;12406.069544784132;12411.689707757288;626.6302881300032;643.0964494884695;643.7135474713755;777.8755399136139;794.2097612875198;637.8373514753731;639.8656282180748;765.5138986743431;793.238491048594;795.459087820282;829.2660995019421;832.142892820393;834.04501845387;834.6160766047625;836.3852568362249;823.8558252305822;824.077033722229;824.2705205892798;824.530017889803;824.6289169873551;485.6042325504702;493.6273113799095;495.49459551257877;495.66294919454754;592.2005292854654;12115.757684846341;12172.878271217263;12533.060020498408;12538.623841284776;12583.119181657288;11779.469923853447;12216.450259738333;12224.755504889941;12583.433745481476;12599.811002834966;11256.73554669145;11296.661100167008;11297.548098076068;11300.208985371028;11339.262947908443;4002.8598999034893;4005.218982298453;4082.346824508094;4106.938395924063;4150.896227594334;46384.7680761594;48684;48750.26874596884;48901.75549122267;49002.26496602554;9730.12428881404;9832.164266037324;9858.80282394348;9915.405075695482;10392.06471417576;18137.546561336072;18289.908550457163;18291.176897039666;18295.72556411655;18371;6742.407366154342;6775.830604234835;6778.796636100925;6934.895976560356;6958.547694399847;3696.519452471215;3711.1464363196615;3725.8509659613856;3748.9625103748613;3755.5681096674234;2835.5746638004466;2906.055531952124;2913.606663100454;2914.0383673387732;2914.635670541182;519.1641457253818;525.4010428111956;536.8523655994633;539.7975759090341;547.5099785691863;413.88204361756755;450.07734145002615;466.1446246138374;470.8705106095783;474.67484772929964;7537.4723769336715;7667.504836556818;7823;7873;8056.677732890736;472.95622428238426;600.9879802403927;607.5595193484777;627.9120923070774;628.9088082228051;3643.7267204959735;3653.06846754076;3653.762505437138;3655.926881462356;3703.0372103252807;59656;59971.700141499015;60172.39827601668;61690;62653;50037.74981125071;50074.49925500698;50181.24728129008;54208.728956354964;54859.72570137124;45088.999999999345;45187.77406112949;45246.32130518045;45990.540094599295;47080.29379559309;8029.277365037175;8157;8193.221643943816;8230.62962166692;8276.131006244257;31598.526022110145;32206.838965805957;32411.35177296488;32504.83747581247;32856.50715239321;42511.362329564465;42520;42558.57441425546;42928.35607465953;43144.56855431531;10053.346532475365;10118.494075296352;10191.898081019095;10690.465476726287;10707.732306692395;11095.389753563308;11142.331460112418;11255.268407553483;11401.087912967108;11878.940605296919;10366.170706343626;10541.262111652111;10610.310329828537;10729.302595331279;10958.780824383308;10618.256722029693;10692;11033.724156896142;11106.777864442503;11173.329600224013;10468.214883883587;10506.106980906403;10566.524506397076;11027.944860275647;11119.221654484109;8915.153060459246;9145.451272923647;9321.394109382869;9353;9742.025797420201;9154.954225228832;9182.908170918472;9290.046733618268;9345.15893569582;9458.43249405038 15:16:04 INFO - PROCESS | 17073 | __end_tp_report 15:16:04 INFO - PROCESS | 17073 | __start_cc_report 15:16:04 INFO - PROCESS | 17073 | _x_x_mozilla_cycle_collect,919 15:16:04 INFO - PROCESS | 17073 | __end_cc_report 15:16:04 INFO - PROCESS | 17073 | __startTimestamp1464387364307__endTimestamp 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | ------- Summary: start ------- 15:16:04 INFO - PROCESS | 17073 | Number of tests: 6 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#0] dojo.html Cycles:165 Average:4778.97 Median:4895.24 stddev:511.20 (10.4%) stddev-sans-first:485.96 15:16:04 INFO - PROCESS | 17073 | Values: 2696.2 2709.5 2725.0 2746.1 2772.7 4703.1 4750.5 4791.0 4818.8 4869.2 4806.0 4813.2 4870.8 4878.8 4884.2 4392.5 4396.4 4451.6 4523.7 4597.1 4513.3 4545.0 4563.0 4568.9 4584.5 4324.2 4363.5 4371.6 4436.2 4457.7 4377.7 4378.7 4386.9 4447.6 4466.0 4444.9 4450.5 4452.8 4506.1 4507.7 4597.8 4669.2 4745.8 4754.6 4758.5 5253.2 5266.1 5267.7 5269.9 5273.1 5226.2 5266.1 5306.6 5319.5 5324.5 4725.3 4832.2 4894.7 4907.7 4908.1 5333.9 5369.3 5376.1 5389.5 5391.1 4978.3 5153.7 5164.1 5166.3 5172.2 5109.2 5113.3 5135.8 5155.9 5170.9 5105.8 5127.6 5134.7 5137.7 5188.5 4978.9 4992.5 5125.9 5140.2 5145.2 4291.5 4295.9 4310.2 4354.6 4358.1 3770.8 3778.3 3782.7 3803.2 3817.5 4309.4 4356.8 4394.1 4394.4 4431.2 5087.7 5089.4 5146.3 5161.1 5177.4 4409.1 4421.8 4426.9 4474.8 4479.0 4512.2 4573.7 4599.2 4617.6 4622.2 4848.6 4877.9 4880.2 4915.8 4920.7 5181.1 5182.3 5187.7 5193.8 5198.3 4718.6 4832.4 4876.1 4877.5 4893.8 5106.6 5119.5 5136.1 5144.5 5186.0 5210.9 5217.1 5226.3 5231.1 5231.6 4895.2 4981.7 5030.5 5040.0 5050.4 5019.9 5055.1 5057.5 5058.7 5109.4 4837.0 4988.2 5001.0 5004.8 5050.6 5041.5 5077.7 5095.9 5103.9 5118.8 5001.7 5002.8 5012.3 5023.8 5064.2 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#1] ext.html Cycles:180 Average:50451.53 Median:38956.30 stddev:95604.12 (245.4%) stddev-sans-first:95799.05 15:16:04 INFO - PROCESS | 17073 | Values: 599.5 599.7 601.8 608.2 614.2 26760.9 29763.4 40202.4 41344.2 41460.2 41805.2 42073.8 42168.4 42173.0 42323.8 7668.1 7834.5 7840.9 7849.9 7851.5 7636.2 7751.7 7754.3 7759.0 7760.4 7769.3 7787.9 7799.0 7805.7 7820.0 7718.1 7752.3 7760.0 7762.2 7786.5 7649.6 7791.1 7806.0 7806.9 7809.6 38707.0 39089.6 39107.0 39183.4 39221.8 3022.3 3029.3 3033.4 3204.9 3356.1 28220.2 28265.0 29138.3 29352.9 29770.3 3472.7 3517.8 3539.2 3550.8 3551.8 263701.0 265648.0 266249.0 266687.0 266916.0 55962.6 56399.0 56528.0 56577.4 56669.1 50959.0 56559.7 58203.7 58502.0 64092.0 13165.5 13411.3 13417.3 13423.8 13426.9 8981.1 9966.0 10056.7 10058.6 10061.6 18016.5 18260.4 18622.9 19016.4 19186.6 6696.9 6908.9 6964.7 7082.3 7125.4 737.3 825.9 857.9 935.0 951.5 27959.3 28608.7 28763.7 28966.9 29277.9 862.3 953.5 960.6 1021.6 1029.8 15096.4 15134.4 15218.8 15412.5 15444.4 388192.0 422684.0 429276.0 429432.0 642816.0 48038.3 48169.3 48621.3 54404.2 54464.5 1119.6 1182.1 1216.0 1219.4 1237.5 26056.2 29965.6 30138.8 30368.7 30680.2 42647.0 42911.8 43456.3 43540.8 43597.0 308955.0 309883.0 313425.0 313998.0 314286.0 32846.7 38823.0 39174.4 39327.0 39747.6 42298.6 42459.0 42605.6 43280.0 43334.3 37123.6 37336.3 37488.6 37615.8 37758.8 36446.3 37189.4 37259.0 37288.3 37451.3 35699.6 36332.6 36419.8 36860.3 37121.1 31857.0 32882.2 33043.7 33591.8 33631.7 25280.7 25382.6 25444.5 25614.9 25993.5 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#2] jquery.html Cycles:180 Average:22843.78 Median:5038.25 stddev:61582.40 (1222.3%) stddev-sans-first:61732.06 15:16:04 INFO - PROCESS | 17073 | Values: 379.5 379.9 381.9 387.7 396.2 15584.3 16312.9 16788.2 16803.8 16810.2 16159.9 16487.5 17428.9 17448.7 17456.6 4786.7 5027.4 5052.5 5054.0 5065.2 4964.5 4996.1 5040.9 5043.3 5058.7 4859.6 4994.8 5011.5 5033.1 5035.6 4933.8 5007.3 5013.9 5014.1 5254.5 5140.7 5156.7 5165.0 5170.0 5176.2 11778.8 13669.5 20373.6 20395.1 20396.9 1732.5 1825.4 1851.1 1852.3 1907.3 8437.6 8768.0 9160.1 9266.0 9336.0 1672.6 1684.8 1698.9 1737.6 1811.1 61984.7 63998.7 65163.0 65597.0 66117.7 9663.0 10277.6 10625.9 10919.9 10952.3 13855.0 14074.3 14146.0 14151.4 14155.2 6676.3 6755.0 6900.1 6972.3 7008.8 6121.2 6159.4 6258.4 6363.9 6368.7 4354.4 4394.1 4409.7 4411.5 4484.0 1721.8 1745.1 1777.9 1788.9 1799.8 781.7 865.2 927.6 928.8 938.0 15725.8 16521.2 16889.0 16972.7 17395.7 851.6 881.1 889.9 967.7 975.7 9088.9 9431.9 9532.8 9541.6 9785.6 365606.0 368091.0 376814.0 378567.0 379103.0 54883.5 69148.0 72781.0 74306.0 74537.0 855.3 882.0 885.5 891.2 892.2 11675.8 14689.3 15383.6 15548.8 15805.9 25738.9 35087.6 35420.8 35995.5 36253.3 42635.6 46185.0 47340.5 47755.5 48410.8 7106.1 7260.4 7341.8 7374.0 7427.5 7906.9 7975.5 10828.6 10887.3 11163.2 8907.8 8928.8 8997.9 9214.8 9266.4 4460.3 7012.5 8690.9 9465.8 9928.4 8787.2 8855.7 8985.3 9194.5 9300.2 6729.7 6784.7 6842.4 7013.8 7170.3 8413.2 8443.7 8496.7 8752.1 9134.8 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#3] mootools.html Cycles:180 Average:5231.27 Median:4996.70 stddev:2912.71 (58.3%) stddev-sans-first:2905.68 15:16:04 INFO - PROCESS | 17073 | Values: 1272.6 1421.7 1454.2 1574.8 1767.1 6734.6 7625.2 7849.1 7858.5 8103.7 7873.9 8059.6 8066.5 8068.0 8080.8 2246.5 2272.5 2272.9 2274.7 2275.1 2172.6 2195.2 2217.6 2219.0 2219.7 2181.3 2192.5 2198.5 2201.9 2212.5 2147.6 2176.7 2178.2 2179.8 2181.5 2137.2 2138.1 2140.4 2156.6 2157.1 7654.2 7894.1 7914.4 7977.4 7981.7 4836.0 4970.3 4973.0 4976.4 4981.0 2911.6 3094.8 3138.1 3141.3 3143.7 976.4 983.8 989.5 999.7 1009.7 10402.7 10477.5 10497.2 10503.9 10513.1 4004.4 4255.2 4256.1 4257.1 4260.3 8380.1 8415.5 8416.6 8425.8 8430.5 4626.4 4626.4 4632.0 4634.4 4639.5 3753.7 3843.1 4225.8 4295.0 4308.0 3441.7 3452.7 3525.0 3529.5 3536.2 1051.4 1083.6 1090.9 1093.3 1104.5 654.7 801.4 882.6 891.8 906.1 5334.7 5437.7 5710.1 5759.7 5772.8 399.0 403.5 405.7 421.7 429.1 3749.1 3840.1 3878.1 3893.4 3898.2 9535.5 9751.7 9971.2 10034.6 10050.4 9676.9 9811.6 9878.4 9969.5 9978.7 6993.1 7331.5 7344.0 7459.4 7524.5 5657.1 5761.3 5834.2 5906.7 5917.8 8661.5 8822.1 8862.3 8875.2 8902.9 8858.1 8978.6 9045.8 9208.9 9334.2 6924.8 6931.5 7043.4 7118.5 7142.6 7909.4 7919.8 8023.4 8032.8 8032.9 6908.2 6927.3 6995.2 7061.6 7110.2 6844.3 6896.8 6899.6 6996.8 7005.2 6589.7 6612.2 6613.3 6774.1 6782.1 4725.4 4865.7 4894.6 4915.1 4926.5 4767.4 4774.7 4805.9 5012.4 5146.1 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#4] prototype.html Cycles:180 Average:4077.32 Median:4469.81 stddev:1160.22 (26.0%) stddev-sans-first:1128.12 15:16:04 INFO - PROCESS | 17073 | Values: 290.4 295.6 312.3 312.9 315.3 4617.9 4772.9 4825.0 4848.1 4880.4 4596.5 4752.7 4756.4 4766.7 4782.4 3808.4 3816.7 3825.8 3830.8 3834.6 3601.6 3668.3 3807.7 3813.6 3853.0 3780.7 3795.4 3827.6 3834.1 3840.6 3784.7 3791.7 3811.8 3839.6 3840.0 3399.5 3406.8 3407.0 3410.2 3411.5 4537.8 4582.6 4591.6 4592.2 4598.6 4260.2 4275.5 4287.7 4299.6 4352.2 4977.6 4992.2 5003.5 5007.6 5043.3 3582.9 3654.6 3657.4 3667.4 3695.4 5217.7 5225.5 5231.4 5238.3 5258.8 3734.2 3735.2 3739.5 3752.9 3789.1 3650.7 3811.5 3813.0 3814.0 3815.1 4238.5 4270.0 4282.4 4283.3 4293.9 4979.9 5001.2 5014.7 5019.6 5057.9 1257.9 1266.6 1294.0 1316.0 1317.3 837.8 865.6 871.3 878.3 885.7 3919.9 3947.6 3994.7 4010.7 4032.5 4607.4 4611.7 4612.2 4654.3 4655.6 4042.6 4047.4 4059.4 4066.6 4080.1 2392.3 2499.2 2508.4 2515.7 2523.4 4400.7 4414.8 4448.2 4465.7 4473.7 4779.4 4797.1 4799.5 4812.3 4824.8 4152.7 4434.4 4459.9 4466.0 4473.6 4583.3 4652.1 4660.9 4680.4 4690.4 4512.7 4566.6 4569.6 4581.4 4596.2 4417.3 4437.4 4454.9 4520.7 4931.2 3685.3 3685.3 3718.9 3724.7 3730.2 4928.5 5186.4 5235.7 5248.4 5250.3 4892.5 5043.4 5055.7 5056.5 5075.5 5039.7 5042.6 5045.3 5049.4 5071.3 4877.7 4987.3 4992.9 5012.6 5016.3 5067.7 5086.1 5091.8 5121.4 5124.2 4993.8 5006.8 5009.6 5015.8 5023.7 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - PROCESS | 17073 | [#5] yui.html Cycles:180 Average:13499.86 Median:45618.43 stddev:16105.59 (35.3%) stddev-sans-first:16121.48 15:16:04 INFO - PROCESS | 17073 | Values: 565.2 612.4 708.1 716.5 742.1 11498.1 12125.0 12127.5 12140.6 12141.3 12373.5 12381.1 12384.1 12406.1 12411.7 626.6 643.1 643.7 777.9 794.2 637.8 639.9 765.5 793.2 795.5 829.3 832.1 834.0 834.6 836.4 823.9 824.1 824.3 824.5 824.6 485.6 493.6 495.5 495.7 592.2 12115.8 12172.9 12533.1 12538.6 12583.1 11779.5 12216.5 12224.8 12583.4 12599.8 11256.7 11296.7 11297.5 11300.2 11339.3 4002.9 4005.2 4082.3 4106.9 4150.9 46384.8 48684.0 48750.3 48901.8 49002.3 9730.1 9832.2 9858.8 9915.4 10392.1 18137.5 18289.9 18291.2 18295.7 18371.0 6742.4 6775.8 6778.8 6934.9 6958.5 3696.5 3711.1 3725.9 3749.0 3755.6 2835.6 2906.1 2913.6 2914.0 2914.6 519.2 525.4 536.9 539.8 547.5 413.9 450.1 466.1 470.9 474.7 7537.5 7667.5 7823.0 7873.0 8056.7 473.0 601.0 607.6 627.9 628.9 3643.7 3653.1 3653.8 3655.9 3703.0 59656.0 59971.7 60172.4 61690.0 62653.0 50037.7 50074.5 50181.2 54208.7 54859.7 45089.0 45187.8 45246.3 45990.5 47080.3 8029.3 8157.0 8193.2 8230.6 8276.1 31598.5 32206.8 32411.4 32504.8 32856.5 42511.4 42520.0 42558.6 42928.4 43144.6 10053.3 10118.5 10191.9 10690.5 10707.7 11095.4 11142.3 11255.3 11401.1 11878.9 10366.2 10541.3 10610.3 10729.3 10958.8 10618.3 10692.0 11033.7 11106.8 11173.3 10468.2 10506.1 10566.5 11027.9 11119.2 8915.2 9145.5 9321.4 9353.0 9742.0 9155.0 9182.9 9290.0 9345.2 9458.4 15:16:04 INFO - PROCESS | 17073 | -------- Summary: end -------- 15:16:04 INFO - PROCESS | 17073 | 15:16:04 INFO - TEST-INFO | 17073: exit 0 15:16:04 INFO - TEST-OK | dromaeo_css | took 1118668ms 15:16:04 INFO - TEST-START | kraken 15:16:04 INFO - operating with platform_type : linux_ 15:16:04 INFO - Initialising browser for kraken test... 15:16:04 INFO - TEST-INFO | started process 17263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcliDl/profile http://localhost:42591/getInfo.html) 15:16:09 INFO - PROCESS | 17263 | __metrics Screen width/height:1600/1200 15:16:09 INFO - PROCESS | 17263 | colorDepth:24 15:16:09 INFO - PROCESS | 17263 | Browser inner width/height: 1024/697 15:16:09 INFO - PROCESS | 17263 | __metrics 15:16:10 ERROR - PROCESS | 17263 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:16:11 INFO - TEST-INFO | 17263: exit 0 15:16:11 INFO - Browser initialized. 15:16:11 INFO - Running cycle 1/1 for kraken test... 15:16:11 INFO - TEST-INFO | started process 17342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcliDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:23 INFO - PROCESS | 17342 | RSS: Main: 157044736 15:16:23 INFO - PROCESS | 17342 | 15:16:26 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42591/tests/kraken/driver.html?testName=audio-beat-detection) 15:16:26 INFO - PROCESS | 17342 | RSS: Main: 214650880 15:16:26 INFO - PROCESS | 17342 | 15:16:29 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42591/tests/kraken/driver.html?testName=audio-dft) 15:16:30 INFO - PROCESS | 17342 | RSS: Main: 204185600 15:16:30 INFO - PROCESS | 17342 | 15:16:33 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42591/tests/kraken/driver.html?testName=audio-fft) 15:16:34 INFO - PROCESS | 17342 | RSS: Main: 269385728 15:16:34 INFO - PROCESS | 17342 | 15:16:36 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42591/tests/kraken/driver.html?testName=audio-oscillator) 15:16:37 INFO - PROCESS | 17342 | RSS: Main: 181067776 15:16:37 INFO - PROCESS | 17342 | 15:16:39 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:16:39 INFO - PROCESS | 17342 | RSS: Main: 183697408 15:16:39 INFO - PROCESS | 17342 | 15:16:43 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42591/tests/kraken/driver.html?testName=imaging-darkroom) 15:16:43 INFO - PROCESS | 17342 | RSS: Main: 220299264 15:16:43 INFO - PROCESS | 17342 | 15:16:47 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42591/tests/kraken/driver.html?testName=imaging-desaturate) 15:16:47 INFO - PROCESS | 17342 | RSS: Main: 216424448 15:16:47 INFO - PROCESS | 17342 | 15:16:50 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42591/tests/kraken/driver.html?testName=json-parse-financial) 15:16:51 INFO - PROCESS | 17342 | RSS: Main: 219045888 15:16:51 INFO - PROCESS | 17342 | 15:16:53 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:16:53 INFO - PROCESS | 17342 | RSS: Main: 206766080 15:16:53 INFO - PROCESS | 17342 | 15:16:55 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:16:56 INFO - PROCESS | 17342 | RSS: Main: 210526208 15:16:56 INFO - PROCESS | 17342 | 15:16:58 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:16:59 INFO - PROCESS | 17342 | RSS: Main: 216072192 15:16:59 INFO - PROCESS | 17342 | 15:17:01 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:02 INFO - PROCESS | 17342 | RSS: Main: 220110848 15:17:02 INFO - PROCESS | 17342 | 15:17:05 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:05 INFO - PROCESS | 17342 | RSS: Main: 220282880 15:17:05 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | Cycle 1(1): loaded http://localhost:42591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42591/tests/kraken/driver.html?testName=ai-astar) 15:17:07 INFO - PROCESS | 17342 | RSS: Main: 262152192 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | __start_tp_report 15:17:07 INFO - PROCESS | 17342 | _x_x_mozilla_page_load 15:17:07 INFO - PROCESS | 17342 | _x_x_mozilla_page_load_details 15:17:07 INFO - PROCESS | 17342 | |i|pagename|runs| 15:17:07 INFO - PROCESS | 17342 | |0;ai-astar;112;109;113;114;113;112;114;114;113;113 15:17:07 INFO - PROCESS | 17342 | |1;audio-beat-detection;165;129;132;165;137;149;150;134;197;129 15:17:07 INFO - PROCESS | 17342 | |2;audio-dft;162;162;162;170;161;162;161;161;161;161 15:17:07 INFO - PROCESS | 17342 | |3;audio-fft;75;76;76;118;76;77;75;75;123;75 15:17:07 INFO - PROCESS | 17342 | |4;audio-oscillator;83;84;129;83;84;84;118;85;84;120 15:17:07 INFO - PROCESS | 17342 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;116;116;116 15:17:07 INFO - PROCESS | 17342 | |6;imaging-darkroom;146;148;146;146;146;148;145;146;146;147 15:17:07 INFO - PROCESS | 17342 | |7;imaging-desaturate;95;96;96;96;96;95;96;95;95;95 15:17:07 INFO - PROCESS | 17342 | |8;json-parse-financial;64;63;65;63;64;62;63;62;63;64 15:17:07 INFO - PROCESS | 17342 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;65;65;64 15:17:07 INFO - PROCESS | 17342 | |10;stanford-crypto-aes;90;83;82;82;89;83;88;84;115;89 15:17:07 INFO - PROCESS | 17342 | |11;stanford-crypto-ccm;134;128;144;129;127;130;127;136;132;142 15:17:07 INFO - PROCESS | 17342 | |12;stanford-crypto-pbkdf2;172;173;173;167;169;168;167;167;165;170 15:17:07 INFO - PROCESS | 17342 | |13;stanford-crypto-sha256-iterative;68;68;66;67;67;64;66;65;65;66 15:17:07 INFO - PROCESS | 17342 | __end_tp_report 15:17:07 INFO - PROCESS | 17342 | __start_cc_report 15:17:07 INFO - PROCESS | 17342 | _x_x_mozilla_cycle_collect,1910 15:17:07 INFO - PROCESS | 17342 | __end_cc_report 15:17:07 INFO - PROCESS | 17342 | __startTimestamp1464387427944__endTimestamp 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | ------- Summary: start ------- 15:17:07 INFO - PROCESS | 17342 | Number of tests: 14 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.49 (1.3%) stddev-sans-first:1.56 15:17:07 INFO - PROCESS | 17342 | Values: 112.0 109.0 113.0 114.0 113.0 112.0 114.0 114.0 113.0 113.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:149.50 stddev:21.79 (14.6%) stddev-sans-first:22.30 15:17:07 INFO - PROCESS | 17342 | Values: 165.0 129.0 132.0 165.0 137.0 149.0 150.0 134.0 197.0 129.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 15:17:07 INFO - PROCESS | 17342 | Values: 162.0 162.0 162.0 170.0 161.0 162.0 161.0 161.0 161.0 161.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.50 stddev:18.97 (25.1%) stddev-sans-first:19.80 15:17:07 INFO - PROCESS | 17342 | Values: 75.0 76.0 76.0 118.0 76.0 77.0 75.0 75.0 123.0 75.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.80 (22.4%) stddev-sans-first:19.40 15:17:07 INFO - PROCESS | 17342 | Values: 83.0 84.0 129.0 83.0 84.0 84.0 118.0 85.0 84.0 120.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 15:17:07 INFO - PROCESS | 17342 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:17:07 INFO - PROCESS | 17342 | Values: 146.0 148.0 146.0 146.0 146.0 148.0 145.0 146.0 146.0 147.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:17:07 INFO - PROCESS | 17342 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 15:17:07 INFO - PROCESS | 17342 | Values: 64.0 63.0 65.0 63.0 64.0 62.0 63.0 62.0 63.0 64.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 15:17:07 INFO - PROCESS | 17342 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:86.00 stddev:9.83 (11.4%) stddev-sans-first:10.42 15:17:07 INFO - PROCESS | 17342 | Values: 90.0 83.0 82.0 82.0 89.0 83.0 88.0 84.0 115.0 89.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:133.00 stddev:6.10 (4.6%) stddev-sans-first:6.46 15:17:07 INFO - PROCESS | 17342 | Values: 134.0 128.0 144.0 129.0 127.0 130.0 127.0 136.0 132.0 142.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:2.81 (1.7%) stddev-sans-first:2.77 15:17:07 INFO - PROCESS | 17342 | Values: 172.0 173.0 173.0 167.0 169.0 168.0 167.0 167.0 165.0 170.0 15:17:07 INFO - PROCESS | 17342 | 15:17:07 INFO - PROCESS | 17342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.22 15:17:07 INFO - PROCESS | 17342 | Values: 68.0 68.0 66.0 67.0 67.0 64.0 66.0 65.0 65.0 66.0 15:17:07 INFO - PROCESS | 17342 | -------- Summary: end -------- 15:17:07 INFO - PROCESS | 17342 | 15:17:08 INFO - TEST-INFO | 17342: exit 0 15:17:08 INFO - TEST-OK | kraken | took 64030ms 15:17:08 INFO - SUITE-END | took 1182s 15:17:09 INFO - Completed test suite (00:19:42) 15:17:09 INFO - javascript benchmark 15:17:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2696.191142657203, 2709.512287788197, 2724.9727502724977, 2746.080063178835, 2772.708865569115, 4703.106409782139, 4750.501197374273, 4791.0, 4818.759062046896, 4869.245266983615, 4805.975970120145, 4813.205821039524, 4870.780814863331, 4878.756062196885, 4884.169691152504, 4392.538783427742, 4396.36252743352, 4451.577100175478, 4523.705959112664, 4597.057603191354, 4513.255312873372, 4545.045540436512, 4562.977185114087, 4568.908621827578, 4584.472785629645, 4324.243257429937, 4363.47638283408, 4371.562843715635, 4436.179306828247, 4457.665675074366, 4377.737335759864, 4378.737275763432, 4386.934195987063, 4447.644188464915, 4466.0, 4444.933326000112, 4450.46594408673, 4452.844150454718, 4506.053728716974, 4507.661925355578, 4597.839075632371, 4669.229577119771, 4745.83389581363, 4754.595859351959, 4758.547937945889, 5253.238280449352, 5266.078436273637, 5267.736613169326, 5269.894602107975, 5273.129933560957, 5226.216067589854, 5266.104762190437, 5306.602004849652, 5319.494648008433, 5324.467553244684, 4725.29120631908, 4832.226843704991, 4894.657373983858, 4907.705537667752, 4908.11653902301, 5333.86665333362, 5369.328833895763, 5376.139817629239, 5389.487998640123, 5391.083515802323, 4978.303037574742, 5153.665011774297, 5164.147915593885, 5166.250893620404, 5172.224166375074, 5109.20807274873, 5113.309703190096, 5135.845924622267, 5155.922661160085, 5170.948290517047, 5105.795768169306, 5127.6154288428515, 5134.666246693953, 5137.717425541631, 5188.455212202664, 4978.90042199154, 4992.500749925051, 5125.8718532037, 5140.151874940593, 5145.176771716508, 4291.463567054118, 4295.892602684958, 4310.181065597527, 4354.608085272277, 4358.128374325148, 3770.792606406619, 3778.301014312361, 3782.6973842093116, 3803.1633040730994, 3817.4846395736777, 4309.375140604658, 4356.803943822536, 4394.055278115221, 4394.428724265825, 4431.180231657154, 5087.669301495391, 5089.440161582223, 5146.30524879144, 5161.096808058574, 5177.352830896138, 4409.052053808383, 4421.756803375781, 4426.911461770746, 4474.753888536162, 4479.014616784368, 4512.165249428866, 4573.679842411066, 4599.241125214302, 4617.561331673485, 4622.214223581999, 4848.5636292733825, 4877.853664390074, 4880.243562247857, 4915.803367865316, 4920.72935988524, 5181.145111056633, 5182.274481572507, 5187.714675692722, 5193.766280517461, 5198.272241886063, 4718.551737584924, 4832.395950506187, 4876.097921884463, 4877.517152552392, 4893.755312234445, 5106.617003724661, 5119.46245644202, 5136.101182293009, 5144.485551444825, 5185.974070129625, 5210.921836172536, 5217.139172036572, 5226.320578324793, 5231.136862417658, 5231.633785634969, 4895.241237608177, 4981.651284410056, 5030.471800461045, 5040.042391945519, 5050.419201791841, 5019.924701129413, 5055.115354812967, 5057.494250574913, 5058.671186372874, 5109.412417571878, 4836.95163048365, 4988.152014157675, 5001.049800537886, 5004.799808007784, 5050.570701490415, 5041.495850414929, 5077.7461126944245, 5095.87260318495, 5103.948960510495, 5118.769655365443, 5001.749912504433, 5002.774875130555, 5012.273220383097, 5023.7739301732245, 5064.240363945438], "value": 4746.136275985282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.5473417569734, 599.6701814002299, 601.8495376155961, 608.1880689279811, 614.2260751453169, 26760.86619566902, 29763.40473190535, 40202.396964045525, 41344.17311653773, 41460.17079658413, 41805.16389672205, 42073.789631051804, 42168.36747448783, 42173.0, 42323.788381058126, 7668.079830420357, 7834.490758100734, 7840.882386764203, 7849.882251766228, 7851.45039847211, 7636.236376362347, 7751.728689495869, 7754.263344982218, 7758.961205193966, 7760.417968652346, 7769.2619201176085, 7787.922120778805, 7799.0, 7805.726799562017, 7819.98340215774, 7718.073831140243, 7752.26353496417, 7760.029996250469, 7762.184970578092, 7786.4938778979185, 7649.617519124077, 7791.10402303731, 7806.0, 7806.882896756553, 7809.570473623949, 38707.0, 39089.60910390888, 39107.0, 39183.41224881601, 39221.80389098065, 3022.2897619059504, 3029.2578318311935, 3033.4084853453587, 3204.871805127792, 3356.110630682871, 28220.15339539817, 28265.0, 29138.271543211376, 29352.8532357339, 29770.255743606365, 3472.70482009027, 3517.8065206413635, 3539.2213712983103, 3550.804705741183, 3551.804650744208, 263701.0, 265648.0, 266249.0, 266687.0, 266916.0, 55962.60093497695, 56399.0, 56528.0, 56577.43422565804, 56669.14996275059, 50959.0, 56559.71720141373, 58203.70898145482, 58502.0, 64092.0, 13165.53920612774, 13411.262380569162, 13417.25575675156, 13423.798643020362, 13426.932865335611, 8981.14679105484, 9965.950170249102, 10056.69829905104, 10058.597656093674, 10061.64784232563, 18016.459506214833, 18260.36088736888, 18622.906885465756, 19016.42950711453, 19186.616267674846, 6696.933030669728, 6908.861822763517, 6964.651767411609, 7082.256363081905, 7125.394341481032, 737.3032484302283, 825.8802473641289, 857.9013413457533, 934.9672761453317, 951.4909523404945, 27959.301017474318, 28608.71391286102, 28763.712362876104, 28966.855165724035, 29277.85361073181, 862.2799962031648, 953.4755884263627, 960.6061514778908, 1021.581151727788, 1029.8249297619423, 15096.39614415411, 15134.394624215129, 15218.847811521964, 15412.537623871302, 15444.382224710886, 388192.0, 422684.0, 429276.0, 429432.0, 642816.0, 48038.27942580864, 48169.277460838115, 48621.270680939815, 54404.183937240974, 54464.45535544673, 1119.6193294279822, 1182.1193211057816, 1215.9513619455122, 1219.3842109734528, 1237.5111830826952, 26056.218313450627, 29965.550516742704, 30138.84930575333, 30368.69631303747, 30680.232994175323, 42647.0, 42911.78544107259, 43456.34815477707, 43540.78229608832, 43597.0, 308955.0, 309883.0, 313425.0, 313998.0, 314286.0, 32846.67153328532, 38823.0, 39174.412383813695, 39327.0, 39747.60252397439, 42298.577014230694, 42459.0, 42605.57394426016, 43280.0, 43334.34998474962, 37123.628763713095, 37336.253274933806, 37488.625113748516, 37615.81192094022, 37758.81120594379, 36446.27107457889, 37189.44215836819, 37259.0, 37288.254234915694, 37451.250974979805, 35699.64300356963, 36332.63667363292, 36419.817900910326, 36860.26279474449, 37121.07197320089, 31857.0, 32882.1779455506, 33043.66956330406, 33591.83204083964, 33631.66368336285, 25280.747192528575, 25382.619260710733, 25444.491110178064, 25614.87192564025, 25993.480130397664], "value": 17932.32476075402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.45548138421367, 379.86324923027706, 381.9369803982343, 387.6666067182221, 396.21351617040153, 15584.273735112021, 16312.91843540782, 16788.160591970383, 16803.831961680396, 16810.15949202541, 16159.919200403981, 16487.505374838773, 17428.912855435705, 17448.651026979453, 17456.603471722232, 4786.688865223749, 5027.371578552681, 5052.4947505249365, 5054.0, 5065.214891691794, 4964.4787297333805, 4996.050750357439, 5040.899182016357, 5043.319151914499, 5058.671186372892, 4859.635527335447, 4994.825181118662, 5011.473795251501, 5033.144365457881, 5035.597152227831, 4933.753312334405, 5007.273945277932, 5013.949860501403, 5014.097462456756, 5254.527092561688, 5140.7172605506685, 5156.690598564061, 5164.974175129138, 5170.0, 5176.223566465061, 11778.764424711459, 13669.453221871114, 20373.592528149504, 20395.082221300076, 20396.898015509974, 1732.5322163015915, 1825.3611236067402, 1851.1022154255174, 1852.3331600623765, 1907.2847682119204, 8437.620307086196, 8768.0, 9160.083991600854, 9266.0, 9336.0, 1672.5902153972233, 1684.7978242610843, 1698.906560139192, 1737.5742942978925, 1811.112554848115, 61984.69007654978, 63998.68000660014, 65163.0, 65597.0, 66117.66941165263, 9663.0, 10277.612522309393, 10625.884282150417, 10919.853415391428, 10952.288101273392, 13855.0, 14074.2962851857, 14146.0, 14151.363188656534, 14155.221462819438, 6676.332366763382, 6754.966225168842, 6900.137482814648, 6972.337627925339, 7008.824779380557, 6121.204243448412, 6159.414855588712, 6258.436740693269, 6363.872722545523, 6368.713407896656, 4354.433923589913, 4394.12117576486, 4409.691321607456, 4411.536788637211, 4484.0, 1721.7761690980092, 1745.1099939030933, 1777.8933264004202, 1788.928442862297, 1799.7570328005552, 781.7263957614903, 865.1651156633752, 927.5733162745078, 928.7817362919709, 938.0, 15725.842741572667, 16521.173941302888, 16889.0, 16972.74540881888, 17395.7390639138, 851.6252848746532, 881.0836729800935, 889.9421537600035, 967.7000129959735, 975.6926568131016, 9088.863667045, 9431.90568094324, 9532.809343813085, 9541.61833526665, 9785.559649815776, 365606.0, 368091.0, 376814.0, 378567.0, 379103.0, 54883.45116548863, 69148.0, 72781.0, 74306.0, 74537.0, 855.3157474020759, 881.9538670285006, 885.4819930340694, 891.1667590802621, 892.1791951404723, 11675.824862627238, 14689.265536722907, 15383.61540961485, 15548.766768498255, 15805.920970395075, 25738.87130564335, 35087.64912350844, 35420.822895886384, 35995.46006809952, 36253.27493450064, 42635.573644264405, 46185.0, 47340.52659473361, 47755.52244477511, 48410.75794621004, 7106.111736032996, 7260.382867456326, 7341.816454588678, 7374.0, 7427.517211381243, 7906.893034975223, 7975.481593696623, 10828.566857325619, 10887.292325998786, 11163.162762792985, 8907.777305567413, 8928.821423571622, 8997.910020899708, 9214.769630759285, 9266.397684150777, 4460.264056430653, 7012.509124361246, 8690.91309086901, 9465.763355916157, 9928.354656947275, 8787.165219304155, 8855.690050848189, 8985.326100542356, 9194.54027298619, 9300.162985331353, 6729.663516824237, 6784.728610855511, 6842.418394436529, 7013.754518591825, 7170.282971702788, 8413.242808147295, 8443.66225350979, 8496.660133594587, 8752.124787521452, 9134.771630709285], "value": 7746.750295108881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.5736878145822, 1421.673015206503, 1454.1711224601977, 1574.7716581095742, 1767.1076106566181, 6734.629595372253, 7625.237476252379, 7849.058113026431, 7858.489198202113, 8103.716369927054, 7873.921260787405, 8059.597020148998, 8066.516009039447, 8068.031836179666, 8080.757577272691, 2246.539459410821, 2272.5454909018263, 2272.9318120456414, 2274.715660542432, 2275.1468199425217, 2172.641514150171, 2195.1548653768336, 2217.5675743230076, 2218.9889050554725, 2219.6892435059103, 2181.3455963211054, 2192.48476607997, 2198.505336299336, 2201.878896660683, 2212.4911270407815, 2147.5919575280645, 2176.7170267865235, 2178.237616834111, 2179.825613950888, 2181.5091604389045, 2137.241279345825, 2138.1233694185307, 2140.4006878074165, 2156.579467003935, 2157.0832396231694, 7654.196309387546, 7894.131645519045, 7914.366850651992, 7977.3618110551015, 7981.720639777638, 4836.0, 4970.329005584236, 4973.005398920194, 4976.377952755905, 4980.950190498085, 2911.5923770672125, 3094.7833651644396, 3138.0585824252635, 3141.3141763792087, 3143.654198038214, 976.3702411944256, 983.8179936711731, 989.4656885281939, 999.7300728803256, 1009.7172791618359, 10402.739931501697, 10477.528511217013, 10497.212709046775, 10503.897090805433, 10513.106385957126, 4004.3993400989502, 4255.170241802881, 4256.063665993476, 4257.127288905767, 4260.339647354665, 8380.078191398941, 8415.452995555392, 8416.621252043673, 8425.831483370299, 8430.452020618763, 4626.3523106764405, 4626.421697287839, 4631.980964187874, 4634.420697412824, 4639.536046395334, 3753.662170404622, 3843.0584506795453, 4225.809838557211, 4294.957050429518, 4307.956920430755, 3441.7074548663645, 3452.7410444216785, 3524.964750352515, 3529.4529347951107, 3536.2397084626414, 1051.3925464847068, 1083.550326614462, 1090.8854570270166, 1093.3221402730358, 1104.5195340027115, 654.6726636681659, 801.4069588504465, 882.5851849630664, 891.8350105230553, 906.089380172922, 5334.67991920486, 5437.673739575638, 5710.114932185518, 5759.712014399263, 5772.769089236467, 399.048269876347, 403.45936445163034, 405.6511400195829, 421.6647765026811, 429.0624984409014, 3749.1189570450924, 3840.116773142193, 3878.108035151931, 3893.3575959966856, 3898.2203559288255, 9535.52322383878, 9751.658691945748, 9971.202303815677, 10034.598616055277, 10050.447225402528, 9676.854847177297, 9811.607535698493, 9878.407295562289, 9969.451680157661, 9978.700638980843, 6993.125859267591, 7331.523450975669, 7344.0, 7459.440541959266, 7524.473286869867, 5657.12314591239, 5761.251037365116, 5834.15404766315, 5906.734196961061, 5917.792877249276, 8661.523616200917, 8822.07368226327, 8862.291016718777, 8875.201231889161, 8902.910970890209, 8858.11418858109, 8978.551072446482, 9045.77385565366, 9208.861867071866, 9334.159925606727, 6924.792256232321, 6931.514793964374, 7043.401310888632, 7118.5017048806085, 7142.607156606437, 7909.406794490551, 7919.802004949692, 8023.358131349595, 8032.83934321322, 8032.87950680752, 6908.171019477494, 6927.3419025192525, 6995.195552511323, 7061.6469176542, 7110.182329032021, 6844.28135045813, 6896.793096207121, 6899.586024838526, 6996.790096296915, 7005.194402643558, 6589.670516474253, 6612.23959244693, 6613.272540020497, 6774.051632771318, 6782.118324617768, 4725.40932383452, 4865.70805751656, 4894.559489645807, 4915.139850526215, 4926.48271931442, 4767.427908650984, 4774.689645173192, 4805.927911081267, 5012.448630650699, 5146.125158722951], "value": 4137.326796477409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.36410261527254, 295.5625674002475, 312.28486765307446, 312.85921335399064, 315.2921690804145, 4617.8614641560725, 4772.928406073903, 4824.975875120619, 4848.127337079324, 4880.389951256093, 4596.49438561758, 4752.667313288071, 4756.429228492586, 4766.7378294193895, 4782.426108866941, 3808.447775072613, 3816.656500914917, 3825.751326163804, 3830.7550046234946, 3834.559025712051, 3601.621829707882, 3668.284684486526, 3807.714421418391, 3813.561440434344, 3852.9614703852885, 3780.7164462665273, 3795.430685397199, 3827.5598306194725, 3834.060655139495, 3840.5967373425806, 3784.7161462890394, 3791.7345785795005, 3811.8094095295123, 3839.5968423315708, 3839.9808000959815, 3399.5410619566287, 3406.8466918988706, 3406.9608769325346, 3410.181556426465, 3411.4541673332396, 4537.795799189044, 4582.6104781093645, 4591.6097131743845, 4592.219322715113, 4598.609118224955, 4260.1905637929, 4275.503573749163, 4287.742735435852, 4299.634531064863, 4352.194843953847, 4977.626677999128, 4992.151334273182, 5003.474635163292, 5007.574356179729, 5043.344365232533, 3582.8925132245813, 3654.5979942206336, 3657.359962006665, 3667.431548110047, 3695.3902606069964, 5217.739113044333, 5225.477452254782, 5231.398389185254, 5238.271370447743, 5258.81594144207, 3734.1598140418187, 3735.1969326594913, 3739.495168152319, 3752.9061773455337, 3789.109559253573, 3650.6714395703984, 3811.5235595550557, 3812.961870381316, 3813.9618603813606, 3815.141593141521, 4238.512571054306, 4270.039241170712, 4282.379055037064, 4283.2932566126865, 4293.8711838644895, 4979.875503112451, 5001.174806156943, 5014.6991180529285, 5019.598432125421, 5057.873553161126, 1257.8930790882694, 1266.645339304996, 1293.9611811645666, 1315.9736805263842, 1317.2820812657126, 837.7570504553734, 865.5845194306768, 871.3203701113142, 878.2622597018535, 885.685581618529, 3919.92160156801, 3947.585503522146, 3994.720369574102, 4010.6590939770444, 4032.536258330271, 4607.401037865056, 4611.723296602215, 4612.238980568169, 4654.348391225231, 4655.557722016403, 4042.5957404259925, 4047.392891066305, 4059.350503919418, 4066.552679205285, 4080.10237747695, 2392.3301475586863, 2499.187763976715, 2508.41052352697, 2515.735847735998, 2523.3691577105724, 4400.669949753781, 4414.757188354607, 4448.243798554254, 4465.709728867678, 4473.70262623842, 4779.375012495768, 4797.129119643342, 4799.472058073609, 4812.326274321597, 4824.758762061883, 4152.730072545275, 4434.445694288214, 4459.862735002618, 4466.0, 4473.619742321874, 4583.289590113538, 4652.116097941381, 4660.906781864276, 4680.438347398334, 4690.390249267573, 4512.684112112121, 4566.611837993808, 4569.588737013684, 4581.358609794698, 4596.2186428306595, 4417.3214178611925, 4437.38035617004, 4454.866354009385, 4520.706154099973, 4931.2001119591805, 3685.281370132798, 3685.3182161299173, 3718.9070273243387, 3724.7206459516187, 3730.198007428416, 4928.507149285187, 5186.4035635902355, 5235.712035838065, 5248.396434409939, 5250.343707036621, 4892.461829198856, 5043.36957880265, 5055.7472126392795, 5056.494350564914, 5075.5178258065425, 5039.672421292605, 5042.647014708935, 5045.31888195089, 5049.368828896388, 5071.340725705634, 4877.6829506081995, 4987.301777751045, 4992.925106123484, 5012.649114561946, 5016.344606279992, 5067.69593824357, 5086.059079070384, 5091.796328146833, 5121.385433747974, 5124.180131178993, 4993.80024799004, 5006.849794506171, 5009.574186194214, 5015.774290157025, 5023.723695196799], "value": 3714.844855005918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2284631478033, 612.3692596625476, 708.1421448860817, 716.4912911832598, 742.0909386002148, 11498.080153587714, 12125.0, 12127.514899404014, 12140.575079872206, 12141.332226727527, 12373.50505979762, 12381.07141964354, 12384.071194660413, 12406.069544784132, 12411.689707757288, 626.6302881300032, 643.0964494884695, 643.7135474713755, 777.8755399136139, 794.2097612875198, 637.8373514753731, 639.8656282180748, 765.5138986743431, 793.238491048594, 795.459087820282, 829.2660995019421, 832.142892820393, 834.04501845387, 834.6160766047625, 836.3852568362249, 823.8558252305822, 824.077033722229, 824.2705205892798, 824.530017889803, 824.6289169873551, 485.6042325504702, 493.6273113799095, 495.49459551257877, 495.66294919454754, 592.2005292854654, 12115.757684846341, 12172.878271217263, 12533.060020498408, 12538.623841284776, 12583.119181657288, 11779.469923853447, 12216.450259738333, 12224.755504889941, 12583.433745481476, 12599.811002834966, 11256.73554669145, 11296.661100167008, 11297.548098076068, 11300.208985371028, 11339.262947908443, 4002.8598999034893, 4005.218982298453, 4082.346824508094, 4106.938395924063, 4150.896227594334, 46384.7680761594, 48684.0, 48750.26874596884, 48901.75549122267, 49002.26496602554, 9730.12428881404, 9832.164266037324, 9858.80282394348, 9915.405075695482, 10392.06471417576, 18137.546561336072, 18289.908550457163, 18291.176897039666, 18295.72556411655, 18371.0, 6742.407366154342, 6775.830604234835, 6778.796636100925, 6934.895976560356, 6958.547694399847, 3696.519452471215, 3711.1464363196615, 3725.8509659613856, 3748.9625103748613, 3755.5681096674234, 2835.5746638004466, 2906.055531952124, 2913.606663100454, 2914.0383673387732, 2914.635670541182, 519.1641457253818, 525.4010428111956, 536.8523655994633, 539.7975759090341, 547.5099785691863, 413.88204361756755, 450.07734145002615, 466.1446246138374, 470.8705106095783, 474.67484772929964, 7537.4723769336715, 7667.504836556818, 7823.0, 7873.0, 8056.677732890736, 472.95622428238426, 600.9879802403927, 607.5595193484777, 627.9120923070774, 628.9088082228051, 3643.7267204959735, 3653.06846754076, 3653.762505437138, 3655.926881462356, 3703.0372103252807, 59656.0, 59971.700141499015, 60172.39827601668, 61690.0, 62653.0, 50037.74981125071, 50074.49925500698, 50181.24728129008, 54208.728956354964, 54859.72570137124, 45088.999999999345, 45187.77406112949, 45246.32130518045, 45990.540094599295, 47080.29379559309, 8029.277365037175, 8157.0, 8193.221643943816, 8230.62962166692, 8276.131006244257, 31598.526022110145, 32206.838965805957, 32411.35177296488, 32504.83747581247, 32856.50715239321, 42511.362329564465, 42520.0, 42558.57441425546, 42928.35607465953, 43144.56855431531, 10053.346532475365, 10118.494075296352, 10191.898081019095, 10690.465476726287, 10707.732306692395, 11095.389753563308, 11142.331460112418, 11255.268407553483, 11401.087912967108, 11878.940605296919, 10366.170706343626, 10541.262111652111, 10610.310329828537, 10729.302595331279, 10958.780824383308, 10618.256722029693, 10692.0, 11033.724156896142, 11106.777864442503, 11173.329600224013, 10468.214883883587, 10506.106980906403, 10566.524506397076, 11027.944860275647, 11119.221654484109, 8915.153060459246, 9145.451272923647, 9321.394109382869, 9353.0, 9742.025797420201, 9154.954225228832, 9182.908170918472, 9290.046733618268, 9345.15893569582, 9458.43249405038], "value": 5932.012109833338, "unit": "score"}], "name": "dromaeo_css", "value": 6258.95127872891, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 129.0, 132.0, 165.0, 137.0, 149.0, 150.0, 134.0, 197.0, 129.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 170.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 76.0, 77.0, 75.0, 75.0, 123.0, 75.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 129.0, 83.0, 84.0, 84.0, 118.0, 85.0, 84.0, 120.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 148.0, 145.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 82.0, 82.0, 89.0, 83.0, 88.0, 84.0, 115.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 144.0, 129.0, 127.0, 130.0, 127.0, 136.0, 132.0, 142.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 173.0, 167.0, 169.0, 168.0, 167.0, 167.0, 165.0, 170.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 64.0, 66.0, 65.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1547.1, "alertThreshold": 2.0}]} 15:17:09 INFO - Return code: 0 15:17:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:17:09 ERROR - # TBPL SUCCESS # 15:17:09 INFO - Running post-action listener: _resource_record_post_action 15:17:09 INFO - ##### 15:17:09 INFO - ##### Finished run-tests step (success) 15:17:09 INFO - ##### 15:17:09 INFO - Running post-run listener: _resource_record_post_run 15:17:09 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 530259968; Read time: 0; Write time: 367984 15:17:09 INFO - TinderboxPrint: CPU usage
13.2% 15:17:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:17:09 INFO - TinderboxPrint: I/O write bytes / time
530,259,968 / 367,984 15:17:09 INFO - TinderboxPrint: CPU idle
8,315.1 (86.8%) 15:17:09 INFO - TinderboxPrint: CPU user
1,218.8 (12.7%) 15:17:09 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246812672; Read time: 0; Write time: 200284 15:17:09 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283447296; Read time: 0; Write time: 167700 15:17:09 INFO - Running post-run listener: _upload_blobber_files 15:17:09 INFO - Blob upload gear active. 15:17:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:09 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 15:17:09 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'] 15:17:09 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 15:17:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:14 INFO - (blobuploader) - INFO - Done attempting. 15:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:15 INFO - (blobuploader) - INFO - Done attempting. 15:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:17:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:16 INFO - (blobuploader) - INFO - Done attempting. 15:17:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:17:16 INFO - Return code: 0 15:17:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:17:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:17:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfd69599cfecea9cec277a9ea825ae6e72e2be53d1169420552f3e257dc6f63a054ddfacbbaf020c8a2289762b499a9dd64f8740c565f2b6c4248ed97d8e46ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0dba217a2b040c7e043e7b9d484a2c0716f1e849b3612eb3363488830c8079362fc3e650b152176e32a80e719a806a972717b2db892517836fbcf8e265d82ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80b09b68f5b4a731b41d449c87184b1100b78c5071c78b0de4737a34b7beeb6dd9dcc3575eda9c01d758bb92a564469fa1dabaefcd04361f5cfa7d02a0530353"} 15:17:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:17:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:17:16 INFO - Contents: 15:17:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfd69599cfecea9cec277a9ea825ae6e72e2be53d1169420552f3e257dc6f63a054ddfacbbaf020c8a2289762b499a9dd64f8740c565f2b6c4248ed97d8e46ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0dba217a2b040c7e043e7b9d484a2c0716f1e849b3612eb3363488830c8079362fc3e650b152176e32a80e719a806a972717b2db892517836fbcf8e265d82ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80b09b68f5b4a731b41d449c87184b1100b78c5071c78b0de4737a34b7beeb6dd9dcc3575eda9c01d758bb92a564469fa1dabaefcd04361f5cfa7d02a0530353"} 15:17:16 INFO - Running post-run listener: copy_logs_to_upload_dir 15:17:16 INFO - Copying logs to upload dir... 15:17:16 INFO - mkdir: /builds/slave/test/build/upload/logs 15:17:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.130959 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 15:17:15.804528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 15:17:15.807954) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 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/dfd69599cfecea9cec277a9ea825ae6e72e2be53d1169420552f3e257dc6f63a054ddfacbbaf020c8a2289762b499a9dd64f8740c565f2b6c4248ed97d8e46ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0dba217a2b040c7e043e7b9d484a2c0716f1e849b3612eb3363488830c8079362fc3e650b152176e32a80e719a806a972717b2db892517836fbcf8e265d82ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80b09b68f5b4a731b41d449c87184b1100b78c5071c78b0de4737a34b7beeb6dd9dcc3575eda9c01d758bb92a564469fa1dabaefcd04361f5cfa7d02a0530353"} build_url:https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/QkuKy9HQSEy0_jlXNMfcWA/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/dfd69599cfecea9cec277a9ea825ae6e72e2be53d1169420552f3e257dc6f63a054ddfacbbaf020c8a2289762b499a9dd64f8740c565f2b6c4248ed97d8e46ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0dba217a2b040c7e043e7b9d484a2c0716f1e849b3612eb3363488830c8079362fc3e650b152176e32a80e719a806a972717b2db892517836fbcf8e265d82ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80b09b68f5b4a731b41d449c87184b1100b78c5071c78b0de4737a34b7beeb6dd9dcc3575eda9c01d758bb92a564469fa1dabaefcd04361f5cfa7d02a0530353"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 15:17:15.836536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:17:15.836866) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464386084.324968-1367342987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 15:17:15.920104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 15:17:15.920860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 15:17:15.921501) ========= ========= Total master_lag: 0.19 =========