builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1463402777.7 results: success (0) buildid: 20160516050634 builduid: df246aded826448b938d9323b0037136 revision: 3b86a9c8c8527db36b8d8681700ca65c996b12bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.704551) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.705944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.706252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.735107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.735399) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 05:46:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-16 05:46:19 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.856045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.856363) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015517 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:17.907389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 05:46:17.907787) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b86a9c8c8527db36b8d8681700ca65c996b12bb --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 3b86a9c8c8527db36b8d8681700ca65c996b12bb --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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 05:46:19,531 truncating revision to first 12 chars 2016-05-16 05:46:19,531 Setting DEBUG logging. 2016-05-16 05:46:19,531 attempt 1/10 2016-05-16 05:46:19,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b86a9c8c852?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 05:46:20,349 unpacking tar archive at: fx-team-3b86a9c8c852/testing/mozharness/ program finished with exit code 0 elapsedTime=1.091332 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 05:46:19.114727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:19.115084) ========= script_repo_revision: 3b86a9c8c8527db36b8d8681700ca65c996b12bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:19.115553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:19.115864) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 05:46:19.125949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-16 05:46:19.126251) ========= /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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:20 INFO - MultiFileLogger online at 20160516 05:46:20 in /builds/slave/test 05:46:20 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 05:46:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:20 INFO - {'append_to_log': False, 05:46:20 INFO - 'base_work_dir': '/builds/slave/test', 05:46:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:46:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:20 INFO - 'branch': 'Fx-Team-Non-PGO', 05:46:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:20 INFO - 'config_files': ('talos/linux_config.py',), 05:46:20 INFO - 'default_actions': ('clobber', 05:46:20 INFO - 'read-buildbot-config', 05:46:20 INFO - 'download-and-extract', 05:46:20 INFO - 'populate-webroot', 05:46:20 INFO - 'create-virtualenv', 05:46:20 INFO - 'install', 05:46:20 INFO - 'run-tests'), 05:46:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:20 INFO - 'download_minidump_stackwalk': True, 05:46:20 INFO - 'download_symbols': 'ondemand', 05:46:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:20 INFO - 'installer_path': 'installer.exe', 05:46:20 INFO - 'log_level': 'info', 05:46:20 INFO - 'log_name': 'talos', 05:46:20 INFO - 'log_to_console': True, 05:46:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:20 INFO - 'opt_config_files': (), 05:46:20 INFO - 'pip_index': False, 05:46:20 INFO - 'sps_profile': False, 05:46:20 INFO - 'sps_profile_interval': 0, 05:46:20 INFO - 'suite': 'dromaeojs', 05:46:20 INFO - 'system_bits': '32', 05:46:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:20 INFO - 'title': 'talos-linux64-ix-060', 05:46:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:20 INFO - 'use_talos_json': True, 05:46:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:20 INFO - 'work_dir': 'build'} 05:46:20 INFO - ##### 05:46:20 INFO - ##### Running clobber step. 05:46:20 INFO - ##### 05:46:20 INFO - Running pre-action listener: _resource_record_pre_action 05:46:20 INFO - Running main action method: clobber 05:46:20 INFO - rmtree: /builds/slave/test/build 05:46:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:21 INFO - Running post-action listener: _resource_record_post_action 05:46:21 INFO - ##### 05:46:21 INFO - ##### Finished clobber step (success) 05:46:21 INFO - ##### 05:46:21 INFO - ##### 05:46:21 INFO - ##### Running read-buildbot-config step. 05:46:21 INFO - ##### 05:46:21 INFO - Running pre-action listener: _resource_record_pre_action 05:46:21 INFO - Running main action method: read_buildbot_config 05:46:21 INFO - Using buildbot properties: 05:46:21 INFO - { 05:46:21 INFO - "project": "", 05:46:21 INFO - "product": "firefox", 05:46:21 INFO - "script_repo_revision": "production", 05:46:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:46:21 INFO - "repository": "", 05:46:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:46:21 INFO - "buildid": "20160516050634", 05:46:21 INFO - "pgo_build": "False", 05:46:21 INFO - "basedir": "/builds/slave/test", 05:46:21 INFO - "buildnumber": 1746, 05:46:21 INFO - "slavename": "talos-linux64-ix-060", 05:46:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:46:21 INFO - "platform": "ubuntu64_hw", 05:46:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:46:21 INFO - "branch": "fx-team", 05:46:21 INFO - "repo_path": "integration/fx-team", 05:46:21 INFO - "revision": "3b86a9c8c8527db36b8d8681700ca65c996b12bb", 05:46:21 INFO - "stage_platform": "linux64", 05:46:21 INFO - "builduid": "df246aded826448b938d9323b0037136", 05:46:21 INFO - "slavebuilddir": "test" 05:46:21 INFO - } 05:46:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:46:21 INFO - Running post-action listener: _resource_record_post_action 05:46:21 INFO - ##### 05:46:21 INFO - ##### Finished read-buildbot-config step (success) 05:46:21 INFO - ##### 05:46:21 INFO - ##### 05:46:21 INFO - ##### Running download-and-extract step. 05:46:21 INFO - ##### 05:46:21 INFO - Running pre-action listener: _resource_record_pre_action 05:46:21 INFO - Running main action method: download_and_extract 05:46:21 INFO - mkdir: /builds/slave/test/build/tests 05:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:21 INFO - https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:24 INFO - Downloaded 1361 bytes. 05:46:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:46:24 INFO - Using the following test package requirements: 05:46:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:46:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'jsshell-linux-x86_64.zip'], 05:46:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:46:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:46:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46:24 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')]} 05:46:24 INFO - https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:26 INFO - Downloaded 22448136 bytes. 05:46:26 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'] 05:46:26 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 05:46:27 INFO - Return code: 0 05:46:27 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 05:46:27 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')]} 05:46:27 INFO - https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:30 INFO - Downloaded 22448136 bytes. 05:46:30 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'] 05:46:30 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 05:46:31 INFO - Return code: 0 05:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:31 INFO - https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:32 INFO - Downloaded 10840194 bytes. 05:46:32 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'] 05:46:32 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 05:46:33 INFO - Return code: 0 05:46:33 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')]} 05:46:33 INFO - https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_xWu60bSDWFCx9KowdZ9g/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 05:46:34 INFO - Downloaded 54743490 bytes. 05:46:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:46:34 INFO - mkdir: /builds/slave/test/properties 05:46:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:34 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:34 INFO - Contents: 05:46:34 INFO - build_url:https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:46:35 INFO - Running post-action listener: _resource_record_post_action 05:46:35 INFO - Running post-action listener: set_extra_try_arguments 05:46:35 INFO - ##### 05:46:35 INFO - ##### Finished download-and-extract step (success) 05:46:35 INFO - ##### 05:46:35 INFO - ##### 05:46:35 INFO - ##### Running populate-webroot step. 05:46:35 INFO - ##### 05:46:35 INFO - Running pre-action listener: _resource_record_pre_action 05:46:35 INFO - Running main action method: populate_webroot 05:46:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:35 INFO - '--tppagecycles', 05:46:35 INFO - '7'], 05:46:35 INFO - 'tests': ['tsvgm']}}, 05:46:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['damp', 'tps']}, 05:46:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'tests': ['damp', 'tps']}, 05:46:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['dromaeo_dom']}, 05:46:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['a11yr', 05:46:35 INFO - 'ts_paint', 05:46:35 INFO - 'tpaint', 05:46:35 INFO - 'sessionrestore', 05:46:35 INFO - 'sessionrestore_no_auto_restore', 05:46:35 INFO - 'tabpaint']}, 05:46:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['tsvgx', 05:46:35 INFO - 'tsvgr_opacity', 05:46:35 INFO - 'tart', 05:46:35 INFO - 'tscrollx', 05:46:35 INFO - 'cart']}, 05:46:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:35 INFO - 'tsvgr_opacity', 05:46:35 INFO - 'tart', 05:46:35 INFO - 'tscrollx', 05:46:35 INFO - 'cart']}, 05:46:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'talos_options': ['--disable-e10s'], 05:46:35 INFO - 'tests': ['tp5o']}, 05:46:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'tests': ['tp5o']}, 05:46:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'talos_options': ['--disable-e10s', 05:46:35 INFO - '--xperf_path', 05:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:35 INFO - 'tests': ['tp5n']}, 05:46:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:35 INFO - 'talos_options': ['--xperf_path', 05:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:35 INFO - 'tests': ['tp5n']}}, 05:46:35 INFO - 'talos.zip': {'path': '', 05:46:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:35 INFO - Running post-action listener: _resource_record_post_action 05:46:35 INFO - ##### 05:46:35 INFO - ##### Finished populate-webroot step (success) 05:46:35 INFO - ##### 05:46:35 INFO - ##### 05:46:35 INFO - ##### Running create-virtualenv step. 05:46:35 INFO - ##### 05:46:35 INFO - Running pre-action listener: _resource_record_pre_action 05:46:35 INFO - Running main action method: create_virtualenv 05:46:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:35 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 05:46:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:35 INFO - Using real prefix '/usr' 05:46:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:37 INFO - Installing pip.................done. 05:46:37 INFO - Return code: 0 05:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:37 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 05:46:37 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 05:46:37 INFO - Using env: {'DISPLAY': ':0', 05:46:37 INFO - 'HOME': '/home/cltbld', 05:46:37 INFO - 'LANG': 'en_US.UTF-8', 05:46:37 INFO - 'LANGUAGE': 'en_US:en', 05:46:37 INFO - 'LOGNAME': 'cltbld', 05:46:37 INFO - 'MAIL': '/var/mail/cltbld', 05:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:37 INFO - 'MOZ_NO_REMOTE': '1', 05:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:37 INFO - 'NO_EM_RESTART': '1', 05:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:37 INFO - 'PWD': '/builds/slave/test', 05:46:37 INFO - 'SHELL': '/bin/bash', 05:46:37 INFO - 'SHLVL': '1', 05:46:37 INFO - 'TERM': 'linux', 05:46:37 INFO - 'TMOUT': '86400', 05:46:37 INFO - 'USER': 'cltbld', 05:46:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:37 INFO - '_': '/tools/buildbot/bin/python'} 05:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:37 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 05:46:37 INFO - Cleaning up... 05:46:37 INFO - Return code: 0 05:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:37 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 05:46:37 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 05:46:37 INFO - Using env: {'DISPLAY': ':0', 05:46:37 INFO - 'HOME': '/home/cltbld', 05:46:37 INFO - 'LANG': 'en_US.UTF-8', 05:46:37 INFO - 'LANGUAGE': 'en_US:en', 05:46:37 INFO - 'LOGNAME': 'cltbld', 05:46:37 INFO - 'MAIL': '/var/mail/cltbld', 05:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:37 INFO - 'MOZ_NO_REMOTE': '1', 05:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:37 INFO - 'NO_EM_RESTART': '1', 05:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:37 INFO - 'PWD': '/builds/slave/test', 05:46:37 INFO - 'SHELL': '/bin/bash', 05:46:37 INFO - 'SHLVL': '1', 05:46:37 INFO - 'TERM': 'linux', 05:46:37 INFO - 'TMOUT': '86400', 05:46:37 INFO - 'USER': 'cltbld', 05:46:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:37 INFO - '_': '/tools/buildbot/bin/python'} 05:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:38 INFO - Downloading/unpacking psutil>=3.1.1 05:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:40 INFO - Installing collected packages: psutil 05:46:40 INFO - Running setup.py install for psutil 05:46:40 INFO - building 'psutil._psutil_linux' extension 05:46:40 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 05:46:40 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 05:46:40 INFO - building 'psutil._psutil_posix' extension 05:46:40 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 05:46:40 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 05:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:40 INFO - Successfully installed psutil 05:46:40 INFO - Cleaning up... 05:46:40 INFO - Return code: 0 05:46:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:40 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:40 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 05:46:40 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 05:46:40 INFO - Using env: {'DISPLAY': ':0', 05:46:40 INFO - 'HOME': '/home/cltbld', 05:46:40 INFO - 'LANG': 'en_US.UTF-8', 05:46:40 INFO - 'LANGUAGE': 'en_US:en', 05:46:40 INFO - 'LOGNAME': 'cltbld', 05:46:40 INFO - 'MAIL': '/var/mail/cltbld', 05:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:40 INFO - 'MOZ_NO_REMOTE': '1', 05:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:40 INFO - 'NO_EM_RESTART': '1', 05:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:40 INFO - 'PWD': '/builds/slave/test', 05:46:40 INFO - 'SHELL': '/bin/bash', 05:46:40 INFO - 'SHLVL': '1', 05:46:40 INFO - 'TERM': 'linux', 05:46:40 INFO - 'TMOUT': '86400', 05:46:40 INFO - 'USER': 'cltbld', 05:46:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:40 INFO - '_': '/tools/buildbot/bin/python'} 05:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:40 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 05:46:40 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 05:46:40 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 05:46:40 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 05:46:40 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 05:46:40 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 05:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:42 INFO - Installing collected packages: mozsystemmonitor 05:46:42 INFO - Running setup.py install for mozsystemmonitor 05:46:42 INFO - Successfully installed mozsystemmonitor 05:46:42 INFO - Cleaning up... 05:46:43 INFO - Return code: 0 05:46:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:46:43 INFO - Using env: {'DISPLAY': ':0', 05:46:43 INFO - 'HOME': '/home/cltbld', 05:46:43 INFO - 'LANG': 'en_US.UTF-8', 05:46:43 INFO - 'LANGUAGE': 'en_US:en', 05:46:43 INFO - 'LOGNAME': 'cltbld', 05:46:43 INFO - 'MAIL': '/var/mail/cltbld', 05:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:43 INFO - 'MOZ_NO_REMOTE': '1', 05:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:43 INFO - 'NO_EM_RESTART': '1', 05:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:43 INFO - 'PWD': '/builds/slave/test', 05:46:43 INFO - 'SHELL': '/bin/bash', 05:46:43 INFO - 'SHLVL': '1', 05:46:43 INFO - 'TERM': 'linux', 05:46:43 INFO - 'TMOUT': '86400', 05:46:43 INFO - 'USER': 'cltbld', 05:46:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:43 INFO - '_': '/tools/buildbot/bin/python'} 05:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 INFO - Downloading docopt-0.6.1.tar.gz 05:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:45 INFO - Running setup.py install for blobuploader 05:46:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:45 INFO - Running setup.py install for requests 05:46:46 INFO - Running setup.py install for docopt 05:46:46 INFO - Successfully installed blobuploader requests docopt 05:46:46 INFO - Cleaning up... 05:46:46 INFO - Return code: 0 05:46:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:46 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 05:46:46 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 05:46:46 INFO - Using env: {'DISPLAY': ':0', 05:46:46 INFO - 'HOME': '/home/cltbld', 05:46:46 INFO - 'LANG': 'en_US.UTF-8', 05:46:46 INFO - 'LANGUAGE': 'en_US:en', 05:46:46 INFO - 'LOGNAME': 'cltbld', 05:46:46 INFO - 'MAIL': '/var/mail/cltbld', 05:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:46 INFO - 'MOZ_NO_REMOTE': '1', 05:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:46 INFO - 'NO_EM_RESTART': '1', 05:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:46 INFO - 'PWD': '/builds/slave/test', 05:46:46 INFO - 'SHELL': '/bin/bash', 05:46:46 INFO - 'SHLVL': '1', 05:46:46 INFO - 'TERM': 'linux', 05:46:46 INFO - 'TMOUT': '86400', 05:46:46 INFO - 'USER': 'cltbld', 05:46:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:46 INFO - '_': '/tools/buildbot/bin/python'} 05:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:46 INFO - Running setup.py (path:/tmp/pip-pCT5I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:46 INFO - Running setup.py (path:/tmp/pip-5bTM5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:46 INFO - Running setup.py (path:/tmp/pip-iLgR1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:46 INFO - Running setup.py (path:/tmp/pip-FiicSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:46 INFO - Running setup.py (path:/tmp/pip-RZjXOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:47 INFO - Running setup.py (path:/tmp/pip-qsecaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:47 INFO - Running setup.py (path:/tmp/pip-agoxr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:47 INFO - Running setup.py (path:/tmp/pip-LS9KHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:47 INFO - Running setup.py (path:/tmp/pip-6yCVlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:47 INFO - Running setup.py (path:/tmp/pip-1GA1mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:47 INFO - Running setup.py (path:/tmp/pip-kSOUzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:47 INFO - Running setup.py (path:/tmp/pip-cPJbZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:47 INFO - Running setup.py (path:/tmp/pip-luHyb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:47 INFO - Running setup.py (path:/tmp/pip-mwmpnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:47 INFO - Running setup.py (path:/tmp/pip-YHVxvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:47 INFO - Running setup.py (path:/tmp/pip-GQBIn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:47 INFO - Running setup.py (path:/tmp/pip-lxYF44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:47 INFO - Running setup.py install for manifestparser 05:46:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozcrash 05:46:48 INFO - Running setup.py install for mozdebug 05:46:48 INFO - Running setup.py install for mozdevice 05:46:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozfile 05:46:48 INFO - Running setup.py install for mozhttpd 05:46:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozinfo 05:46:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozInstall 05:46:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozleak 05:46:48 INFO - Running setup.py install for mozlog 05:46:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for moznetwork 05:46:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozprocess 05:46:49 INFO - Running setup.py install for mozprofile 05:46:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozrunner 05:46:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozscreenshot 05:46:49 INFO - Running setup.py install for moztest 05:46:49 INFO - Running setup.py install for mozversion 05:46:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:49 INFO - Cleaning up... 05:46:49 INFO - Return code: 0 05:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:49 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:49 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 05:46:49 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 05:46:49 INFO - Using env: {'DISPLAY': ':0', 05:46:49 INFO - 'HOME': '/home/cltbld', 05:46:49 INFO - 'LANG': 'en_US.UTF-8', 05:46:49 INFO - 'LANGUAGE': 'en_US:en', 05:46:49 INFO - 'LOGNAME': 'cltbld', 05:46:49 INFO - 'MAIL': '/var/mail/cltbld', 05:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:49 INFO - 'MOZ_NO_REMOTE': '1', 05:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:49 INFO - 'NO_EM_RESTART': '1', 05:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:49 INFO - 'PWD': '/builds/slave/test', 05:46:49 INFO - 'SHELL': '/bin/bash', 05:46:49 INFO - 'SHLVL': '1', 05:46:49 INFO - 'TERM': 'linux', 05:46:49 INFO - 'TMOUT': '86400', 05:46:49 INFO - 'USER': 'cltbld', 05:46:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:49 INFO - '_': '/tools/buildbot/bin/python'} 05:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:49 INFO - Running setup.py (path:/tmp/pip-LxLcFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:49 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)) 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:50 INFO - Running setup.py (path:/tmp/pip-8ftFMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:50 INFO - Running setup.py (path:/tmp/pip-KcihKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:50 INFO - Running setup.py (path:/tmp/pip-5AriDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:50 INFO - Running setup.py (path:/tmp/pip-RQ_QLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:50 INFO - Running setup.py (path:/tmp/pip-nDdxw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:50 INFO - Running setup.py (path:/tmp/pip-i9TAyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:50 INFO - Running setup.py (path:/tmp/pip-OyA7BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:50 INFO - Running setup.py (path:/tmp/pip-aZKnPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:50 INFO - Running setup.py (path:/tmp/pip-UmHpzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:50 INFO - Running setup.py (path:/tmp/pip-lqQRl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:50 INFO - Running setup.py (path:/tmp/pip-EXn3L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:50 INFO - Running setup.py (path:/tmp/pip-gmQlu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:50 INFO - Running setup.py (path:/tmp/pip-VSnHnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:50 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)) 05:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:50 INFO - Running setup.py (path:/tmp/pip-mnjetG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:51 INFO - Running setup.py (path:/tmp/pip-t8ous4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:51 INFO - Running setup.py (path:/tmp/pip-yQkwix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:51 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)) 05:46:51 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)) 05:46:51 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)) 05:46:51 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)) 05:46:51 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)) 05:46:51 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)) 05:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:53 INFO - Downloading blessings-1.6.tar.gz 05:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:53 INFO - Installing collected packages: blessings 05:46:53 INFO - Running setup.py install for blessings 05:46:53 INFO - Successfully installed blessings 05:46:53 INFO - Cleaning up... 05:46:53 INFO - Return code: 0 05:46:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:53 INFO - Reading from file tmpfile_stdout 05:46:53 INFO - Current package versions: 05:46:53 INFO - argparse == 1.2.1 05:46:53 INFO - blessings == 1.6 05:46:53 INFO - blobuploader == 1.2.4 05:46:53 INFO - docopt == 0.6.1 05:46:53 INFO - manifestparser == 1.1 05:46:53 INFO - mozInstall == 1.12 05:46:53 INFO - mozcrash == 0.17 05:46:53 INFO - mozdebug == 0.1 05:46:53 INFO - mozdevice == 0.48 05:46:53 INFO - mozfile == 1.2 05:46:53 INFO - mozhttpd == 0.7 05:46:53 INFO - mozinfo == 0.9 05:46:53 INFO - mozleak == 0.1 05:46:53 INFO - mozlog == 3.2 05:46:53 INFO - moznetwork == 0.27 05:46:53 INFO - mozprocess == 0.22 05:46:53 INFO - mozprofile == 0.28 05:46:53 INFO - mozrunner == 6.11 05:46:53 INFO - mozscreenshot == 0.1 05:46:53 INFO - mozsystemmonitor == 0.3 05:46:53 INFO - moztest == 0.7 05:46:53 INFO - mozversion == 1.4 05:46:53 INFO - psutil == 3.1.1 05:46:53 INFO - requests == 1.2.3 05:46:53 INFO - wsgiref == 0.1.2 05:46:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:53 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')]} 05:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:53 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')]} 05:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:53 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:53 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 05:46:53 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 05:46:53 INFO - Using env: {'DISPLAY': ':0', 05:46:53 INFO - 'HOME': '/home/cltbld', 05:46:53 INFO - 'LANG': 'en_US.UTF-8', 05:46:53 INFO - 'LANGUAGE': 'en_US:en', 05:46:53 INFO - 'LOGNAME': 'cltbld', 05:46:53 INFO - 'MAIL': '/var/mail/cltbld', 05:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:53 INFO - 'MOZ_NO_REMOTE': '1', 05:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:53 INFO - 'NO_EM_RESTART': '1', 05:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:53 INFO - 'PWD': '/builds/slave/test', 05:46:53 INFO - 'SHELL': '/bin/bash', 05:46:53 INFO - 'SHLVL': '1', 05:46:53 INFO - 'TERM': 'linux', 05:46:53 INFO - 'TMOUT': '86400', 05:46:53 INFO - 'USER': 'cltbld', 05:46:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:53 INFO - '_': '/tools/buildbot/bin/python'} 05:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 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)) 05:46:53 INFO - Cleaning up... 05:46:53 INFO - Return code: 0 05:46:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:53 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')]} 05:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:53 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')]} 05:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:53 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:53 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 05:46:53 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 05:46:53 INFO - Using env: {'DISPLAY': ':0', 05:46:53 INFO - 'HOME': '/home/cltbld', 05:46:53 INFO - 'LANG': 'en_US.UTF-8', 05:46:53 INFO - 'LANGUAGE': 'en_US:en', 05:46:53 INFO - 'LOGNAME': 'cltbld', 05:46:53 INFO - 'MAIL': '/var/mail/cltbld', 05:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:53 INFO - 'MOZ_NO_REMOTE': '1', 05:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:53 INFO - 'NO_EM_RESTART': '1', 05:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:53 INFO - 'PWD': '/builds/slave/test', 05:46:53 INFO - 'SHELL': '/bin/bash', 05:46:53 INFO - 'SHLVL': '1', 05:46:53 INFO - 'TERM': 'linux', 05:46:53 INFO - 'TMOUT': '86400', 05:46:53 INFO - 'USER': 'cltbld', 05:46:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:53 INFO - '_': '/tools/buildbot/bin/python'} 05:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:53 INFO - Downloading/unpacking jsonschema 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:56 INFO - warning: no files found matching '*.txt' 05:46:56 INFO - no previously-included directories found matching 'build' 05:46:56 INFO - no previously-included directories found matching 'dist' 05:46:56 INFO - no previously-included directories found matching '.git*' 05:46:56 INFO - Installing collected packages: jsonschema, functools32 05:46:56 INFO - Running setup.py install for functools32 05:46:56 INFO - warning: no files found matching '*.txt' 05:46:56 INFO - no previously-included directories found matching 'build' 05:46:56 INFO - no previously-included directories found matching 'dist' 05:46:56 INFO - no previously-included directories found matching '.git*' 05:46:56 INFO - Successfully installed jsonschema functools32 05:46:56 INFO - Cleaning up... 05:46:56 INFO - Return code: 0 05:46:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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 0x7f8e6dc33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2332770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', '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 05:46:56 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 05:46:56 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 05:46:56 INFO - Using env: {'DISPLAY': ':0', 05:46:56 INFO - 'HOME': '/home/cltbld', 05:46:56 INFO - 'LANG': 'en_US.UTF-8', 05:46:56 INFO - 'LANGUAGE': 'en_US:en', 05:46:56 INFO - 'LOGNAME': 'cltbld', 05:46:56 INFO - 'MAIL': '/var/mail/cltbld', 05:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:56 INFO - 'MOZ_NO_REMOTE': '1', 05:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:56 INFO - 'NO_EM_RESTART': '1', 05:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:56 INFO - 'PWD': '/builds/slave/test', 05:46:56 INFO - 'SHELL': '/bin/bash', 05:46:56 INFO - 'SHLVL': '1', 05:46:56 INFO - 'TERM': 'linux', 05:46:56 INFO - 'TMOUT': '86400', 05:46:56 INFO - 'USER': 'cltbld', 05:46:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:56 INFO - '_': '/tools/buildbot/bin/python'} 05:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:56 INFO - Downloading/unpacking flake8 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:58 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 05:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:59 INFO - no previously-included directories found matching 'docs/_build' 05:46:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:59 INFO - Running setup.py install for pep8 05:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:59 INFO - no previously-included directories found matching 'docs/_build' 05:46:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:46:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:59 INFO - Cleaning up... 05:46:59 INFO - Return code: 0 05:46:59 INFO - Running post-action listener: _resource_record_post_action 05:46:59 INFO - Running post-action listener: _start_resource_monitoring 05:46:59 INFO - Starting resource monitoring. 05:46:59 INFO - ##### 05:46:59 INFO - ##### Finished create-virtualenv step (success) 05:46:59 INFO - ##### 05:46:59 INFO - ##### 05:46:59 INFO - ##### Running install step. 05:46:59 INFO - ##### 05:46:59 INFO - Running pre-action listener: _resource_record_pre_action 05:46:59 INFO - Running main action method: install 05:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:59 INFO - Reading from file tmpfile_stdout 05:46:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:59 INFO - Reading from file tmpfile_stdout 05:46:59 INFO - Output received: 05:46:59 INFO - Usage: mozinstall [options] installer 05:46:59 INFO - Options: 05:46:59 INFO - -h, --help show this help message and exit 05:46:59 INFO - -d DEST, --destination=DEST 05:46:59 INFO - Directory to install application into. [default: 05:46:59 INFO - "/builds/slave/test"] 05:46:59 INFO - --app=APP Application being installed. [default: firefox] 05:46:59 INFO - mkdir: /builds/slave/test/build/application 05:46:59 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'] 05:46:59 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 05:47:15 INFO - Reading from file tmpfile_stdout 05:47:15 INFO - Output received: 05:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:15 INFO - Running post-action listener: _resource_record_post_action 05:47:15 INFO - ##### 05:47:15 INFO - ##### Finished install step (success) 05:47:15 INFO - ##### 05:47:15 INFO - ##### 05:47:15 INFO - ##### Running run-tests step. 05:47:15 INFO - ##### 05:47:15 INFO - Running pre-action listener: _resource_record_pre_action 05:47:15 INFO - Running main action method: run_tests 05:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:15 INFO - Python 2.7.3 05:47:15 INFO - Return code: 0 05:47:15 INFO - grabbing minidump binary from tooltool 05:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:15 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 0x23c19c0>, '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 0x23c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:15 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 05:47:15 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 05:47:15 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 05:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:15 INFO - Return code: 0 05:47:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:47:16 INFO - Return code: 0 05:47:16 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/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:47:16 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/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 05:47:16 INFO - Using env: {'DISPLAY': ':0', 05:47:16 INFO - 'HOME': '/home/cltbld', 05:47:16 INFO - 'LANG': 'en_US.UTF-8', 05:47:16 INFO - 'LANGUAGE': 'en_US:en', 05:47:16 INFO - 'LOGNAME': 'cltbld', 05:47:16 INFO - 'MAIL': '/var/mail/cltbld', 05:47:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:16 INFO - 'MOZ_NO_REMOTE': '1', 05:47:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:16 INFO - 'NO_EM_RESTART': '1', 05:47:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:16 INFO - 'PWD': '/builds/slave/test', 05:47:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:16 INFO - 'SHELL': '/bin/bash', 05:47:16 INFO - 'SHLVL': '1', 05:47:16 INFO - 'TERM': 'linux', 05:47:16 INFO - 'TMOUT': '86400', 05:47:16 INFO - 'USER': 'cltbld', 05:47:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781', 05:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:16 INFO - '_': '/tools/buildbot/bin/python'} 05:47:16 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/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 05:47:16 INFO - mozversion application_buildid: 20160516050634 05:47:16 INFO - mozversion application_changeset: 3b86a9c8c8527db36b8d8681700ca65c996b12bb 05:47:16 INFO - mozversion application_display_name: Nightly 05:47:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:16 INFO - mozversion application_name: Firefox 05:47:16 INFO - mozversion application_remotingname: firefox 05:47:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:47:16 INFO - mozversion application_vendor: Mozilla 05:47:16 INFO - mozversion application_version: 49.0a1 05:47:16 INFO - mozversion platform_buildid: 20160516050634 05:47:16 INFO - mozversion platform_changeset: 3b86a9c8c8527db36b8d8681700ca65c996b12bb 05:47:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:47:16 INFO - mozversion platform_version: 49.0a1 05:47:16 INFO - using testdate: 1463402836 05:47:16 INFO - actual date: 1463402836 05:47:16 INFO - starting webserver on 'localhost:56936' 05:47:16 INFO - SUITE-START | Running 2 tests 05:47:16 INFO - TEST-START | dromaeo_css 05:47:16 INFO - operating with platform_type : linux_ 05:47:16 INFO - Initialising browser for dromaeo_css test... 05:47:16 INFO - TEST-INFO | started process 10355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyG0VWJ/profile http://localhost:56936/getInfo.html) 05:47:21 INFO - PROCESS | 10355 | __metrics Screen width/height:1600/1200 05:47:21 INFO - PROCESS | 10355 | colorDepth:24 05:47:21 INFO - PROCESS | 10355 | Browser inner width/height: 1024/697 05:47:21 INFO - PROCESS | 10355 | __metrics 05:47:22 ERROR - PROCESS | 10355 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:47:23 INFO - TEST-INFO | 10355: exit 0 05:47:23 INFO - Browser initialized. 05:47:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:23 INFO - TEST-INFO | started process 10433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyG0VWJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:34 INFO - PROCESS | 10433 | RSS: Main: 154238976 05:47:34 INFO - PROCESS | 10433 | 05:48:26 INFO - PROCESS | 10433 | 1463402906655 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] 05:50:38 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56936/tests/dromaeo/cssquery-ext.html) 05:50:39 INFO - PROCESS | 10433 | RSS: Main: 275845120 05:50:39 INFO - PROCESS | 10433 | 05:53:42 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-ext.html (next: http://localhost:56936/tests/dromaeo/cssquery-jquery.html) 05:53:42 INFO - PROCESS | 10433 | RSS: Main: 239161344 05:53:42 INFO - PROCESS | 10433 | 05:56:45 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56936/tests/dromaeo/cssquery-mootools.html) 05:56:45 INFO - PROCESS | 10433 | RSS: Main: 244420608 05:56:45 INFO - PROCESS | 10433 | 05:59:47 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56936/tests/dromaeo/cssquery-prototype.html) 05:59:48 INFO - PROCESS | 10433 | RSS: Main: 239570944 05:59:48 INFO - PROCESS | 10433 | 06:02:51 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56936/tests/dromaeo/cssquery-yui.html) 06:02:51 INFO - PROCESS | 10433 | RSS: Main: 203362304 06:02:51 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-yui.html (next: http://localhost:56936/tests/dromaeo/cssquery-dojo.html) 06:05:54 INFO - PROCESS | 10433 | RSS: Main: 267104256 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | __start_tp_report 06:05:54 INFO - PROCESS | 10433 | _x_x_mozilla_page_load 06:05:54 INFO - PROCESS | 10433 | _x_x_mozilla_page_load_details 06:05:54 INFO - PROCESS | 10433 | |i|pagename|runs| 06:05:54 INFO - PROCESS | 10433 | |0;dojo.html;2656.614790855326;2685.194441667502;2716.904908328209;2728.208819442362;2729.304027472995;4570;4605.815767369301;4685.718856868591;4771.236602143662;4807.1587472192405;4679.695819771721;4687.578117969382;4694.741789201593;4726.550977657125;4734.502877197896;4278.57214278572;4338.804753786071;4374.015846434542;4408.647308215351;4475.149721552911;4349.282368409209;4372.256716358227;4378.10248898975;4401.911961760763;4428.269335559645;4218.472690913636;4254.298040823261;4290.957090429102;4333.58830911063;4349.608535231812;4250.681198910063;4260.68044896634;4263.893402664927;4365.454318210223;4448.288273876196;4303.505096913864;4310.48274207094;4317.4819021717285;4321.308590625485;4350.456192975878;4409.470863496369;4488.865334039984;4544.341070544786;4544.863654090383;4578.198815207359;5031.974840125776;5043.041822053798;5044.571211447032;5045.64680472367;5051.166557518005;4973.3286006389035;4986.40163180417;5013.248012798073;5024.648274620778;5026.974865125651;4590.265557510782;4642.53574642533;4715.905681886343;4717.127331443694;4737.9289310660715;5205.063088644005;5216.426193118754;5228.869278267997;5230.137027390514;5237.319148510669;4951.356323677899;4964.801407943714;5003;5011.0980023595375;5024.698518088926;4934.235193545006;5007.974960125249;5042.546170844642;5054.747262636927;5076.6192535559985;4987.700737955734;5004.599632029429;5020.171671674206;5027.245913113063;5073.644844860898;4865.56209941107;4994;5008.199572628365;5011.248312753116;5012.548870601663;4120.773357465308;4131.194417088699;4154.210699967057;4164.75011499311;4221.472315960505;3673.7612055216327;3689.870854520079;3698.3527882620433;3734.57052438973;3738.476613274144;4351.19502891966;4356.150550642657;4357.43353364067;4398.406215160976;4401.2517871961845;4883.658143929891;5060.696358218519;5080.949190508048;5101.770420331094;5106.514881086291;4380.759058251763;4386.473623165177;4393.340998850134;4396.384506169139;4443.244648409778;4390.934135987963;4566.657500687462;4567.954320456819;4571.085782843445;4600;4763.809447622057;4797.280407938698;4806.206975848946;4808.1345357834525;4816.397950256218;5028.270900719302;5085.288059671723;5102.821401250939;5104.033801020313;5166.225066240094;4612.031473390625;4774.40319960005;4778.354922085613;4790.473047964791;4835.20219163834;4978.626603004862;5000.099982003274;5002.824901128589;5034.597232221487;5040.57155141817;5048.419431765247;5064.341635587498;5071.771770270273;5074;5082.847514574569;4782.856514304576;4897.142999975062;4916.483769204182;4921.9015619688125;4986.750662466935;4932.038252540864;4960.379952505937;4962.354893863775;4964.180910149929;4996.750162491933;4880.633952453509;4882.902341953212;4929.186684197068;4939.357883475125;4939.827106051271;4763.73799441034;4787.736674482937;4895.069936712013;4918.606511479002;5016.648834581544;4727.621790256702;4807.278908163804;4808.831690890802;4813.350197723403;4834.564889159852 06:05:54 INFO - PROCESS | 10433 | |1;ext.html;563.2002556369957;587.5886879184571;599.1641659884458;601.4316470934965;611.6758118197356;28321.15036548902;28843;30974.225644358874;41233.7938310308;41319;39836.203275934466;40325.39511907324;40354.192916141736;43590;43759.34360984588;7942.841143177133;8072.919270807275;8073.394495412838;8097.676092956304;8102.1492743262;7606.961965190194;10050.798984020315;10312.38125712456;10320.225983051263;10328.58685652573;9924;10014.349067310637;10020.448875311855;10293.382397056163;10293.53679084443;10135.797284054315;10250.436226007567;10250.487475626263;10251.384916904935;10252.641157559525;10134.037266459674;10207.591696332138;10231.079202871777;10233.488325583765;10252.538635761408;41899.37150942738;42446.57553424457;42479.57520424787;42482.36276455856;42504;3358.3115461330367;3394.7114495267933;3399.762016658835;3801.334766415866;3997.480327557428;30887.227819304473;31281.217969550715;31420.685793142005;31527.211819704462;32178.678213218038;3474.4961980512935;3569.6965757910607;3645.21379049476;3672.59601443841;3767.340715374826;269697;273486;273845;274994;275230.999999998;56682;56932.14601780977;57190.14214786782;57294;57402.425975740545;68391.65804171047;68673.31326686768;68827;68924.3107568928;69104;15061.774073388908;15660.608484787972;15665.60835979087;15673.216339182994;15675.686486270211;10172.745681357877;11009.889901100887;11153.609623663133;11247.718807029889;11284.548618055185;20973.58052838965;21076.367708968755;21198.36404907855;21207.515473916985;21246.78753212479;7556.811079723051;7716.575588342583;7733.785087127529;7818.8827167592535;7958.243966823143;841.995790021046;914.9359544831931;975.6780262513354;1028.2236911132047;1045.696747943088;28266;29288.707112929023;29373.85313073464;29391.853040735088;29554.113376598736;1017.0388982411698;1040.458961340099;1052.8578641883248;1053.394298278493;1163.3078318400537;14867.851321486864;15291.847081529042;15342.468492698803;15676.68646627084;15765.369385224692;397269;401316;401981;402705;402771;51860.48139518632;52309.47690523046;52443;52520;52587.47412525826;1178.2753606531921;1270.1490001698885;1271.0721173543366;1281.6923938254565;1320.4454129265732;28534.42931141324;29768.404631906807;29892.252693682833;29912.551311729905;30087.398252035273;43363.132737344444;43789.562104379824;44269.55730442654;44341;44438.55561444473;298961;300379;301935;302086;302560;33762.83118584391;34165.829170853984;34203.4869476963;34502.48246276258;35461.82269088638;43583.12833743371;44439;44510.332345014205;45243.09513809771;45436.54563454456;37485.62514374821;37504.81247593745;37937.43093853539;37952;38808.80595597004;37160.44259336058;38000.42999355067;38068.80965595154;38344.233115338095;38414.807925960195;36553.268934621694;37014.07464813293;37023.25953480861;37807.81096094502;37997.620023799405;33404.33191336111;33617;34315.31369372549;34493.13767155841;34518;25549.87225063937;25602.35994100088;25789.226323210332;25827.612585811603;26042.86978565095 06:05:54 INFO - PROCESS | 10433 | |2;jquery.html;386.91487872668006;388.87944737131494;391.02143155632484;393.1213737297142;415.2670536503073;12594.748105037894;13301.401436935337;16533.834661653378;17916.64166716665;17929.910350448245;15899.60250993723;16488.505344839643;17047.48857534273;17049;17513.91243043786;5092.312537807395;5183.118869792144;5222.451642577532;5237.423883372826;5279.868003299929;4965.28003439501;4981.875453113665;4987.251912213179;5011.498850114996;5117.897642047157;5198.090334191501;5230.267762513251;5232.4767523247565;5237.13587258102;5239.502247286502;5193.792248310101;5198.792048318062;5207.817726379559;5218.582513398919;5222.268882356473;4511.481179664348;4640.303954406866;4661.7669116544375;4663.207254766698;4683.367745354368;19868.503287417785;21149.15403383863;21442;21454;21472.89263553688;1801.0994502748626;1897.7153426985924;1926.1717461491553;2020.0404807716363;2086.238522939116;9636;9956.751081222956;10407.635732749317;10655.307405018726;13840.100393474391;1690.5604542818833;1691.0445598236956;1743.3723859410602;1763.2241813602102;1810.6469238498498;65960;67111.99332010024;67502.66248668774;69699.65150174216;69802.65098674526;10214.387136771817;10261.230407719451;10296.918823523572;10425.843612345669;10430.322029068238;13609.183448993092;13703.383347749375;13761.655958600915;13768.173909565458;13776.242306673028;7187.604681742554;7448.180700122982;7478.5138965967035;7561.848763024709;7562.508436951581;6971.8605627887155;6990.266022067712;7010.861687185356;7182.96408517954;7184.676689548983;4302.935455968163;4401.603855653007;4446.333050042519;4509.165804326144;4522.547745225451;1841.2911029253567;1873.8313551780404;1898.857585681052;1905.1236431241784;1920.4238728381429;850.4557083466586;943.1087622196958;951.3007939164709;953.2612225525273;1034.8706411698538;16598.502044938672;17205.655886882192;17318.39385621497;17342.65314693699;17495.669388765156;913.488446469979;929.3215952354819;932.4265576670299;964.6045121500151;1005.9647912323034;9391.436513809193;9772.609095636237;9869.309148359545;9892.25808064398;9987.700368988943;379220;399347;406906;407776;408223;50398;56058.439415605324;80996;81918;82072.58963705144;950.064186776025;952.9904700953041;956.1729104324709;959.2374062620233;974.9317547771587;15211.619709507351;15366.615834604225;15492.690146196788;15679.451219207273;15693.21533923322;28651;32870.178245544055;35595.64404356027;35648.64351356453;36994.8150259247;45198.32202516899;50924;51704.741476293886;51726.48273517217;52136;7760.301572858244;7937.880931786143;8007.3978691354505;8036.276735093869;8125.512469251864;8748.387612867038;11685.941570292094;12068.818967715315;12075.939620301842;12311.56909508163;10290.073893349634;10353.964603539585;10579.36523808574;10588.205884558534;10690.358578485315;10191.643292484727;10273.178145748472;10450.268481206547;10480.947595261974;10714.624988125379;10559.52482138321;10587.4706264688;10853.968872957372;10903.29128606638;10972.792992770948;7711.961440192763;7721.729739459092;7883.132855385788;7898.2891539761695;8133.715319963773;9882.85175722379;10448.843267351147;10454.372737635766;10459.372437653765;10820.945895270474 06:05:54 INFO - PROCESS | 10433 | |3;mootools.html;1335.8196643453132;1518.848115188481;1528.6636939873229;1705.624762552238;1885.7737071551408;7774.37804975602;8156.6737330506785;8202.015758109028;8372.079071302152;8400.579971001442;8153.429259951791;8289.295409890152;8294.129116442777;8307.50154990701;8313.709020184295;2278.8860556972168;2287.5996700577334;2303.6314189729646;2305.7117860267467;2309.284121922201;2280.794728474437;2305.400595845084;2337.8246631502707;2343.7070366204225;2346.2022912209845;2267.8639281643073;2272.1138755885218;2296.4144143243448;2302.4934514406805;2307.7346105197867;2218.367765186914;2231.62062449384;2237.6196046672103;2242.7196600424945;2244.551089782042;2214.346767703515;2217.057750456066;2218.7559368469456;2221.389117992549;2222.0334154642783;7945.483543569707;8087.31257843084;8177.264046235808;8222.8355432891;8231.300339471152;4718.528147185289;4800.15997200492;4804.279358096279;4806.735629540374;4815.0851338245975;2964.8072875263038;3008.4885569453027;3037.6202974628172;3039.088273517958;3074.784765066446;930.6928713524588;936.0966667166217;951.7240000399876;958.0323872888433;961.9951900240454;10723.517441715063;10744.194185436123;10801.83797243042;10895.400752958583;10897.67306980792;4125.876223713293;4249.213895429355;4297.162053399619;4352.368906508602;4353.69524133314;8567.700130495527;8569.48583085017;8592.613332400057;8609.354298427517;8610.052894181636;4583.4041574595085;4723;4726.976365118152;4730.101280756645;4740.28895665646;3702.4631428443263;4286.914261714811;4380.364847097153;4408.096340250241;4448.621867141264;3498.9475157872653;3570.7143428525656;3605.351036813346;3695.981520092382;3697.205100903265;1091.8744344400495;1094.813881640123;1118.7426891814766;1119.345183067898;1135.7160709822545;679.9592024478449;771.5563550958109;873.7509809704204;901.8647202919615;904.5703290936884;5528.032594296063;5541.2796336476;5689.857753556194;5726.341470730836;5797.536197104221;862.844687956174;876.6493402638868;888.5151012936873;909.2952961454926;915.9394346237093;3728.9627103728617;3845.4616353710503;3854.807259637007;3866.9806650966566;3907.199024200032;9646.614135434504;9798.951005244928;9892.455914924605;9907.356021858555;9940.055694708992;9457.054294570626;9762.121409073075;9794.167495762798;9794.461304628172;9799.902000979899;7285.526440781332;7586.962065189638;7612.733554325572;7621.580813055335;7639.083310002835;5426.891462170814;5451.264079349396;5451.48210919962;5727.8854422912145;5830.067189249869;8734.956325218332;9390.67132650354;9407.4825884577;9416.246700263826;9433;9279.814403712024;9284.442933424016;9389.014153513783;9486.33595648298;9558.235341172829;6914;6984.057152284377;7051.224365319913;7115.82210444743;7361.631918404166;7943.44395892282;7960.721374751856;8015.278624923785;8019.358451323764;8025.678972841021;5295.523402893758;6900.309969003059;6921.757738479129;7132.322429369409;7400.629968501661;6950.339717726808;6996.580205187705;7141.642917853983;7199.676014579251;7216.5670059796585;6704.7988560343265;6713.194416669836;6786.93213067863;6792.117024786746;6899.482538809509;4816.54242846929;4823.204171311834;4842.273658951185;4871.878203044952;4933.827316043921;4711.269753188261;4879.585235255043;4879.951200488092;4925.38432695913;4964.503549645006 06:05:54 INFO - PROCESS | 10433 | |4;prototype.html;319.1001376119343;320.150001745366;324.37557701424765;329.18198277280953;330.3195417440072;4756.38167038285;4823.734694591801;4826.276058591213;4844.418669759634;4870;4760.214564596838;4763.9272669128395;4788.0663270662235;4794.6266598033935;4795.136875362434;3638.6543278388513;3709.0727318170457;3741.8316175772156;3745.793981331026;3767.6797472214894;3432.1762776933483;3731.1791405890795;3751.6248375162404;3791.7345785795005;3804.7717136971733;3715.7213209009296;3752.174521605256;3760.8683696070507;3767.472553842464;3768.6608205261523;3625.329314076878;3760.868369607078;3763.397856342972;3770.472133901256;3779.4897688811934;3298.472244440902;3370.3933292007428;3374.958150319046;3384.932301353984;3389.610194827602;4542.591166795004;4542.613877820356;4552.135094332067;4563.726176429392;4578.88552786183;4290.592393722592;4291.184674911788;4292.957070429318;4293.592108749664;4324.351347297899;4741.928871066937;4964.15609346412;4971.925421118686;4980.975095124538;4996.7501624918605;3657.683234035745;3673.0266479382985;3691.169486865461;3692.8153592320277;3708.8887333380044;4944.110060189165;4977.875553111129;5130.050940576006;5174.611904107207;5197.66215196011;3742.232842267383;3761.567419746709;3780.4896338993885;3781.9810900945317;3785.6592906638534;3829.4447305140598;3830.812448141085;3835.558910725302;3845.9807700961314;3870.806459677005;4289.270823959934;4289.520115560127;4315.050688848449;4332.328489084197;4333.8699839004885;4863.975680121577;4885.487023862514;4991.700497970133;5000.39995200571;5015.724135172601;1321.8631976500203;1325.2909693314032;1330.314887832767;1334.6463187255385;1340.2092765268537;855.5080828523623;881.1408876345512;883.1786438612153;893.3478560650761;894.2086253665553;4013.4581831452965;4015.819288132041;4017.879463616096;4019.9196016079513;4020.43713880057;4579.656525760582;4581.221192397301;4584.15193189261;4595.93106103402;4618.2841659542155;4014.6714905354825;4017.91964160721;4042.292598795199;4046.615571520701;4065.10567675111;2466.9136580219606;2541.6187571863998;2713.606527053566;2758.7930905182193;2765.2395591212176;4857.514248575114;4858.684185527929;4865.537773911473;4913.582345500601;4919.139150648693;5134.150546446684;5197.792088316425;5217.426083130853;5258.342707161605;5260.63319475536;4853.781579828846;4858.222684370625;4870.342503762088;4888.9488759916785;4905.166121759309;5137.845864624067;5149.498341128069;5159.690418574897;5166;5169.715665638426;4829.1890541047105;5000.724960127228;5039.571636410946;5040.924386134137;5073.061483625541;4565.109803588269;4729.314249433882;4879.56083952446;4901.117798796108;4904.509549045067;3687.1519550503;3692.298463291966;3698.354232366571;3700.093477098128;3700.389435743072;5070.3155074064525;5096.541311282002;5121.359830021247;5137.2037334213255;5140.820071297487;4819.759012049453;4866.024108265395;4897.632677549127;4923.778429970732;4930.408350997904;4934.963657631937;4939.185034469416;4957.652964292465;4960.454350021422;4960.875978100432;4888.462269150319;4888.755562221946;4899.240617704261;4900.828471003498;4902.975485122694;4848.9757551212015;4897.95102048975;5009.895843745563;5014.34813474246;5014.398272207212;4839.733814640088;4848.109237397488;4885.511448855228;4922.803087876445;4930.802767889244 06:05:54 INFO - PROCESS | 10433 | |5;yui.html;662.8873091574432;784.7253461288553;787.4291138924277;787.9606019699014;801.5751651624637;10592.894071059296;11092.889071109286;11129.054030407406;11143.108551315905;11154.498047587858;11945.701357466067;12539;12545.996320294378;12601.747965040693;12626.494940202381;863.1670438027287;873.4715497124243;877.8990416102166;878.8066625342447;879.6349514951288;861.3066481482405;864.5849992003842;864.8962124545031;865.3077537969631;866.4281574161055;914.3690853311194;914.4467597103757;914.7575892388522;915.9450432974043;917.0004694882576;903.7876099116702;903.814717982812;903.9638414463413;904.2268860124598;904.2991681446865;670.1589505171028;670.9731610735565;671.3353779758053;671.4359937652396;672.0758956434902;10010.349327293703;10197.082262596401;10205.897941020568;10206.897931020669;10219.080282774587;10155.187584993182;10259.17926565873;10378.11785998191;10393.9480302598;10802.945985270102;9001.099890010946;9017.504037277948;9076.137766912132;9239.214666753334;9274.629014839398;3175.6030496187977;3211.8167802257967;3266.6080070391467;3281.6718328166994;3357.865685372582;42878.14243715139;46786.53213467856;47072.52927470716;47075.05849883017;47114.76442617765;9526.476043817518;9763.414195148314;9929.751756206153;10217.540210690537;10466.947665261625;17604.91197544004;17742.822571774374;17750.46748597544;17775.111244437983;17982.2807087715;6255;6513.576617519846;6932.7226910923;7056.6118863463;7175.103112110986;3566.2154326048226;3610.9638903610626;3643.3441980443777;3652.415613501827;3653.104989277591;2745.272502786763;2869.626948496724;2870.9712902870706;2873;2875.25243436708;523.8271370447743;536.5466181076984;544.6731960823554;555.6221769196904;557.7462254674114;519.9688018718889;595.7289433307834;617.561531312764;623.1400667079402;685.530411668009;6631.204255489276;6757.763478278335;6803.727850886008;6893;6893.586384816927;491.2410326046267;504.2537045173164;590.4095904095905;597.9983527591268;603.9094135879653;3965.40518922164;4087.713860029829;4151.14901445203;4162.771047592351;4194.077302993336;56269;56632.433675662716;57059.14411283834;57419;57768.71115644395;36874.63125368766;49203.753981229864;52028.47971520312;52062.21906671403;54576.181357279675;47397.289040664415;48092.519074809505;48654.51345486571;48698;48723.5127648719;8405.369597280107;8775.473471591726;8974.775630609287;9014.008459069628;9148.222401095982;31548.526772098896;32095.679043209268;32283.677163229007;32357.838210808794;33103.33793324168;38661;40004.79997599994;42356.788216058725;42389.15221695487;42774.35838462488;10858.511366988347;11354.489047993025;11389.544418223179;11464.885351146382;11501.53993840237;12064.879351206726;12175.33035683046;12299.077569182526;12424.627261182179;12854.421551030413;11622.418879056182;11901.285922844658;12019.338936358585;12089.274643521418;12641.747165056831;11585.536578536765;12006.63980080599;12240.265584064984;12605.558805441766;12881.613551593467;11525.769484610428;11632.592859249886;11767.470463828977;11806.940965295118;12214.022878169902;9947.900520994697;9988.200943924323;10085.243606729378;10168.796624067625;10242.846357304497;9541.284403669613;9608.471534065415;9614.855777163208;9623.470709111067;9676.70969870905 06:05:54 INFO - PROCESS | 10433 | __end_tp_report 06:05:54 INFO - PROCESS | 10433 | __start_cc_report 06:05:54 INFO - PROCESS | 10433 | _x_x_mozilla_cycle_collect,1169 06:05:54 INFO - PROCESS | 10433 | __end_cc_report 06:05:54 INFO - PROCESS | 10433 | __startTimestamp1463403954855__endTimestamp 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | ------- Summary: start ------- 06:05:54 INFO - PROCESS | 10433 | Number of tests: 6 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#0] dojo.html Cycles:165 Average:4656.87 Median:4790.47 stddev:487.00 (10.2%) stddev-sans-first:462.52 06:05:54 INFO - PROCESS | 10433 | Values: 2656.6 2685.2 2716.9 2728.2 2729.3 4570.0 4605.8 4685.7 4771.2 4807.2 4679.7 4687.6 4694.7 4726.6 4734.5 4278.6 4338.8 4374.0 4408.6 4475.1 4349.3 4372.3 4378.1 4401.9 4428.3 4218.5 4254.3 4291.0 4333.6 4349.6 4250.7 4260.7 4263.9 4365.5 4448.3 4303.5 4310.5 4317.5 4321.3 4350.5 4409.5 4488.9 4544.3 4544.9 4578.2 5032.0 5043.0 5044.6 5045.6 5051.2 4973.3 4986.4 5013.2 5024.6 5027.0 4590.3 4642.5 4715.9 4717.1 4737.9 5205.1 5216.4 5228.9 5230.1 5237.3 4951.4 4964.8 5003.0 5011.1 5024.7 4934.2 5008.0 5042.5 5054.7 5076.6 4987.7 5004.6 5020.2 5027.2 5073.6 4865.6 4994.0 5008.2 5011.2 5012.5 4120.8 4131.2 4154.2 4164.8 4221.5 3673.8 3689.9 3698.4 3734.6 3738.5 4351.2 4356.2 4357.4 4398.4 4401.3 4883.7 5060.7 5080.9 5101.8 5106.5 4380.8 4386.5 4393.3 4396.4 4443.2 4390.9 4566.7 4568.0 4571.1 4600.0 4763.8 4797.3 4806.2 4808.1 4816.4 5028.3 5085.3 5102.8 5104.0 5166.2 4612.0 4774.4 4778.4 4790.5 4835.2 4978.6 5000.1 5002.8 5034.6 5040.6 5048.4 5064.3 5071.8 5074.0 5082.8 4782.9 4897.1 4916.5 4921.9 4986.8 4932.0 4960.4 4962.4 4964.2 4996.8 4880.6 4882.9 4929.2 4939.4 4939.8 4763.7 4787.7 4895.1 4918.6 5016.6 4727.6 4807.3 4808.8 4813.4 4834.6 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#1] ext.html Cycles:180 Average:49689.01 Median:34259.40 stddev:86616.06 (252.8%) stddev-sans-first:86780.50 06:05:54 INFO - PROCESS | 10433 | Values: 563.2 587.6 599.2 601.4 611.7 28321.2 28843.0 30974.2 41233.8 41319.0 39836.2 40325.4 40354.2 43590.0 43759.3 7942.8 8072.9 8073.4 8097.7 8102.1 7607.0 10050.8 10312.4 10320.2 10328.6 9924.0 10014.3 10020.4 10293.4 10293.5 10135.8 10250.4 10250.5 10251.4 10252.6 10134.0 10207.6 10231.1 10233.5 10252.5 41899.4 42446.6 42479.6 42482.4 42504.0 3358.3 3394.7 3399.8 3801.3 3997.5 30887.2 31281.2 31420.7 31527.2 32178.7 3474.5 3569.7 3645.2 3672.6 3767.3 269697.0 273486.0 273845.0 274994.0 275231.0 56682.0 56932.1 57190.1 57294.0 57402.4 68391.7 68673.3 68827.0 68924.3 69104.0 15061.8 15660.6 15665.6 15673.2 15675.7 10172.7 11009.9 11153.6 11247.7 11284.5 20973.6 21076.4 21198.4 21207.5 21246.8 7556.8 7716.6 7733.8 7818.9 7958.2 842.0 914.9 975.7 1028.2 1045.7 28266.0 29288.7 29373.9 29391.9 29554.1 1017.0 1040.5 1052.9 1053.4 1163.3 14867.9 15291.8 15342.5 15676.7 15765.4 397269.0 401316.0 401981.0 402705.0 402771.0 51860.5 52309.5 52443.0 52520.0 52587.5 1178.3 1270.1 1271.1 1281.7 1320.4 28534.4 29768.4 29892.3 29912.6 30087.4 43363.1 43789.6 44269.6 44341.0 44438.6 298961.0 300379.0 301935.0 302086.0 302560.0 33762.8 34165.8 34203.5 34502.5 35461.8 43583.1 44439.0 44510.3 45243.1 45436.5 37485.6 37504.8 37937.4 37952.0 38808.8 37160.4 38000.4 38068.8 38344.2 38414.8 36553.3 37014.1 37023.3 37807.8 37997.6 33404.3 33617.0 34315.3 34493.1 34518.0 25549.9 25602.4 25789.2 25827.6 26042.9 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#2] jquery.html Cycles:180 Average:24339.58 Median:407999.50 stddev:65903.77 (16.2%) stddev-sans-first:66064.11 06:05:54 INFO - PROCESS | 10433 | Values: 386.9 388.9 391.0 393.1 415.3 12594.7 13301.4 16533.8 17916.6 17929.9 15899.6 16488.5 17047.5 17049.0 17513.9 5092.3 5183.1 5222.5 5237.4 5279.9 4965.3 4981.9 4987.3 5011.5 5117.9 5198.1 5230.3 5232.5 5237.1 5239.5 5193.8 5198.8 5207.8 5218.6 5222.3 4511.5 4640.3 4661.8 4663.2 4683.4 19868.5 21149.2 21442.0 21454.0 21472.9 1801.1 1897.7 1926.2 2020.0 2086.2 9636.0 9956.8 10407.6 10655.3 13840.1 1690.6 1691.0 1743.4 1763.2 1810.6 65960.0 67112.0 67502.7 69699.7 69802.7 10214.4 10261.2 10296.9 10425.8 10430.3 13609.2 13703.4 13761.7 13768.2 13776.2 7187.6 7448.2 7478.5 7561.8 7562.5 6971.9 6990.3 7010.9 7183.0 7184.7 4302.9 4401.6 4446.3 4509.2 4522.5 1841.3 1873.8 1898.9 1905.1 1920.4 850.5 943.1 951.3 953.3 1034.9 16598.5 17205.7 17318.4 17342.7 17495.7 913.5 929.3 932.4 964.6 1006.0 9391.4 9772.6 9869.3 9892.3 9987.7 379220.0 399347.0 406906.0 407776.0 408223.0 50398.0 56058.4 80996.0 81918.0 82072.6 950.1 953.0 956.2 959.2 974.9 15211.6 15366.6 15492.7 15679.5 15693.2 28651.0 32870.2 35595.6 35648.6 36994.8 45198.3 50924.0 51704.7 51726.5 52136.0 7760.3 7937.9 8007.4 8036.3 8125.5 8748.4 11685.9 12068.8 12075.9 12311.6 10290.1 10354.0 10579.4 10588.2 10690.4 10191.6 10273.2 10450.3 10480.9 10714.6 10559.5 10587.5 10854.0 10903.3 10972.8 7712.0 7721.7 7883.1 7898.3 8133.7 9882.9 10448.8 10454.4 10459.4 10820.9 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#3] mootools.html Cycles:180 Average:5323.58 Median:5615.57 stddev:2952.48 (52.6%) stddev-sans-first:2945.55 06:05:54 INFO - PROCESS | 10433 | Values: 1335.8 1518.8 1528.7 1705.6 1885.8 7774.4 8156.7 8202.0 8372.1 8400.6 8153.4 8289.3 8294.1 8307.5 8313.7 2278.9 2287.6 2303.6 2305.7 2309.3 2280.8 2305.4 2337.8 2343.7 2346.2 2267.9 2272.1 2296.4 2302.5 2307.7 2218.4 2231.6 2237.6 2242.7 2244.6 2214.3 2217.1 2218.8 2221.4 2222.0 7945.5 8087.3 8177.3 8222.8 8231.3 4718.5 4800.2 4804.3 4806.7 4815.1 2964.8 3008.5 3037.6 3039.1 3074.8 930.7 936.1 951.7 958.0 962.0 10723.5 10744.2 10801.8 10895.4 10897.7 4125.9 4249.2 4297.2 4352.4 4353.7 8567.7 8569.5 8592.6 8609.4 8610.1 4583.4 4723.0 4727.0 4730.1 4740.3 3702.5 4286.9 4380.4 4408.1 4448.6 3498.9 3570.7 3605.4 3696.0 3697.2 1091.9 1094.8 1118.7 1119.3 1135.7 680.0 771.6 873.8 901.9 904.6 5528.0 5541.3 5689.9 5726.3 5797.5 862.8 876.6 888.5 909.3 915.9 3729.0 3845.5 3854.8 3867.0 3907.2 9646.6 9799.0 9892.5 9907.4 9940.1 9457.1 9762.1 9794.2 9794.5 9799.9 7285.5 7587.0 7612.7 7621.6 7639.1 5426.9 5451.3 5451.5 5727.9 5830.1 8735.0 9390.7 9407.5 9416.2 9433.0 9279.8 9284.4 9389.0 9486.3 9558.2 6914.0 6984.1 7051.2 7115.8 7361.6 7943.4 7960.7 8015.3 8019.4 8025.7 5295.5 6900.3 6921.8 7132.3 7400.6 6950.3 6996.6 7141.6 7199.7 7216.6 6704.8 6713.2 6786.9 6792.1 6899.5 4816.5 4823.2 4842.3 4871.9 4933.8 4711.3 4879.6 4880.0 4925.4 4964.5 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#4] prototype.html Cycles:180 Average:4123.74 Median:4673.80 stddev:1172.44 (25.1%) stddev-sans-first:1140.42 06:05:54 INFO - PROCESS | 10433 | Values: 319.1 320.2 324.4 329.2 330.3 4756.4 4823.7 4826.3 4844.4 4870.0 4760.2 4763.9 4788.1 4794.6 4795.1 3638.7 3709.1 3741.8 3745.8 3767.7 3432.2 3731.2 3751.6 3791.7 3804.8 3715.7 3752.2 3760.9 3767.5 3768.7 3625.3 3760.9 3763.4 3770.5 3779.5 3298.5 3370.4 3375.0 3384.9 3389.6 4542.6 4542.6 4552.1 4563.7 4578.9 4290.6 4291.2 4293.0 4293.6 4324.4 4741.9 4964.2 4971.9 4981.0 4996.8 3657.7 3673.0 3691.2 3692.8 3708.9 4944.1 4977.9 5130.1 5174.6 5197.7 3742.2 3761.6 3780.5 3782.0 3785.7 3829.4 3830.8 3835.6 3846.0 3870.8 4289.3 4289.5 4315.1 4332.3 4333.9 4864.0 4885.5 4991.7 5000.4 5015.7 1321.9 1325.3 1330.3 1334.6 1340.2 855.5 881.1 883.2 893.3 894.2 4013.5 4015.8 4017.9 4019.9 4020.4 4579.7 4581.2 4584.2 4595.9 4618.3 4014.7 4017.9 4042.3 4046.6 4065.1 2466.9 2541.6 2713.6 2758.8 2765.2 4857.5 4858.7 4865.5 4913.6 4919.1 5134.2 5197.8 5217.4 5258.3 5260.6 4853.8 4858.2 4870.3 4888.9 4905.2 5137.8 5149.5 5159.7 5166.0 5169.7 4829.2 5000.7 5039.6 5040.9 5073.1 4565.1 4729.3 4879.6 4901.1 4904.5 3687.2 3692.3 3698.4 3700.1 3700.4 5070.3 5096.5 5121.4 5137.2 5140.8 4819.8 4866.0 4897.6 4923.8 4930.4 4935.0 4939.2 4957.7 4960.5 4960.9 4888.5 4888.8 4899.2 4900.8 4903.0 4849.0 4898.0 5009.9 5014.3 5014.4 4839.7 4848.1 4885.5 4922.8 4930.8 06:05:54 INFO - PROCESS | 10433 | 06:05:54 INFO - PROCESS | 10433 | [#5] yui.html Cycles:180 Average:13260.67 Median:47256.03 stddev:15584.77 (33.0%) stddev-sans-first:15599.77 06:05:54 INFO - PROCESS | 10433 | Values: 662.9 784.7 787.4 788.0 801.6 10592.9 11092.9 11129.1 11143.1 11154.5 11945.7 12539.0 12546.0 12601.7 12626.5 863.2 873.5 877.9 878.8 879.6 861.3 864.6 864.9 865.3 866.4 914.4 914.4 914.8 915.9 917.0 903.8 903.8 904.0 904.2 904.3 670.2 671.0 671.3 671.4 672.1 10010.3 10197.1 10205.9 10206.9 10219.1 10155.2 10259.2 10378.1 10393.9 10802.9 9001.1 9017.5 9076.1 9239.2 9274.6 3175.6 3211.8 3266.6 3281.7 3357.9 42878.1 46786.5 47072.5 47075.1 47114.8 9526.5 9763.4 9929.8 10217.5 10466.9 17604.9 17742.8 17750.5 17775.1 17982.3 6255.0 6513.6 6932.7 7056.6 7175.1 3566.2 3611.0 3643.3 3652.4 3653.1 2745.3 2869.6 2871.0 2873.0 2875.3 523.8 536.5 544.7 555.6 557.7 520.0 595.7 617.6 623.1 685.5 6631.2 6757.8 6803.7 6893.0 6893.6 491.2 504.3 590.4 598.0 603.9 3965.4 4087.7 4151.1 4162.8 4194.1 56269.0 56632.4 57059.1 57419.0 57768.7 36874.6 49203.8 52028.5 52062.2 54576.2 47397.3 48092.5 48654.5 48698.0 48723.5 8405.4 8775.5 8974.8 9014.0 9148.2 31548.5 32095.7 32283.7 32357.8 33103.3 38661.0 40004.8 42356.8 42389.2 42774.4 10858.5 11354.5 11389.5 11464.9 11501.5 12064.9 12175.3 12299.1 12424.6 12854.4 11622.4 11901.3 12019.3 12089.3 12641.7 11585.5 12006.6 12240.3 12605.6 12881.6 11525.8 11632.6 11767.5 11806.9 12214.0 9947.9 9988.2 10085.2 10168.8 10242.8 9541.3 9608.5 9614.9 9623.5 9676.7 06:05:54 INFO - PROCESS | 10433 | -------- Summary: end -------- 06:05:54 INFO - PROCESS | 10433 | 06:05:55 INFO - TEST-INFO | 10433: exit 0 06:05:55 INFO - TEST-OK | dromaeo_css | took 1118949ms 06:05:55 INFO - TEST-START | kraken 06:05:55 INFO - operating with platform_type : linux_ 06:05:55 INFO - Initialising browser for kraken test... 06:05:55 INFO - TEST-INFO | started process 10609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBh4Om/profile http://localhost:56936/getInfo.html) 06:05:59 INFO - PROCESS | 10609 | __metrics Screen width/height:1600/1200 06:05:59 INFO - PROCESS | 10609 | colorDepth:24 06:05:59 INFO - PROCESS | 10609 | Browser inner width/height: 1024/697 06:05:59 INFO - PROCESS | 10609 | __metrics 06:06:00 ERROR - PROCESS | 10609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:06:01 INFO - TEST-INFO | 10609: exit 0 06:06:01 INFO - Browser initialized. 06:06:01 INFO - Running cycle 1/1 for kraken test... 06:06:01 INFO - TEST-INFO | started process 10690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBh4Om/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:13 INFO - PROCESS | 10690 | RSS: Main: 154730496 06:06:13 INFO - PROCESS | 10690 | 06:06:16 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:17 INFO - PROCESS | 10690 | RSS: Main: 209416192 06:06:17 INFO - PROCESS | 10690 | 06:06:20 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-dft) 06:06:20 INFO - PROCESS | 10690 | RSS: Main: 198242304 06:06:20 INFO - PROCESS | 10690 | 06:06:24 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-fft) 06:06:24 INFO - PROCESS | 10690 | RSS: Main: 266555392 06:06:24 INFO - PROCESS | 10690 | 06:06:27 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-oscillator) 06:06:27 INFO - PROCESS | 10690 | RSS: Main: 175923200 06:06:27 INFO - PROCESS | 10690 | 06:06:30 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:30 INFO - PROCESS | 10690 | RSS: Main: 179904512 06:06:30 INFO - PROCESS | 10690 | 06:06:34 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:34 INFO - PROCESS | 10690 | RSS: Main: 215719936 06:06:34 INFO - PROCESS | 10690 | 06:06:38 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:38 INFO - PROCESS | 10690 | RSS: Main: 215236608 06:06:38 INFO - PROCESS | 10690 | 06:06:42 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56936/tests/kraken/driver.html?testName=json-parse-financial) 06:06:42 INFO - PROCESS | 10690 | RSS: Main: 214859776 06:06:42 INFO - PROCESS | 10690 | 06:06:44 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:45 INFO - PROCESS | 10690 | RSS: Main: 210272256 06:06:45 INFO - PROCESS | 10690 | 06:06:47 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:47 INFO - PROCESS | 10690 | RSS: Main: 211554304 06:06:47 INFO - PROCESS | 10690 | 06:06:49 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:50 INFO - PROCESS | 10690 | RSS: Main: 216059904 06:06:50 INFO - PROCESS | 10690 | 06:06:53 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:54 INFO - PROCESS | 10690 | RSS: Main: 219836416 06:06:54 INFO - PROCESS | 10690 | 06:06:57 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:57 INFO - PROCESS | 10690 | RSS: Main: 219324416 06:06:57 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56936/tests/kraken/driver.html?testName=ai-astar) 06:06:59 INFO - PROCESS | 10690 | RSS: Main: 266444800 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | __start_tp_report 06:06:59 INFO - PROCESS | 10690 | _x_x_mozilla_page_load 06:06:59 INFO - PROCESS | 10690 | _x_x_mozilla_page_load_details 06:06:59 INFO - PROCESS | 10690 | |i|pagename|runs| 06:06:59 INFO - PROCESS | 10690 | |0;ai-astar;113;107;113;113;112;115;112;112;113;112 06:06:59 INFO - PROCESS | 10690 | |1;audio-beat-detection;178;131;152;209;131;168;160;139;184;130 06:06:59 INFO - PROCESS | 10690 | |2;audio-dft;160;161;162;160;160;161;162;161;160;160 06:06:59 INFO - PROCESS | 10690 | |3;audio-fft;75;76;76;151;76;75;79;75;132;78 06:06:59 INFO - PROCESS | 10690 | |4;audio-oscillator;92;93;167;92;92;92;133;92;92;128 06:06:59 INFO - PROCESS | 10690 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;116;116 06:06:59 INFO - PROCESS | 10690 | |6;imaging-darkroom;145;146;145;145;145;146;146;146;145;146 06:06:59 INFO - PROCESS | 10690 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 06:06:59 INFO - PROCESS | 10690 | |8;json-parse-financial;66;64;68;64;65;64;65;66;65;65 06:06:59 INFO - PROCESS | 10690 | |9;json-stringify-tinderbox;64;64;64;63;64;64;64;64;64;65 06:06:59 INFO - PROCESS | 10690 | |10;stanford-crypto-aes;82;82;89;82;81;83;82;88;164;83 06:06:59 INFO - PROCESS | 10690 | |11;stanford-crypto-ccm;132;132;138;128;130;129;126;130;152;133 06:06:59 INFO - PROCESS | 10690 | |12;stanford-crypto-pbkdf2;170;171;172;171;169;172;175;174;169;175 06:06:59 INFO - PROCESS | 10690 | |13;stanford-crypto-sha256-iterative;67;72;68;69;68;67;67;64;64;66 06:06:59 INFO - PROCESS | 10690 | __end_tp_report 06:06:59 INFO - PROCESS | 10690 | __start_cc_report 06:06:59 INFO - PROCESS | 10690 | _x_x_mozilla_cycle_collect,2095 06:06:59 INFO - PROCESS | 10690 | __end_cc_report 06:06:59 INFO - PROCESS | 10690 | __startTimestamp1463404019708__endTimestamp 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | ------- Summary: start ------- 06:06:59 INFO - PROCESS | 10690 | Number of tests: 14 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.04 (1.8%) stddev-sans-first:2.15 06:06:59 INFO - PROCESS | 10690 | Values: 113.0 107.0 113.0 113.0 112.0 115.0 112.0 112.0 113.0 112.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#1] audio-beat-detection Cycles:10 Average:158.20 Median:164.00 stddev:26.71 (16.3%) stddev-sans-first:27.35 06:06:59 INFO - PROCESS | 10690 | Values: 178.0 131.0 152.0 209.0 131.0 168.0 160.0 139.0 184.0 130.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 06:06:59 INFO - PROCESS | 10690 | Values: 160.0 161.0 162.0 160.0 160.0 161.0 162.0 161.0 160.0 160.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:27.90 (36.7%) stddev-sans-first:29.11 06:06:59 INFO - PROCESS | 10690 | Values: 75.0 76.0 76.0 151.0 76.0 75.0 79.0 75.0 132.0 78.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:92.00 stddev:26.38 (28.7%) stddev-sans-first:27.39 06:06:59 INFO - PROCESS | 10690 | Values: 92.0 93.0 167.0 92.0 92.0 92.0 133.0 92.0 92.0 128.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:06:59 INFO - PROCESS | 10690 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:06:59 INFO - PROCESS | 10690 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:06:59 INFO - PROCESS | 10690 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 06:06:59 INFO - PROCESS | 10690 | Values: 66.0 64.0 68.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 06:06:59 INFO - PROCESS | 10690 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 65.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:82.50 stddev:25.58 (31.0%) stddev-sans-first:26.90 06:06:59 INFO - PROCESS | 10690 | Values: 82.0 82.0 89.0 82.0 81.0 83.0 82.0 88.0 164.0 83.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:132.00 stddev:7.42 (5.6%) stddev-sans-first:7.87 06:06:59 INFO - PROCESS | 10690 | Values: 132.0 132.0 138.0 128.0 130.0 129.0 126.0 130.0 152.0 133.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:2.25 (1.3%) stddev-sans-first:2.29 06:06:59 INFO - PROCESS | 10690 | Values: 170.0 171.0 172.0 171.0 169.0 172.0 175.0 174.0 169.0 175.0 06:06:59 INFO - PROCESS | 10690 | 06:06:59 INFO - PROCESS | 10690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.35 (3.5%) stddev-sans-first:2.49 06:06:59 INFO - PROCESS | 10690 | Values: 67.0 72.0 68.0 69.0 68.0 67.0 67.0 64.0 64.0 66.0 06:06:59 INFO - PROCESS | 10690 | -------- Summary: end -------- 06:06:59 INFO - PROCESS | 10690 | 06:07:00 INFO - TEST-INFO | 10690: exit 0 06:07:00 INFO - TEST-OK | kraken | took 65090ms 06:07:00 INFO - SUITE-END | took 1184s 06:07:00 INFO - Completed test suite (00:19:44) 06:07:00 INFO - javascript benchmark 06:07:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2656.614790855326, 2685.194441667502, 2716.904908328209, 2728.208819442362, 2729.304027472995, 4570.0, 4605.815767369301, 4685.718856868591, 4771.236602143662, 4807.1587472192405, 4679.695819771721, 4687.578117969382, 4694.741789201593, 4726.550977657125, 4734.502877197896, 4278.57214278572, 4338.804753786071, 4374.015846434542, 4408.647308215351, 4475.149721552911, 4349.282368409209, 4372.256716358227, 4378.10248898975, 4401.911961760763, 4428.269335559645, 4218.472690913636, 4254.298040823261, 4290.957090429102, 4333.58830911063, 4349.608535231812, 4250.681198910063, 4260.68044896634, 4263.893402664927, 4365.454318210223, 4448.288273876196, 4303.505096913864, 4310.48274207094, 4317.4819021717285, 4321.308590625485, 4350.456192975878, 4409.470863496369, 4488.865334039984, 4544.341070544786, 4544.863654090383, 4578.198815207359, 5031.974840125776, 5043.041822053798, 5044.571211447032, 5045.64680472367, 5051.166557518005, 4973.3286006389035, 4986.40163180417, 5013.248012798073, 5024.648274620778, 5026.974865125651, 4590.265557510782, 4642.53574642533, 4715.905681886343, 4717.127331443694, 4737.9289310660715, 5205.063088644005, 5216.426193118754, 5228.869278267997, 5230.137027390514, 5237.319148510669, 4951.356323677899, 4964.801407943714, 5003.0, 5011.0980023595375, 5024.698518088926, 4934.235193545006, 5007.974960125249, 5042.546170844642, 5054.747262636927, 5076.6192535559985, 4987.700737955734, 5004.599632029429, 5020.171671674206, 5027.245913113063, 5073.644844860898, 4865.56209941107, 4994.0, 5008.199572628365, 5011.248312753116, 5012.548870601663, 4120.773357465308, 4131.194417088699, 4154.210699967057, 4164.75011499311, 4221.472315960505, 3673.7612055216327, 3689.870854520079, 3698.3527882620433, 3734.57052438973, 3738.476613274144, 4351.19502891966, 4356.150550642657, 4357.43353364067, 4398.406215160976, 4401.2517871961845, 4883.658143929891, 5060.696358218519, 5080.949190508048, 5101.770420331094, 5106.514881086291, 4380.759058251763, 4386.473623165177, 4393.340998850134, 4396.384506169139, 4443.244648409778, 4390.934135987963, 4566.657500687462, 4567.954320456819, 4571.085782843445, 4600.0, 4763.809447622057, 4797.280407938698, 4806.206975848946, 4808.1345357834525, 4816.397950256218, 5028.270900719302, 5085.288059671723, 5102.821401250939, 5104.033801020313, 5166.225066240094, 4612.031473390625, 4774.40319960005, 4778.354922085613, 4790.473047964791, 4835.20219163834, 4978.626603004862, 5000.099982003274, 5002.824901128589, 5034.597232221487, 5040.57155141817, 5048.419431765247, 5064.341635587498, 5071.771770270273, 5074.0, 5082.847514574569, 4782.856514304576, 4897.142999975062, 4916.483769204182, 4921.9015619688125, 4986.750662466935, 4932.038252540864, 4960.379952505937, 4962.354893863775, 4964.180910149929, 4996.750162491933, 4880.633952453509, 4882.902341953212, 4929.186684197068, 4939.357883475125, 4939.827106051271, 4763.73799441034, 4787.736674482937, 4895.069936712013, 4918.606511479002, 5016.648834581544, 4727.621790256702, 4807.278908163804, 4808.831690890802, 4813.350197723403, 4834.564889159852], "value": 4626.488222101876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2002556369957, 587.5886879184571, 599.1641659884458, 601.4316470934965, 611.6758118197356, 28321.15036548902, 28843.0, 30974.225644358874, 41233.7938310308, 41319.0, 39836.203275934466, 40325.39511907324, 40354.192916141736, 43590.0, 43759.34360984588, 7942.841143177133, 8072.919270807275, 8073.394495412838, 8097.676092956304, 8102.1492743262, 7606.961965190194, 10050.798984020315, 10312.38125712456, 10320.225983051263, 10328.58685652573, 9924.0, 10014.349067310637, 10020.448875311855, 10293.382397056163, 10293.53679084443, 10135.797284054315, 10250.436226007567, 10250.487475626263, 10251.384916904935, 10252.641157559525, 10134.037266459674, 10207.591696332138, 10231.079202871777, 10233.488325583765, 10252.538635761408, 41899.37150942738, 42446.57553424457, 42479.57520424787, 42482.36276455856, 42504.0, 3358.3115461330367, 3394.7114495267933, 3399.762016658835, 3801.334766415866, 3997.480327557428, 30887.227819304473, 31281.217969550715, 31420.685793142005, 31527.211819704462, 32178.678213218038, 3474.4961980512935, 3569.6965757910607, 3645.21379049476, 3672.59601443841, 3767.340715374826, 269697.0, 273486.0, 273845.0, 274994.0, 275230.999999998, 56682.0, 56932.14601780977, 57190.14214786782, 57294.0, 57402.425975740545, 68391.65804171047, 68673.31326686768, 68827.0, 68924.3107568928, 69104.0, 15061.774073388908, 15660.608484787972, 15665.60835979087, 15673.216339182994, 15675.686486270211, 10172.745681357877, 11009.889901100887, 11153.609623663133, 11247.718807029889, 11284.548618055185, 20973.58052838965, 21076.367708968755, 21198.36404907855, 21207.515473916985, 21246.78753212479, 7556.811079723051, 7716.575588342583, 7733.785087127529, 7818.8827167592535, 7958.243966823143, 841.995790021046, 914.9359544831931, 975.6780262513354, 1028.2236911132047, 1045.696747943088, 28266.0, 29288.707112929023, 29373.85313073464, 29391.853040735088, 29554.113376598736, 1017.0388982411698, 1040.458961340099, 1052.8578641883248, 1053.394298278493, 1163.3078318400537, 14867.851321486864, 15291.847081529042, 15342.468492698803, 15676.68646627084, 15765.369385224692, 397269.0, 401316.0, 401981.0, 402705.0, 402771.0, 51860.48139518632, 52309.47690523046, 52443.0, 52520.0, 52587.47412525826, 1178.2753606531921, 1270.1490001698885, 1271.0721173543366, 1281.6923938254565, 1320.4454129265732, 28534.42931141324, 29768.404631906807, 29892.252693682833, 29912.551311729905, 30087.398252035273, 43363.132737344444, 43789.562104379824, 44269.55730442654, 44341.0, 44438.55561444473, 298961.0, 300379.0, 301935.0, 302086.0, 302560.0, 33762.83118584391, 34165.829170853984, 34203.4869476963, 34502.48246276258, 35461.82269088638, 43583.12833743371, 44439.0, 44510.332345014205, 45243.09513809771, 45436.54563454456, 37485.62514374821, 37504.81247593745, 37937.43093853539, 37952.0, 38808.80595597004, 37160.44259336058, 38000.42999355067, 38068.80965595154, 38344.233115338095, 38414.807925960195, 36553.268934621694, 37014.07464813293, 37023.25953480861, 37807.81096094502, 37997.620023799405, 33404.33191336111, 33617.0, 34315.31369372549, 34493.13767155841, 34518.0, 25549.87225063937, 25602.35994100088, 25789.226323210332, 25827.612585811603, 26042.86978565095], "value": 19082.614484065205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.91487872668006, 388.87944737131494, 391.02143155632484, 393.1213737297142, 415.2670536503073, 12594.748105037894, 13301.401436935337, 16533.834661653378, 17916.64166716665, 17929.910350448245, 15899.60250993723, 16488.505344839643, 17047.48857534273, 17049.0, 17513.91243043786, 5092.312537807395, 5183.118869792144, 5222.451642577532, 5237.423883372826, 5279.868003299929, 4965.28003439501, 4981.875453113665, 4987.251912213179, 5011.498850114996, 5117.897642047157, 5198.090334191501, 5230.267762513251, 5232.4767523247565, 5237.13587258102, 5239.502247286502, 5193.792248310101, 5198.792048318062, 5207.817726379559, 5218.582513398919, 5222.268882356473, 4511.481179664348, 4640.303954406866, 4661.7669116544375, 4663.207254766698, 4683.367745354368, 19868.503287417785, 21149.15403383863, 21442.0, 21454.0, 21472.89263553688, 1801.0994502748626, 1897.7153426985924, 1926.1717461491553, 2020.0404807716363, 2086.238522939116, 9636.0, 9956.751081222956, 10407.635732749317, 10655.307405018726, 13840.100393474391, 1690.5604542818833, 1691.0445598236956, 1743.3723859410602, 1763.2241813602102, 1810.6469238498498, 65960.0, 67111.99332010024, 67502.66248668774, 69699.65150174216, 69802.65098674526, 10214.387136771817, 10261.230407719451, 10296.918823523572, 10425.843612345669, 10430.322029068238, 13609.183448993092, 13703.383347749375, 13761.655958600915, 13768.173909565458, 13776.242306673028, 7187.604681742554, 7448.180700122982, 7478.5138965967035, 7561.848763024709, 7562.508436951581, 6971.8605627887155, 6990.266022067712, 7010.861687185356, 7182.96408517954, 7184.676689548983, 4302.935455968163, 4401.603855653007, 4446.333050042519, 4509.165804326144, 4522.547745225451, 1841.2911029253567, 1873.8313551780404, 1898.857585681052, 1905.1236431241784, 1920.4238728381429, 850.4557083466586, 943.1087622196958, 951.3007939164709, 953.2612225525273, 1034.8706411698538, 16598.502044938672, 17205.655886882192, 17318.39385621497, 17342.65314693699, 17495.669388765156, 913.488446469979, 929.3215952354819, 932.4265576670299, 964.6045121500151, 1005.9647912323034, 9391.436513809193, 9772.609095636237, 9869.309148359545, 9892.25808064398, 9987.700368988943, 379220.0, 399347.0, 406906.0, 407776.0, 408223.0, 50398.0, 56058.439415605324, 80996.0, 81918.0, 82072.58963705144, 950.064186776025, 952.9904700953041, 956.1729104324709, 959.2374062620233, 974.9317547771587, 15211.619709507351, 15366.615834604225, 15492.690146196788, 15679.451219207273, 15693.21533923322, 28651.0, 32870.178245544055, 35595.64404356027, 35648.64351356453, 36994.8150259247, 45198.32202516899, 50924.0, 51704.741476293886, 51726.48273517217, 52136.0, 7760.301572858244, 7937.880931786143, 8007.3978691354505, 8036.276735093869, 8125.512469251864, 8748.387612867038, 11685.941570292094, 12068.818967715315, 12075.939620301842, 12311.56909508163, 10290.073893349634, 10353.964603539585, 10579.36523808574, 10588.205884558534, 10690.358578485315, 10191.643292484727, 10273.178145748472, 10450.268481206547, 10480.947595261974, 10714.624988125379, 10559.52482138321, 10587.4706264688, 10853.968872957372, 10903.29128606638, 10972.792992770948, 7711.961440192763, 7721.729739459092, 7883.132855385788, 7898.2891539761695, 8133.715319963773, 9882.85175722379, 10448.843267351147, 10454.372737635766, 10459.372437653765, 10820.945895270474], "value": 8270.624193811736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.8196643453132, 1518.848115188481, 1528.6636939873229, 1705.624762552238, 1885.7737071551408, 7774.37804975602, 8156.6737330506785, 8202.015758109028, 8372.079071302152, 8400.579971001442, 8153.429259951791, 8289.295409890152, 8294.129116442777, 8307.50154990701, 8313.709020184295, 2278.8860556972168, 2287.5996700577334, 2303.6314189729646, 2305.7117860267467, 2309.284121922201, 2280.794728474437, 2305.400595845084, 2337.8246631502707, 2343.7070366204225, 2346.2022912209845, 2267.8639281643073, 2272.1138755885218, 2296.4144143243448, 2302.4934514406805, 2307.7346105197867, 2218.367765186914, 2231.62062449384, 2237.6196046672103, 2242.7196600424945, 2244.551089782042, 2214.346767703515, 2217.057750456066, 2218.7559368469456, 2221.389117992549, 2222.0334154642783, 7945.483543569707, 8087.31257843084, 8177.264046235808, 8222.8355432891, 8231.300339471152, 4718.528147185289, 4800.15997200492, 4804.279358096279, 4806.735629540374, 4815.0851338245975, 2964.8072875263038, 3008.4885569453027, 3037.6202974628172, 3039.088273517958, 3074.784765066446, 930.6928713524588, 936.0966667166217, 951.7240000399876, 958.0323872888433, 961.9951900240454, 10723.517441715063, 10744.194185436123, 10801.83797243042, 10895.400752958583, 10897.67306980792, 4125.876223713293, 4249.213895429355, 4297.162053399619, 4352.368906508602, 4353.69524133314, 8567.700130495527, 8569.48583085017, 8592.613332400057, 8609.354298427517, 8610.052894181636, 4583.4041574595085, 4723.0, 4726.976365118152, 4730.101280756645, 4740.28895665646, 3702.4631428443263, 4286.914261714811, 4380.364847097153, 4408.096340250241, 4448.621867141264, 3498.9475157872653, 3570.7143428525656, 3605.351036813346, 3695.981520092382, 3697.205100903265, 1091.8744344400495, 1094.813881640123, 1118.7426891814766, 1119.345183067898, 1135.7160709822545, 679.9592024478449, 771.5563550958109, 873.7509809704204, 901.8647202919615, 904.5703290936884, 5528.032594296063, 5541.2796336476, 5689.857753556194, 5726.341470730836, 5797.536197104221, 862.844687956174, 876.6493402638868, 888.5151012936873, 909.2952961454926, 915.9394346237093, 3728.9627103728617, 3845.4616353710503, 3854.807259637007, 3866.9806650966566, 3907.199024200032, 9646.614135434504, 9798.951005244928, 9892.455914924605, 9907.356021858555, 9940.055694708992, 9457.054294570626, 9762.121409073075, 9794.167495762798, 9794.461304628172, 9799.902000979899, 7285.526440781332, 7586.962065189638, 7612.733554325572, 7621.580813055335, 7639.083310002835, 5426.891462170814, 5451.264079349396, 5451.48210919962, 5727.8854422912145, 5830.067189249869, 8734.956325218332, 9390.67132650354, 9407.4825884577, 9416.246700263826, 9433.0, 9279.814403712024, 9284.442933424016, 9389.014153513783, 9486.33595648298, 9558.235341172829, 6914.0, 6984.057152284377, 7051.224365319913, 7115.82210444743, 7361.631918404166, 7943.44395892282, 7960.721374751856, 8015.278624923785, 8019.358451323764, 8025.678972841021, 5295.523402893758, 6900.309969003059, 6921.757738479129, 7132.322429369409, 7400.629968501661, 6950.339717726808, 6996.580205187705, 7141.642917853983, 7199.676014579251, 7216.5670059796585, 6704.7988560343265, 6713.194416669836, 6786.93213067863, 6792.117024786746, 6899.482538809509, 4816.54242846929, 4823.204171311834, 4842.273658951185, 4871.878203044952, 4933.827316043921, 4711.269753188261, 4879.585235255043, 4879.951200488092, 4925.38432695913, 4964.503549645006], "value": 4286.221153281471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.1001376119343, 320.150001745366, 324.37557701424765, 329.18198277280953, 330.3195417440072, 4756.38167038285, 4823.734694591801, 4826.276058591213, 4844.418669759634, 4870.0, 4760.214564596838, 4763.9272669128395, 4788.0663270662235, 4794.6266598033935, 4795.136875362434, 3638.6543278388513, 3709.0727318170457, 3741.8316175772156, 3745.793981331026, 3767.6797472214894, 3432.1762776933483, 3731.1791405890795, 3751.6248375162404, 3791.7345785795005, 3804.7717136971733, 3715.7213209009296, 3752.174521605256, 3760.8683696070507, 3767.472553842464, 3768.6608205261523, 3625.329314076878, 3760.868369607078, 3763.397856342972, 3770.472133901256, 3779.4897688811934, 3298.472244440902, 3370.3933292007428, 3374.958150319046, 3384.932301353984, 3389.610194827602, 4542.591166795004, 4542.613877820356, 4552.135094332067, 4563.726176429392, 4578.88552786183, 4290.592393722592, 4291.184674911788, 4292.957070429318, 4293.592108749664, 4324.351347297899, 4741.928871066937, 4964.15609346412, 4971.925421118686, 4980.975095124538, 4996.7501624918605, 3657.683234035745, 3673.0266479382985, 3691.169486865461, 3692.8153592320277, 3708.8887333380044, 4944.110060189165, 4977.875553111129, 5130.050940576006, 5174.611904107207, 5197.66215196011, 3742.232842267383, 3761.567419746709, 3780.4896338993885, 3781.9810900945317, 3785.6592906638534, 3829.4447305140598, 3830.812448141085, 3835.558910725302, 3845.9807700961314, 3870.806459677005, 4289.270823959934, 4289.520115560127, 4315.050688848449, 4332.328489084197, 4333.8699839004885, 4863.975680121577, 4885.487023862514, 4991.700497970133, 5000.39995200571, 5015.724135172601, 1321.8631976500203, 1325.2909693314032, 1330.314887832767, 1334.6463187255385, 1340.2092765268537, 855.5080828523623, 881.1408876345512, 883.1786438612153, 893.3478560650761, 894.2086253665553, 4013.4581831452965, 4015.819288132041, 4017.879463616096, 4019.9196016079513, 4020.43713880057, 4579.656525760582, 4581.221192397301, 4584.15193189261, 4595.93106103402, 4618.2841659542155, 4014.6714905354825, 4017.91964160721, 4042.292598795199, 4046.615571520701, 4065.10567675111, 2466.9136580219606, 2541.6187571863998, 2713.606527053566, 2758.7930905182193, 2765.2395591212176, 4857.514248575114, 4858.684185527929, 4865.537773911473, 4913.582345500601, 4919.139150648693, 5134.150546446684, 5197.792088316425, 5217.426083130853, 5258.342707161605, 5260.63319475536, 4853.781579828846, 4858.222684370625, 4870.342503762088, 4888.9488759916785, 4905.166121759309, 5137.845864624067, 5149.498341128069, 5159.690418574897, 5166.0, 5169.715665638426, 4829.1890541047105, 5000.724960127228, 5039.571636410946, 5040.924386134137, 5073.061483625541, 4565.109803588269, 4729.314249433882, 4879.56083952446, 4901.117798796108, 4904.509549045067, 3687.1519550503, 3692.298463291966, 3698.354232366571, 3700.093477098128, 3700.389435743072, 5070.3155074064525, 5096.541311282002, 5121.359830021247, 5137.2037334213255, 5140.820071297487, 4819.759012049453, 4866.024108265395, 4897.632677549127, 4923.778429970732, 4930.408350997904, 4934.963657631937, 4939.185034469416, 4957.652964292465, 4960.454350021422, 4960.875978100432, 4888.462269150319, 4888.755562221946, 4899.240617704261, 4900.828471003498, 4902.975485122694, 4848.9757551212015, 4897.95102048975, 5009.895843745563, 5014.34813474246, 5014.398272207212, 4839.733814640088, 4848.109237397488, 4885.511448855228, 4922.803087876445, 4930.802767889244], "value": 3763.4001845488183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.8873091574432, 784.7253461288553, 787.4291138924277, 787.9606019699014, 801.5751651624637, 10592.894071059296, 11092.889071109286, 11129.054030407406, 11143.108551315905, 11154.498047587858, 11945.701357466067, 12539.0, 12545.996320294378, 12601.747965040693, 12626.494940202381, 863.1670438027287, 873.4715497124243, 877.8990416102166, 878.8066625342447, 879.6349514951288, 861.3066481482405, 864.5849992003842, 864.8962124545031, 865.3077537969631, 866.4281574161055, 914.3690853311194, 914.4467597103757, 914.7575892388522, 915.9450432974043, 917.0004694882576, 903.7876099116702, 903.814717982812, 903.9638414463413, 904.2268860124598, 904.2991681446865, 670.1589505171028, 670.9731610735565, 671.3353779758053, 671.4359937652396, 672.0758956434902, 10010.349327293703, 10197.082262596401, 10205.897941020568, 10206.897931020669, 10219.080282774587, 10155.187584993182, 10259.17926565873, 10378.11785998191, 10393.9480302598, 10802.945985270102, 9001.099890010946, 9017.504037277948, 9076.137766912132, 9239.214666753334, 9274.629014839398, 3175.6030496187977, 3211.8167802257967, 3266.6080070391467, 3281.6718328166994, 3357.865685372582, 42878.14243715139, 46786.53213467856, 47072.52927470716, 47075.05849883017, 47114.76442617765, 9526.476043817518, 9763.414195148314, 9929.751756206153, 10217.540210690537, 10466.947665261625, 17604.91197544004, 17742.822571774374, 17750.46748597544, 17775.111244437983, 17982.2807087715, 6255.0, 6513.576617519846, 6932.7226910923, 7056.6118863463, 7175.103112110986, 3566.2154326048226, 3610.9638903610626, 3643.3441980443777, 3652.415613501827, 3653.104989277591, 2745.272502786763, 2869.626948496724, 2870.9712902870706, 2873.0, 2875.25243436708, 523.8271370447743, 536.5466181076984, 544.6731960823554, 555.6221769196904, 557.7462254674114, 519.9688018718889, 595.7289433307834, 617.561531312764, 623.1400667079402, 685.530411668009, 6631.204255489276, 6757.763478278335, 6803.727850886008, 6893.0, 6893.586384816927, 491.2410326046267, 504.2537045173164, 590.4095904095905, 597.9983527591268, 603.9094135879653, 3965.40518922164, 4087.713860029829, 4151.14901445203, 4162.771047592351, 4194.077302993336, 56269.0, 56632.433675662716, 57059.14411283834, 57419.0, 57768.71115644395, 36874.63125368766, 49203.753981229864, 52028.47971520312, 52062.21906671403, 54576.181357279675, 47397.289040664415, 48092.519074809505, 48654.51345486571, 48698.0, 48723.5127648719, 8405.369597280107, 8775.473471591726, 8974.775630609287, 9014.008459069628, 9148.222401095982, 31548.526772098896, 32095.679043209268, 32283.677163229007, 32357.838210808794, 33103.33793324168, 38661.0, 40004.79997599994, 42356.788216058725, 42389.15221695487, 42774.35838462488, 10858.511366988347, 11354.489047993025, 11389.544418223179, 11464.885351146382, 11501.53993840237, 12064.879351206726, 12175.33035683046, 12299.077569182526, 12424.627261182179, 12854.421551030413, 11622.418879056182, 11901.285922844658, 12019.338936358585, 12089.274643521418, 12641.747165056831, 11585.536578536765, 12006.63980080599, 12240.265584064984, 12605.558805441766, 12881.613551593467, 11525.769484610428, 11632.592859249886, 11767.470463828977, 11806.940965295118, 12214.022878169902, 9947.900520994697, 9988.200943924323, 10085.243606729378, 10168.796624067625, 10242.846357304497, 9541.284403669613, 9608.471534065415, 9614.855777163208, 9623.470709111067, 9676.70969870905], "value": 6068.908651715395, "unit": "score"}], "name": "dromaeo_css", "value": 6442.301148002035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 113.0, 112.0, 115.0, 112.0, 112.0, 113.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 131.0, 152.0, 209.0, 131.0, 168.0, 160.0, 139.0, 184.0, 130.0], "value": 158.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 151.0, 76.0, 75.0, 79.0, 75.0, 132.0, 78.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 167.0, 92.0, 92.0, 92.0, 133.0, 92.0, 92.0, 128.0], "value": 107.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 89.0, 82.0, 81.0, 83.0, 82.0, 88.0, 164.0, 83.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 138.0, 128.0, 130.0, 129.0, 126.0, 130.0, 152.0, 133.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 172.0, 171.0, 169.0, 172.0, 175.0, 174.0, 169.0, 175.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 68.0, 69.0, 68.0, 67.0, 67.0, 64.0, 64.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1577.6, "alertThreshold": 2.0}]} 06:07:00 INFO - Return code: 0 06:07:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:07:00 ERROR - # TBPL SUCCESS # 06:07:00 INFO - Running post-action listener: _resource_record_post_action 06:07:00 INFO - ##### 06:07:00 INFO - ##### Finished run-tests step (success) 06:07:00 INFO - ##### 06:07:00 INFO - Running post-run listener: _resource_record_post_run 06:07:01 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 530669568; Read time: 0; Write time: 448160 06:07:01 INFO - TinderboxPrint: CPU usage
13.1% 06:07:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:07:01 INFO - TinderboxPrint: I/O write bytes / time
530,669,568 / 448,160 06:07:01 INFO - TinderboxPrint: CPU idle
8,325.7 (86.8%) 06:07:01 INFO - TinderboxPrint: CPU user
1,217.1 (12.7%) 06:07:01 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236154880; Read time: 0; Write time: 242800 06:07:01 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 294395904; Read time: 0; Write time: 205360 06:07:01 INFO - Running post-run listener: _upload_blobber_files 06:07:01 INFO - Blob upload gear active. 06:07:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:01 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 06:07:01 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'] 06:07:01 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 06:07:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:02 INFO - (blobuploader) - INFO - Done attempting. 06:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:03 INFO - (blobuploader) - INFO - Done attempting. 06:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:08 INFO - (blobuploader) - INFO - Done attempting. 06:07:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:08 INFO - Return code: 0 06:07:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68214b8bf8f39fde92dba79bbb7b984731ef4e6983982113e10d70a6ac19d5d3b9ceb8d7cd7aa0bae39a1a0096ef94bf67fb78d820f7ce5ad7fdefa611000fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed56b058e32095678364f8f5a04f71b33f482b3e1624ff816a1d017d8ca028579346a92c8d514816664019febefbb7ce36454ad2eb3133ab08ccd30c4b4440fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2aa7cb543f3ff0d7eaef72c687978cb3e59e122ed04750a658c31df1e98216dbe8f686ca74d1e82a377027f40099a43c85ad884da12f354ce9fffaf9f47e539e"} 06:07:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:08 INFO - Contents: 06:07:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68214b8bf8f39fde92dba79bbb7b984731ef4e6983982113e10d70a6ac19d5d3b9ceb8d7cd7aa0bae39a1a0096ef94bf67fb78d820f7ce5ad7fdefa611000fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed56b058e32095678364f8f5a04f71b33f482b3e1624ff816a1d017d8ca028579346a92c8d514816664019febefbb7ce36454ad2eb3133ab08ccd30c4b4440fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2aa7cb543f3ff0d7eaef72c687978cb3e59e122ed04750a658c31df1e98216dbe8f686ca74d1e82a377027f40099a43c85ad884da12f354ce9fffaf9f47e539e"} 06:07:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:08 INFO - Copying logs to upload dir... 06:07:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.378964 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-16 06:07:06.516024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 06:07:06.519876) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 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/b68214b8bf8f39fde92dba79bbb7b984731ef4e6983982113e10d70a6ac19d5d3b9ceb8d7cd7aa0bae39a1a0096ef94bf67fb78d820f7ce5ad7fdefa611000fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed56b058e32095678364f8f5a04f71b33f482b3e1624ff816a1d017d8ca028579346a92c8d514816664019febefbb7ce36454ad2eb3133ab08ccd30c4b4440fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2aa7cb543f3ff0d7eaef72c687978cb3e59e122ed04750a658c31df1e98216dbe8f686ca74d1e82a377027f40099a43c85ad884da12f354ce9fffaf9f47e539e"} build_url:https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/D_xWu60bSDWFCx9KowdZ9g/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/b68214b8bf8f39fde92dba79bbb7b984731ef4e6983982113e10d70a6ac19d5d3b9ceb8d7cd7aa0bae39a1a0096ef94bf67fb78d820f7ce5ad7fdefa611000fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed56b058e32095678364f8f5a04f71b33f482b3e1624ff816a1d017d8ca028579346a92c8d514816664019febefbb7ce36454ad2eb3133ab08ccd30c4b4440fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2aa7cb543f3ff0d7eaef72c687978cb3e59e122ed04750a658c31df1e98216dbe8f686ca74d1e82a377027f40099a43c85ad884da12f354ce9fffaf9f47e539e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 06:07:06.543823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:07:06.544106) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463397014.314781-1058122781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:07:06.627360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 06:07:06.627683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 06:07:06.627966) ========= ========= Total master_lag: 0.27 =========