builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1463572473.01 results: success (0) buildid: 20160518041250 builduid: e1bac5f8e89840a4b5e184166f45842e revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.010998) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.011629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.012133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.057510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.058032) ========= 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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 04:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.5M=0.001s 2016-05-18 04:54:33 (16.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.186111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.186798) ========= 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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017515 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.247910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.248249) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47b83c8478a06374aa9306122a778654b912f713 --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 47b83c8478a06374aa9306122a778654b912f713 --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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 04:54:33,477 truncating revision to first 12 chars 2016-05-18 04:54:33,477 Setting DEBUG logging. 2016-05-18 04:54:33,477 attempt 1/10 2016-05-18 04:54:33,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47b83c8478a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 04:54:33,735 unpacking tar archive at: fx-team-47b83c8478a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.806872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.807245) ========= script_repo_revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.807787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.808128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 04:54:33.818379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-18 04:54:33.818701) ========= /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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:34 INFO - MultiFileLogger online at 20160518 04:54:34 in /builds/slave/test 04:54:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:34 INFO - {'append_to_log': False, 04:54:34 INFO - 'base_work_dir': '/builds/slave/test', 04:54:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:34 INFO - 'config_files': ('talos/linux_config.py',), 04:54:34 INFO - 'default_actions': ('clobber', 04:54:34 INFO - 'read-buildbot-config', 04:54:34 INFO - 'download-and-extract', 04:54:34 INFO - 'populate-webroot', 04:54:34 INFO - 'create-virtualenv', 04:54:34 INFO - 'install', 04:54:34 INFO - 'run-tests'), 04:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:34 INFO - 'download_minidump_stackwalk': True, 04:54:34 INFO - 'download_symbols': 'ondemand', 04:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:34 INFO - 'installer_path': 'installer.exe', 04:54:34 INFO - 'log_level': 'info', 04:54:34 INFO - 'log_name': 'talos', 04:54:34 INFO - 'log_to_console': True, 04:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:34 INFO - 'opt_config_files': (), 04:54:34 INFO - 'pip_index': False, 04:54:34 INFO - 'sps_profile': False, 04:54:34 INFO - 'sps_profile_interval': 0, 04:54:34 INFO - 'suite': 'dromaeojs', 04:54:34 INFO - 'system_bits': '32', 04:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:34 INFO - 'title': 'talos-linux64-ix-018', 04:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:34 INFO - 'use_talos_json': True, 04:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:34 INFO - 'work_dir': 'build'} 04:54:34 INFO - ##### 04:54:34 INFO - ##### Running clobber step. 04:54:34 INFO - ##### 04:54:34 INFO - Running pre-action listener: _resource_record_pre_action 04:54:34 INFO - Running main action method: clobber 04:54:34 INFO - rmtree: /builds/slave/test/build 04:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:34 INFO - Running post-action listener: _resource_record_post_action 04:54:34 INFO - ##### 04:54:34 INFO - ##### Finished clobber step (success) 04:54:34 INFO - ##### 04:54:34 INFO - ##### 04:54:34 INFO - ##### Running read-buildbot-config step. 04:54:34 INFO - ##### 04:54:34 INFO - Running pre-action listener: _resource_record_pre_action 04:54:34 INFO - Running main action method: read_buildbot_config 04:54:34 INFO - Using buildbot properties: 04:54:34 INFO - { 04:54:34 INFO - "project": "", 04:54:34 INFO - "product": "firefox", 04:54:34 INFO - "script_repo_revision": "production", 04:54:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:54:34 INFO - "repository": "", 04:54:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:54:34 INFO - "buildid": "20160518041250", 04:54:34 INFO - "pgo_build": "False", 04:54:34 INFO - "basedir": "/builds/slave/test", 04:54:34 INFO - "buildnumber": 1694, 04:54:34 INFO - "slavename": "talos-linux64-ix-018", 04:54:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:54:34 INFO - "platform": "ubuntu64_hw", 04:54:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:54:34 INFO - "branch": "fx-team", 04:54:34 INFO - "repo_path": "integration/fx-team", 04:54:34 INFO - "revision": "47b83c8478a06374aa9306122a778654b912f713", 04:54:34 INFO - "stage_platform": "linux64", 04:54:34 INFO - "builduid": "e1bac5f8e89840a4b5e184166f45842e", 04:54:34 INFO - "slavebuilddir": "test" 04:54:34 INFO - } 04:54:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:54:34 INFO - Running post-action listener: _resource_record_post_action 04:54:34 INFO - ##### 04:54:34 INFO - ##### Finished read-buildbot-config step (success) 04:54:34 INFO - ##### 04:54:34 INFO - ##### 04:54:34 INFO - ##### Running download-and-extract step. 04:54:34 INFO - ##### 04:54:34 INFO - Running pre-action listener: _resource_record_pre_action 04:54:34 INFO - Running main action method: download_and_extract 04:54:34 INFO - mkdir: /builds/slave/test/build/tests 04:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:34 INFO - https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:40 INFO - Downloaded 1361 bytes. 04:54:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:54:40 INFO - Using the following test package requirements: 04:54:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:54:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'jsshell-linux-x86_64.zip'], 04:54:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54: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')]} 04:54:40 INFO - https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:42 INFO - Downloaded 22489217 bytes. 04:54:42 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'] 04:54:42 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 04:54:43 INFO - Return code: 0 04:54:43 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 04:54: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')]} 04:54:43 INFO - https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:47 INFO - Downloaded 22489217 bytes. 04:54:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:54:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:54:49 INFO - Return code: 0 04:54: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')]} 04:54:49 INFO - https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:50 INFO - Downloaded 10840194 bytes. 04:54:50 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'] 04:54:50 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 04:54:50 INFO - Return code: 0 04:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:50 INFO - https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:54:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:54:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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 04:54:51 INFO - Downloaded 54777361 bytes. 04:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:54:51 INFO - mkdir: /builds/slave/test/properties 04:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:51 INFO - Contents: 04:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:54:52 INFO - Running post-action listener: _resource_record_post_action 04:54:52 INFO - Running post-action listener: set_extra_try_arguments 04:54:52 INFO - ##### 04:54:52 INFO - ##### Finished download-and-extract step (success) 04:54:52 INFO - ##### 04:54:52 INFO - ##### 04:54:52 INFO - ##### Running populate-webroot step. 04:54:52 INFO - ##### 04:54:52 INFO - Running pre-action listener: _resource_record_pre_action 04:54:52 INFO - Running main action method: populate_webroot 04:54:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:52 INFO - '--tppagecycles', 04:54:52 INFO - '7'], 04:54:52 INFO - 'tests': ['tsvgm']}}, 04:54:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['damp', 'tps']}, 04:54:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'tests': ['damp', 'tps']}, 04:54:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['dromaeo_dom']}, 04:54:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['a11yr', 04:54:52 INFO - 'ts_paint', 04:54:52 INFO - 'tpaint', 04:54:52 INFO - 'sessionrestore', 04:54:52 INFO - 'sessionrestore_no_auto_restore', 04:54:52 INFO - 'tabpaint']}, 04:54:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['tsvgx', 04:54:52 INFO - 'tsvgr_opacity', 04:54:52 INFO - 'tart', 04:54:52 INFO - 'tscrollx', 04:54:52 INFO - 'cart']}, 04:54:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:52 INFO - 'tsvgr_opacity', 04:54:52 INFO - 'tart', 04:54:52 INFO - 'tscrollx', 04:54:52 INFO - 'cart']}, 04:54:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'talos_options': ['--disable-e10s'], 04:54:52 INFO - 'tests': ['tp5o']}, 04:54:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'tests': ['tp5o']}, 04:54:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'talos_options': ['--disable-e10s', 04:54:52 INFO - '--xperf_path', 04:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:52 INFO - 'tests': ['tp5n']}, 04:54:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:52 INFO - 'talos_options': ['--xperf_path', 04:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:52 INFO - 'tests': ['tp5n']}}, 04:54:52 INFO - 'talos.zip': {'path': '', 04:54:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:52 INFO - Running post-action listener: _resource_record_post_action 04:54:52 INFO - ##### 04:54:52 INFO - ##### Finished populate-webroot step (success) 04:54:52 INFO - ##### 04:54:52 INFO - ##### 04:54:52 INFO - ##### Running create-virtualenv step. 04:54:52 INFO - ##### 04:54:52 INFO - Running pre-action listener: _resource_record_pre_action 04:54:52 INFO - Running main action method: create_virtualenv 04:54:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:52 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 04:54:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:52 INFO - Using real prefix '/usr' 04:54:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:55 INFO - Installing pip.................done. 04:54:55 INFO - Return code: 0 04:54:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:54:55 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 04:54:55 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 04:54:55 INFO - Using env: {'DISPLAY': ':0', 04:54:55 INFO - 'HOME': '/home/cltbld', 04:54:55 INFO - 'LANG': 'en_US.UTF-8', 04:54:55 INFO - 'LANGUAGE': 'en_US:en', 04:54:55 INFO - 'LOGNAME': 'cltbld', 04:54:55 INFO - 'MAIL': '/var/mail/cltbld', 04:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:55 INFO - 'MOZ_NO_REMOTE': '1', 04:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:55 INFO - 'NO_EM_RESTART': '1', 04:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:55 INFO - 'PWD': '/builds/slave/test', 04:54:55 INFO - 'SHELL': '/bin/bash', 04:54:55 INFO - 'SHLVL': '1', 04:54:55 INFO - 'TERM': 'linux', 04:54:55 INFO - 'TMOUT': '86400', 04:54:55 INFO - 'USER': 'cltbld', 04:54:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:55 INFO - '_': '/tools/buildbot/bin/python'} 04:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:55 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 04:54:55 INFO - Cleaning up... 04:54:55 INFO - Return code: 0 04:54:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:55 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:54:55 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 04:54:55 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 04:54:55 INFO - Using env: {'DISPLAY': ':0', 04:54:55 INFO - 'HOME': '/home/cltbld', 04:54:55 INFO - 'LANG': 'en_US.UTF-8', 04:54:55 INFO - 'LANGUAGE': 'en_US:en', 04:54:55 INFO - 'LOGNAME': 'cltbld', 04:54:55 INFO - 'MAIL': '/var/mail/cltbld', 04:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:55 INFO - 'MOZ_NO_REMOTE': '1', 04:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:55 INFO - 'NO_EM_RESTART': '1', 04:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:55 INFO - 'PWD': '/builds/slave/test', 04:54:55 INFO - 'SHELL': '/bin/bash', 04:54:55 INFO - 'SHLVL': '1', 04:54:55 INFO - 'TERM': 'linux', 04:54:55 INFO - 'TMOUT': '86400', 04:54:55 INFO - 'USER': 'cltbld', 04:54:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:55 INFO - '_': '/tools/buildbot/bin/python'} 04:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:55 INFO - Downloading/unpacking psutil>=3.1.1 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:58 INFO - Installing collected packages: psutil 04:54:58 INFO - Running setup.py install for psutil 04:54:58 INFO - building 'psutil._psutil_linux' extension 04:54:58 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 04:54:58 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 04:54:58 INFO - building 'psutil._psutil_posix' extension 04:54:58 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 04:54:58 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 04:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:59 INFO - Successfully installed psutil 04:54:59 INFO - Cleaning up... 04:54:59 INFO - Return code: 0 04:54:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:54:59 INFO - Using env: {'DISPLAY': ':0', 04:54:59 INFO - 'HOME': '/home/cltbld', 04:54:59 INFO - 'LANG': 'en_US.UTF-8', 04:54:59 INFO - 'LANGUAGE': 'en_US:en', 04:54:59 INFO - 'LOGNAME': 'cltbld', 04:54:59 INFO - 'MAIL': '/var/mail/cltbld', 04:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:59 INFO - 'MOZ_NO_REMOTE': '1', 04:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:59 INFO - 'NO_EM_RESTART': '1', 04:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:59 INFO - 'PWD': '/builds/slave/test', 04:54:59 INFO - 'SHELL': '/bin/bash', 04:54:59 INFO - 'SHLVL': '1', 04:54:59 INFO - 'TERM': 'linux', 04:54:59 INFO - 'TMOUT': '86400', 04:54:59 INFO - 'USER': 'cltbld', 04:54:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:59 INFO - '_': '/tools/buildbot/bin/python'} 04:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:54:59 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 04:55:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:55:01 INFO - Installing collected packages: mozsystemmonitor 04:55:01 INFO - Running setup.py install for mozsystemmonitor 04:55:01 INFO - Successfully installed mozsystemmonitor 04:55:01 INFO - Cleaning up... 04:55:01 INFO - Return code: 0 04:55:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55:01 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')]} 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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')]} 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:01 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 04:55:01 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 04:55:01 INFO - Using env: {'DISPLAY': ':0', 04:55:01 INFO - 'HOME': '/home/cltbld', 04:55:01 INFO - 'LANG': 'en_US.UTF-8', 04:55:01 INFO - 'LANGUAGE': 'en_US:en', 04:55:01 INFO - 'LOGNAME': 'cltbld', 04:55:01 INFO - 'MAIL': '/var/mail/cltbld', 04:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:01 INFO - 'MOZ_NO_REMOTE': '1', 04:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:01 INFO - 'NO_EM_RESTART': '1', 04:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:01 INFO - 'PWD': '/builds/slave/test', 04:55:01 INFO - 'SHELL': '/bin/bash', 04:55:01 INFO - 'SHLVL': '1', 04:55:01 INFO - 'TERM': 'linux', 04:55:01 INFO - 'TMOUT': '86400', 04:55:01 INFO - 'USER': 'cltbld', 04:55:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:01 INFO - '_': '/tools/buildbot/bin/python'} 04:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:04 INFO - Downloading docopt-0.6.1.tar.gz 04:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:04 INFO - Running setup.py install for blobuploader 04:55:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:04 INFO - Running setup.py install for requests 04:55:04 INFO - Running setup.py install for docopt 04:55:04 INFO - Successfully installed blobuploader requests docopt 04:55:04 INFO - Cleaning up... 04:55:04 INFO - Return code: 0 04:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:04 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')]} 04:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:04 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')]} 04:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:04 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:04 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 04:55:04 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 04:55:04 INFO - Using env: {'DISPLAY': ':0', 04:55:04 INFO - 'HOME': '/home/cltbld', 04:55:04 INFO - 'LANG': 'en_US.UTF-8', 04:55:04 INFO - 'LANGUAGE': 'en_US:en', 04:55:04 INFO - 'LOGNAME': 'cltbld', 04:55:04 INFO - 'MAIL': '/var/mail/cltbld', 04:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:04 INFO - 'MOZ_NO_REMOTE': '1', 04:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:04 INFO - 'NO_EM_RESTART': '1', 04:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:04 INFO - 'PWD': '/builds/slave/test', 04:55:04 INFO - 'SHELL': '/bin/bash', 04:55:04 INFO - 'SHLVL': '1', 04:55:04 INFO - 'TERM': 'linux', 04:55:04 INFO - 'TMOUT': '86400', 04:55:04 INFO - 'USER': 'cltbld', 04:55:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:04 INFO - '_': '/tools/buildbot/bin/python'} 04:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:05 INFO - Running setup.py (path:/tmp/pip-iDd13l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:05 INFO - Running setup.py (path:/tmp/pip-HDOKpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:05 INFO - Running setup.py (path:/tmp/pip-9dFM8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:05 INFO - Running setup.py (path:/tmp/pip-ljWJia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:05 INFO - Running setup.py (path:/tmp/pip-Os0J9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:05 INFO - Running setup.py (path:/tmp/pip-ZoshHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:05 INFO - Running setup.py (path:/tmp/pip-bvQuMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:05 INFO - Running setup.py (path:/tmp/pip-2rRmM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:05 INFO - Running setup.py (path:/tmp/pip-J8KutP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:05 INFO - Running setup.py (path:/tmp/pip-crpFJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:05 INFO - Running setup.py (path:/tmp/pip-qee3Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:05 INFO - Running setup.py (path:/tmp/pip-Y_6VWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:05 INFO - Running setup.py (path:/tmp/pip-agq0Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:06 INFO - Running setup.py (path:/tmp/pip-EdGPMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:06 INFO - Running setup.py (path:/tmp/pip-65Qxf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:06 INFO - Running setup.py (path:/tmp/pip-6UNMUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:06 INFO - Running setup.py (path:/tmp/pip-PZCkYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:06 INFO - Running setup.py install for manifestparser 04:55:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:55:06 INFO - Running setup.py install for mozcrash 04:55:06 INFO - Running setup.py install for mozdebug 04:55:06 INFO - Running setup.py install for mozdevice 04:55:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:55:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:55:06 INFO - Running setup.py install for mozfile 04:55:06 INFO - Running setup.py install for mozhttpd 04:55:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:55:06 INFO - Running setup.py install for mozinfo 04:55:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for mozInstall 04:55:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for mozleak 04:55:07 INFO - Running setup.py install for mozlog 04:55:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for moznetwork 04:55:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for mozprocess 04:55:07 INFO - Running setup.py install for mozprofile 04:55:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for mozrunner 04:55:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:55:07 INFO - Running setup.py install for mozscreenshot 04:55:07 INFO - Running setup.py install for moztest 04:55:08 INFO - Running setup.py install for mozversion 04:55:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:55:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:08 INFO - Cleaning up... 04:55:08 INFO - Return code: 0 04:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:08 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')]} 04:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:08 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')]} 04:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:08 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:08 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 04:55:08 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 04:55:08 INFO - Using env: {'DISPLAY': ':0', 04:55:08 INFO - 'HOME': '/home/cltbld', 04:55:08 INFO - 'LANG': 'en_US.UTF-8', 04:55:08 INFO - 'LANGUAGE': 'en_US:en', 04:55:08 INFO - 'LOGNAME': 'cltbld', 04:55:08 INFO - 'MAIL': '/var/mail/cltbld', 04:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:08 INFO - 'MOZ_NO_REMOTE': '1', 04:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:08 INFO - 'NO_EM_RESTART': '1', 04:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:08 INFO - 'PWD': '/builds/slave/test', 04:55:08 INFO - 'SHELL': '/bin/bash', 04:55:08 INFO - 'SHLVL': '1', 04:55:08 INFO - 'TERM': 'linux', 04:55:08 INFO - 'TMOUT': '86400', 04:55:08 INFO - 'USER': 'cltbld', 04:55:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:08 INFO - '_': '/tools/buildbot/bin/python'} 04:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:08 INFO - Running setup.py (path:/tmp/pip-nN11_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:08 INFO - Running setup.py (path:/tmp/pip-A5G1Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:08 INFO - Running setup.py (path:/tmp/pip-SMavl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:08 INFO - Running setup.py (path:/tmp/pip-48Bv2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:08 INFO - Running setup.py (path:/tmp/pip-1Gd4ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:08 INFO - Running setup.py (path:/tmp/pip-JM185i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:08 INFO - Running setup.py (path:/tmp/pip-cihL6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:08 INFO - Running setup.py (path:/tmp/pip-oFa0yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:08 INFO - Running setup.py (path:/tmp/pip-kIF8NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:08 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)) 04:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:08 INFO - Running setup.py (path:/tmp/pip-RQ0vFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:09 INFO - Running setup.py (path:/tmp/pip-r9nMus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:09 INFO - Running setup.py (path:/tmp/pip-bhfcis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:09 INFO - Running setup.py (path:/tmp/pip-c3BpSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:09 INFO - Running setup.py (path:/tmp/pip-rP36wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:09 INFO - Running setup.py (path:/tmp/pip-MsM9Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:09 INFO - Running setup.py (path:/tmp/pip-rd44Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:09 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)) 04:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:09 INFO - Running setup.py (path:/tmp/pip-famRsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:09 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)) 04:55:09 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)) 04:55:09 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)) 04:55:09 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)) 04:55:09 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)) 04:55:09 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)) 04:55:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:09 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 04:55:09 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 04:55:09 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 04:55:09 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 04:55:09 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 04:55:09 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 04:55:11 INFO - Downloading blessings-1.6.tar.gz 04:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:11 INFO - Installing collected packages: blessings 04:55:11 INFO - Running setup.py install for blessings 04:55:11 INFO - Successfully installed blessings 04:55:11 INFO - Cleaning up... 04:55:11 INFO - Return code: 0 04:55:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:11 INFO - Reading from file tmpfile_stdout 04:55:11 INFO - Current package versions: 04:55:11 INFO - argparse == 1.2.1 04:55:11 INFO - blessings == 1.6 04:55:11 INFO - blobuploader == 1.2.4 04:55:11 INFO - docopt == 0.6.1 04:55:11 INFO - manifestparser == 1.1 04:55:11 INFO - mozInstall == 1.12 04:55:11 INFO - mozcrash == 0.17 04:55:11 INFO - mozdebug == 0.1 04:55:11 INFO - mozdevice == 0.48 04:55:11 INFO - mozfile == 1.2 04:55:11 INFO - mozhttpd == 0.7 04:55:11 INFO - mozinfo == 0.9 04:55:11 INFO - mozleak == 0.1 04:55:11 INFO - mozlog == 3.2 04:55:11 INFO - moznetwork == 0.27 04:55:11 INFO - mozprocess == 0.22 04:55:11 INFO - mozprofile == 0.28 04:55:11 INFO - mozrunner == 6.11 04:55:11 INFO - mozscreenshot == 0.1 04:55:11 INFO - mozsystemmonitor == 0.3 04:55:11 INFO - moztest == 0.7 04:55:11 INFO - mozversion == 1.4 04:55:11 INFO - psutil == 3.1.1 04:55:11 INFO - requests == 1.2.3 04:55:11 INFO - wsgiref == 0.1.2 04:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:11 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')]} 04:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:11 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')]} 04:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:11 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:11 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 04:55:11 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 04:55:11 INFO - Using env: {'DISPLAY': ':0', 04:55:11 INFO - 'HOME': '/home/cltbld', 04:55:11 INFO - 'LANG': 'en_US.UTF-8', 04:55:11 INFO - 'LANGUAGE': 'en_US:en', 04:55:11 INFO - 'LOGNAME': 'cltbld', 04:55:11 INFO - 'MAIL': '/var/mail/cltbld', 04:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:11 INFO - 'MOZ_NO_REMOTE': '1', 04:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:11 INFO - 'NO_EM_RESTART': '1', 04:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:11 INFO - 'PWD': '/builds/slave/test', 04:55:11 INFO - 'SHELL': '/bin/bash', 04:55:11 INFO - 'SHLVL': '1', 04:55:11 INFO - 'TERM': 'linux', 04:55:11 INFO - 'TMOUT': '86400', 04:55:11 INFO - 'USER': 'cltbld', 04:55:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:11 INFO - '_': '/tools/buildbot/bin/python'} 04:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 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)) 04:55:12 INFO - Cleaning up... 04:55:12 INFO - Return code: 0 04:55:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:12 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:12 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 04:55:12 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 04:55:12 INFO - Using env: {'DISPLAY': ':0', 04:55:12 INFO - 'HOME': '/home/cltbld', 04:55:12 INFO - 'LANG': 'en_US.UTF-8', 04:55:12 INFO - 'LANGUAGE': 'en_US:en', 04:55:12 INFO - 'LOGNAME': 'cltbld', 04:55:12 INFO - 'MAIL': '/var/mail/cltbld', 04:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:12 INFO - 'MOZ_NO_REMOTE': '1', 04:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:12 INFO - 'NO_EM_RESTART': '1', 04:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:12 INFO - 'PWD': '/builds/slave/test', 04:55:12 INFO - 'SHELL': '/bin/bash', 04:55:12 INFO - 'SHLVL': '1', 04:55:12 INFO - 'TERM': 'linux', 04:55:12 INFO - 'TMOUT': '86400', 04:55:12 INFO - 'USER': 'cltbld', 04:55:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:12 INFO - '_': '/tools/buildbot/bin/python'} 04:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:12 INFO - Downloading/unpacking jsonschema 04:55:12 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 04:55:12 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 04:55:12 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 04:55:12 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 04:55:12 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 04:55:12 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 04:55:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:14 INFO - warning: no files found matching '*.txt' 04:55:14 INFO - no previously-included directories found matching 'build' 04:55:14 INFO - no previously-included directories found matching 'dist' 04:55:14 INFO - no previously-included directories found matching '.git*' 04:55:14 INFO - Installing collected packages: jsonschema, functools32 04:55:14 INFO - Running setup.py install for functools32 04:55:14 INFO - warning: no files found matching '*.txt' 04:55:14 INFO - no previously-included directories found matching 'build' 04:55:14 INFO - no previously-included directories found matching 'dist' 04:55:14 INFO - no previously-included directories found matching '.git*' 04:55:14 INFO - Successfully installed jsonschema functools32 04:55:14 INFO - Cleaning up... 04:55:14 INFO - Return code: 0 04:55:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 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 0x7fe33013ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', '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 04:55:14 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 04:55:14 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 04:55:14 INFO - Using env: {'DISPLAY': ':0', 04:55:14 INFO - 'HOME': '/home/cltbld', 04:55:14 INFO - 'LANG': 'en_US.UTF-8', 04:55:14 INFO - 'LANGUAGE': 'en_US:en', 04:55:14 INFO - 'LOGNAME': 'cltbld', 04:55:14 INFO - 'MAIL': '/var/mail/cltbld', 04:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:14 INFO - 'MOZ_NO_REMOTE': '1', 04:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:14 INFO - 'NO_EM_RESTART': '1', 04:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:14 INFO - 'PWD': '/builds/slave/test', 04:55:14 INFO - 'SHELL': '/bin/bash', 04:55:14 INFO - 'SHLVL': '1', 04:55:14 INFO - 'TERM': 'linux', 04:55:14 INFO - 'TMOUT': '86400', 04:55:14 INFO - 'USER': 'cltbld', 04:55:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:14 INFO - '_': '/tools/buildbot/bin/python'} 04:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:14 INFO - Downloading/unpacking flake8 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:14 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 04:55:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:17 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 04:55:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:18 INFO - no previously-included directories found matching 'docs/_build' 04:55:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:18 INFO - Running setup.py install for pep8 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:18 INFO - no previously-included directories found matching 'docs/_build' 04:55:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:55:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:18 INFO - Cleaning up... 04:55:18 INFO - Return code: 0 04:55:18 INFO - Running post-action listener: _resource_record_post_action 04:55:18 INFO - Running post-action listener: _start_resource_monitoring 04:55:18 INFO - Starting resource monitoring. 04:55:18 INFO - ##### 04:55:18 INFO - ##### Finished create-virtualenv step (success) 04:55:18 INFO - ##### 04:55:18 INFO - ##### 04:55:18 INFO - ##### Running install step. 04:55:18 INFO - ##### 04:55:18 INFO - Running pre-action listener: _resource_record_pre_action 04:55:18 INFO - Running main action method: install 04:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:18 INFO - Reading from file tmpfile_stdout 04:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:19 INFO - Reading from file tmpfile_stdout 04:55:19 INFO - Output received: 04:55:19 INFO - Usage: mozinstall [options] installer 04:55:19 INFO - Options: 04:55:19 INFO - -h, --help show this help message and exit 04:55:19 INFO - -d DEST, --destination=DEST 04:55:19 INFO - Directory to install application into. [default: 04:55:19 INFO - "/builds/slave/test"] 04:55:19 INFO - --app=APP Application being installed. [default: firefox] 04:55:19 INFO - mkdir: /builds/slave/test/build/application 04:55:19 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'] 04:55:19 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 04:55:34 INFO - Reading from file tmpfile_stdout 04:55:34 INFO - Output received: 04:55:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:55:34 INFO - Running post-action listener: _resource_record_post_action 04:55:34 INFO - ##### 04:55:34 INFO - ##### Finished install step (success) 04:55:34 INFO - ##### 04:55:34 INFO - ##### 04:55:34 INFO - ##### Running run-tests step. 04:55:34 INFO - ##### 04:55:34 INFO - Running pre-action listener: _resource_record_pre_action 04:55:34 INFO - Running main action method: run_tests 04:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:34 INFO - Python 2.7.3 04:55:34 INFO - Return code: 0 04:55:34 INFO - grabbing minidump binary from tooltool 04:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:34 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 0x24899c0>, '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 0x248a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:34 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 04:55:34 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 04:55:34 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 04:55:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:34 INFO - Return code: 0 04:55:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:55:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:55:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:55:35 INFO - Return code: 0 04:55:35 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/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:55:35 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/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 04:55:35 INFO - Using env: {'DISPLAY': ':0', 04:55:35 INFO - 'HOME': '/home/cltbld', 04:55:35 INFO - 'LANG': 'en_US.UTF-8', 04:55:35 INFO - 'LANGUAGE': 'en_US:en', 04:55:35 INFO - 'LOGNAME': 'cltbld', 04:55:35 INFO - 'MAIL': '/var/mail/cltbld', 04:55:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:35 INFO - 'MOZ_NO_REMOTE': '1', 04:55:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:35 INFO - 'NO_EM_RESTART': '1', 04:55:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:35 INFO - 'PWD': '/builds/slave/test', 04:55:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:35 INFO - 'SHELL': '/bin/bash', 04:55:35 INFO - 'SHLVL': '1', 04:55:35 INFO - 'TERM': 'linux', 04:55:35 INFO - 'TMOUT': '86400', 04:55:35 INFO - 'USER': 'cltbld', 04:55:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480', 04:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:35 INFO - '_': '/tools/buildbot/bin/python'} 04:55:35 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/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:55:36 INFO - mozversion application_buildid: 20160518041250 04:55:36 INFO - mozversion application_changeset: 47b83c8478a06374aa9306122a778654b912f713 04:55:36 INFO - mozversion application_display_name: Nightly 04:55:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:36 INFO - mozversion application_name: Firefox 04:55:36 INFO - mozversion application_remotingname: firefox 04:55:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:55:36 INFO - mozversion application_vendor: Mozilla 04:55:36 INFO - mozversion application_version: 49.0a1 04:55:36 INFO - mozversion platform_buildid: 20160518041250 04:55:36 INFO - mozversion platform_changeset: 47b83c8478a06374aa9306122a778654b912f713 04:55:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:55:36 INFO - mozversion platform_version: 49.0a1 04:55:36 INFO - using testdate: 1463572536 04:55:36 INFO - actual date: 1463572536 04:55:36 INFO - starting webserver on 'localhost:47922' 04:55:36 INFO - SUITE-START | Running 2 tests 04:55:36 INFO - TEST-START | dromaeo_css 04:55:36 INFO - operating with platform_type : linux_ 04:55:36 INFO - Initialising browser for dromaeo_css test... 04:55:36 INFO - TEST-INFO | started process 7348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFO0cW/profile http://localhost:47922/getInfo.html) 04:55:40 INFO - PROCESS | 7348 | __metrics Screen width/height:1600/1200 04:55:40 INFO - PROCESS | 7348 | colorDepth:24 04:55:40 INFO - PROCESS | 7348 | Browser inner width/height: 1024/697 04:55:40 INFO - PROCESS | 7348 | __metrics 04:55:41 ERROR - PROCESS | 7348 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:55:42 INFO - TEST-INFO | 7348: exit 0 04:55:42 INFO - Browser initialized. 04:55:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:42 INFO - TEST-INFO | started process 7429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFO0cW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:54 INFO - PROCESS | 7429 | RSS: Main: 154509312 04:55:54 INFO - PROCESS | 7429 | 04:56:44 INFO - PROCESS | 7429 | 1463572604924 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] 04:58:57 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47922/tests/dromaeo/cssquery-ext.html) 04:58:58 INFO - PROCESS | 7429 | RSS: Main: 233603072 04:58:58 INFO - PROCESS | 7429 | 05:02:01 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-ext.html (next: http://localhost:47922/tests/dromaeo/cssquery-jquery.html) 05:02:02 INFO - PROCESS | 7429 | RSS: Main: 238673920 05:02:02 INFO - PROCESS | 7429 | 05:05:04 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47922/tests/dromaeo/cssquery-mootools.html) 05:05:04 INFO - PROCESS | 7429 | RSS: Main: 237346816 05:05:04 INFO - PROCESS | 7429 | 05:08:07 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47922/tests/dromaeo/cssquery-prototype.html) 05:08:07 INFO - PROCESS | 7429 | RSS: Main: 231555072 05:08:07 INFO - PROCESS | 7429 | 05:11:10 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47922/tests/dromaeo/cssquery-yui.html) 05:11:11 INFO - PROCESS | 7429 | RSS: Main: 219234304 05:11:11 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | Cycle 1(1): loaded http://localhost:47922/tests/dromaeo/cssquery-yui.html (next: http://localhost:47922/tests/dromaeo/cssquery-dojo.html) 05:14:14 INFO - PROCESS | 7429 | RSS: Main: 266199040 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | __start_tp_report 05:14:14 INFO - PROCESS | 7429 | _x_x_mozilla_page_load 05:14:14 INFO - PROCESS | 7429 | _x_x_mozilla_page_load_details 05:14:14 INFO - PROCESS | 7429 | |i|pagename|runs| 05:14:14 INFO - PROCESS | 7429 | |0;dojo.html;2678.5714285714284;2703.918882433528;2730.4812085703716;2736.835789852609;2756.1593713917246;4680.4149481314835;4720.244760838266;4767.141914455401;4833.78247978841;4871.220604703248;4754.381930349058;4769.642276829234;4770.09368220038;4811.711297322163;4820.180569303218;4222.261104306749;4378.496472905616;4439.733615983036;4469.061497085616;4600.884977875547;4494.887627809315;4535.931961020588;4570.291604801245;4575.130725162225;4599.770011499429;4348.652107831397;4357.520672725997;4375.2124617568825;4387.561243875619;4395.406620106309;4355.80398882051;4362.258416069244;4364.585364390409;4394.912101757947;4426.490953540352;4390.473143222802;4420.8452704155525;4421.049474362995;4429.058138256922;4460.576245256695;4599.83900563482;4661.580457758784;4680.227762419197;4681.063787242531;4701.059788042405;5133.25567792668;5202.739863006835;5206.427292997767;5208;5210.921836172461;5186.740662966837;5208.2968799212;5225.503577160163;5236.528712415901;5237;4666.183417901888;4682.789274482657;4740.95259047412;4748.145333839873;4772.308015337757;5190.351206099238;5260.158374660113;5262.868428289246;5265.578753699695;5272.209168624737;4881.609471242292;4998.600111991032;5013.147764879979;5058.418281897555;5059.620528460307;5083.339165908408;5134.409542902614;5137.588992880561;5138.152204886227;5169.612279079084;5093.567046800989;5099.6685215460875;5104.668196567211;5120.795168193231;5170.638055336166;4869.293952376956;4904.2643603459765;5093.643444958817;5109;5112.105381558213;4366.541513141138;4379.167958087953;4381.846635367747;4398.120375924827;4431.224535706303;3796.3925771876366;3804;3810.733248672622;3837.7889216092826;3847.0574709196426;4304.332828411601;4409.250427427345;4415.072834704748;4456.331550267486;4462.062966777014;5100.923486147711;5152.948470515322;5171.069207542679;5171.146760784503;5198.142306519458;4450.287953927356;4460.30865215892;4463.2635615123145;4466.173757854743;4507.684462087623;4539.341795439709;4630.351750754897;4708.693934894221;4714.339992401066;4748.7863046163;4873.439554451213;4879.121758083579;4914.631402644744;4917.434495032974;4956.132676781477;5141.048905952411;5157.871053223699;5160.329157209689;5161.535461808456;5207.765650545659;4710.105080034782;4851.054044461296;4877.561019508261;4894.755262236803;4911.778969946433;5068.797248110034;5093.337866077386;5094.617903657167;5097.566706829961;5131.435542090442;5166.844994650167;5169.121249387688;5169.121249387688;5173.40505841833;5200.791968321376;4871.293662419001;4973.179425394914;5017.147084995487;5017.347744793154;5029.59763218949;5004.674696144739;5010.624203184849;5028.84913452597;5031.3962324519825;5080.568151707146;4950.2079667253065;4959.57843583285;4966.081274964144;5012.8496145115705;5018.548330650259;4895.16782147043;5000.049990501793;5025.095482813129;5034.09386310453;5077.289179514944;4940.75296235194;4969.403671559436;4972.303877457087;4975.850724478271;5018.974905125451 05:14:14 INFO - PROCESS | 7429 | |1;ext.html;595.5503594785936;605.4308949587388;607.844999525121;622.9657368844714;633.4520639646704;28742.281442963937;31545;31603;41947.161056778845;42815;44252.247207863016;44617;44720.77639611797;44723.55276447235;44795.77602111985;7526.924730752705;8088.797780055516;8229.259366657;8233.135520770293;8237.50574965501;7579.279968403021;7803.141654418009;7808.960955195216;10070.748231294203;10361.067503924645;10527;10576;10584.100351470135;10585.470726463685;10588.3646981181;10447.111995480393;10508.106810921081;10514.053735163872;10520.263581549218;10521.579136834518;7532.39740820733;9924.305298629099;10294.794104117876;10302.793944121151;10669.466526673636;40658.796706016576;41044.17911641781;41173;41177.58822411797;41204.1759164818;3200.311932934407;3290.8025518468967;3315.2043509557775;3359.7480188985924;3546.0425685065147;30193.849030754925;30223.546646800314;30517.389652207054;30986;31167.688323116705;3417.8120203388803;3420.589529256505;3435.9484607730906;3438.398280300937;3497.615262321143;266498;268525;268911.8316126298;268920;269770;55893.720531397084;55951.16073258904;56291.71854140703;56316.02893898776;56350.36496350332;34989;35647.28705425877;35663.286734265166;37915.43126853099;61107;13619.795703064461;13684;13774.517891873737;13799.586012419644;13804.17174969505;9246.815063698688;10212.897871021343;10311.07200351972;10323.380597164043;10324;19392.61214775725;19660.410187694106;19808.929615909557;20667.896660516602;20699.58600827975;7061.929380706127;7137.857942729139;7175.067241258603;7305.269473052758;7392.556446613113;814.1166833985193;832.8173992930053;881.2157180109707;915.945043297391;956.8421210500329;29143.854280728883;29170.124896253146;29363.706362936526;29364.265893352836;29917.70082299149;990.9141257652682;1010.9292349535461;1013.1135256650431;1046.9582765148725;1060.188955449082;14444.566663000127;14815.185164815823;14955;15197.316120774592;15211.619709507351;405045;405793;407726;408389;409634;35914.461283080775;36237.275254494765;36259.274814503566;36273.27453450916;36288.27423451569;1165.4988355007258;1197.9401029948467;1225.5281716539196;1248.9625311240677;1277.5847849448967;27154.913803447642;29612.555811662412;29678.703212967594;29854;30098.247543810703;45347.31979020251;45795.54204458046;45878.31182532198;45878.54121458743;45959.54040459686;302297;302878;303438;304634;305225;22934.19730309431;25381.238562843144;26207.73792262129;26248.475030499663;26340.736592633828;44747.77626111849;44828;45335.77332113318;46254.7687261575;46382.53617463782;36990.815045924595;38102.42846357251;38238.6176138235;38589.228215434974;38647;37838.810805945795;37890.24219515539;38044.23911521699;38470;38516.6148338513;37472.250554989296;37806.43290350592;38199.427008594335;38383;38527.229455411296;32997.17507062342;34063.4890476648;34509.30981380409;34805.47791783074;34868.65131348654;23162.1893233736;23250.3024909253;23794.286171414886;23794.643080354155;23860.64209036831 05:14:14 INFO - PROCESS | 7429 | |2;jquery.html;380.7981769662079;387.7053439386067;388.2371140708509;393.35293442287457;405.37774516117764;16035.759463608056;17030.23363948622;17738.379156729487;17830.82169178308;17848.64302713945;14674.486392976249;15206.847931520682;15700.136492492937;15718.842811571882;15749.133797641125;4776.641751868615;4981.626378021663;5011.3485246918035;5018.849434516952;5019.222020586797;3627.6009638939695;3790.1851102013197;5462.8361149165585;5766.711664416784;5766.7404966776385;5635.5773317001185;5695.686737229451;5713.228714123603;5728.083506638938;5735.541156707453;5584.21820945068;5749.856253593652;5758.683272420015;5761.107028410582;5762.942370576283;3476.6523347665284;3677.3196958562485;3677.724170687209;3710.0168455359353;5177.404598471187;12423.130380873343;12815.231086134861;12902.548410805577;12922.28927408992;12956.611301660965;1853.156813649786;2037.7554693436734;2083.2500299892026;2220;2289.1873384948435;9292.860607090899;9506.954235034209;9933.90066099337;12231;12765.978721702242;1660.8007039155257;1686.072660036987;1719.2864961041153;1726.7064599018197;1775.1035726957932;70592.647036765;71227.28772712259;72527;72640;72840;9900.752481187883;9933.3543319684;10559.683209503728;10624.840627390595;10687.893121068846;14682.926585367219;14876.107433554022;14881.776773348409;14904.403823846924;14916.477923272634;6915.308469153045;7086.114235720535;7280.490365674458;7299.05112335393;7303.342699157101;6405.19935008124;6438.6136831790245;6478.1578394808375;6577.901331480031;6578.671066446658;4530.343100250445;4570.7486088264795;4578.702384345007;4587.72473651582;4658.883527911829;1674.4390629139132;1795.9281628734705;1895.734597156399;1906.5424298168616;1908.2557802457052;828.5484410996022;883.2908322396183;904.8868891388577;1000.1798525209258;1011.9797604047877;16555.6688866222;16680.416185433693;16921.407750728664;17223.56941076458;17345.13274336278;866.1598249697784;868.7133246028795;879.4415546128255;901.832127395025;935.9766005849908;7555.697772089165;9673.613055477703;9684.56419461126;9723.367981081206;9816.312858100007;366515;367949;374728;376330;388381;75692.62153689197;78733.60633196797;79749.60125199454;80249;80899;917.2982668258787;918.6600957645713;921.6820197032014;924.6440120553501;925.9861102083474;15273.6181595461;15324.157171355682;15425.922870385577;15483;15880.285387157375;33974.15064623404;34711.82644086763;34767.82616086904;34791.65208347884;35645.465318019735;48278.5172148274;49937.500624993285;50856.491435085176;51175.48824511707;51214;7750.147483776893;7992.720254791287;8087.069986951576;8103.8379232413845;8144.5520496373265;11587.246828956091;11823.290602563873;11829.704257393634;11961.162718609614;12326.260424374566;10532.89467105319;10579.576816927236;10611.681649550526;10631.149508039493;10735.677929662123;10331.22515811302;10342.741431464274;10370.792584148125;10488.213383996079;10526.947365263124;10450.843237351597;10548.63240036636;10611.628592999208;10673.946630266799;11075.169362298022;6866.828329291808;7087;7419.851602967802;7995.560244186626;8090.757277281691;9796.9020309796;9900.801983960424;9972.900270997487;9990;10001.499925003574 05:14:14 INFO - PROCESS | 7429 | |3;mootools.html;1302.3293004102882;1484.2282013353054;1512.5613572064099;1677.2452396421613;1829.3962992212562;6848.417884479819;7718.614069296534;7946.523208607473;7982;8172;7868.2918537331625;8028.839423211532;8031.799205019863;8032.196780321965;8033.357331413487;1969.5470041890374;2026.9797302026939;2027.1182035814395;2253.346529506445;2284.0635339510804;2028.4523178741804;2213.015208232337;2292.5300313435787;2293.0713061210154;2327.3134425344565;2293.0713061210236;2295.540891821642;2300.9654855177187;2304.435413323738;2305.1125316753005;1910.703840904662;2253.2451628704403;2254.447660323215;2263.321003698884;2264.728232612089;2193.3529608765452;2275.24916777463;2277.077783497686;2281.6691579720846;2289.0614847912443;7998.920010799876;8039.959800200962;8041.758747237593;8052.919470805334;8055.63749631268;4553.408056952608;4688.038952014863;4690.366800481926;4696.2486002239475;4698.060387922429;2969.094426200008;3045.345250771095;3094.675059118805;3107.5494053362363;3128.4525208088494;867.3841572483544;924.0528458330198;924.8057907839362;940.3464592108487;990.1929927109383;10944.945275273652;10953.123750099972;10960.12319014477;10962.232643714942;10973.725656858562;4321.611055005002;4468.285074388147;4470.821167153343;4475.3217543421215;4478.731276123443;9435.575399107056;9493.050694930589;9505.90494095064;9514.666986655573;9522.714318570454;4714.669973101919;4716.033213191287;4717.599004084623;4718.127146477913;4718.669693121448;4141.420201171838;4164.37534369847;4271.380649805761;4317.546657600907;4323.740575565476;3683.4843121962945;3775.452559378875;3816.1413681921345;3850.5764365919727;3890.7665540067687;1212.5513559982687;1221.5541327415428;1229.0843321725372;1232.3591732299153;1240.528599132324;835.8996920369594;855.4482358878488;876.8071024374627;900.7522931193843;913.1051569461832;5331.120365139708;5351.25082488452;5513.062779327443;5686.744096515667;5740;853.0871966995379;887.4675194883018;924.778053267211;949.924006079512;954.5418199264392;3587.3901436755814;3727.366347720894;3732;3737.3085979093953;3748.5126933498473;9625.855612165824;9652.517374131265;10063.094321511098;10066.848997265048;10072.194224462026;9791.265655075898;9843.360181588174;9870.950645246729;9871.901280987242;9879.407235565888;7501.324880760758;7548.773536793905;7667.309942105126;7739.845203096019;7744;5325.334333208349;5332.253484512094;5347;5433.5381492572;5486.725663716878;9033.683821066494;9178.852643419572;9251.491167985825;9273.119053689888;9277.16505514507;8075.9192408077515;8745.91254087451;8763.824723505366;9134.862977055216;9260.212881905114;6567.310432404529;6765.695543700447;6913.41235994926;6921.169459664872;6925.792226233221;7375.557466552024;7624;7643.961780191064;7701.3068823806125;7775.455718099679;6814.93185068143;6935.549189302679;6949.583025018515;6963.199232088375;7018.227994920657;6914;6988.475864310095;7005.684744186626;7022.613756243456;7160.785176444715;6607.438367738796;6615.66921653925;6652.90020649681;6654.900176497454;6658.034584985053;4599.563041511051;4669.509701481295;4772.284157376283;4779.665423420327;4838.830640927551;4537.546245375436;4644.801974065652;4668.08573832984;4744.9051018978735;4746.762661866962 05:14:14 INFO - PROCESS | 7429 | |4;prototype.html;302.9984850075751;315.147525942326;322.68054625920314;324.2509802356557;324.7061409424471;4875.488073752258;4883.19427294496;4941.652714960392;4958.900821983558;4980.605430479467;4604.263317869141;4697.953020469794;4733.313669517918;4797.712137271767;4834.419869615642;3839.0978120141745;3874.651281384675;3881.864134755277;3887.358585833334;3888.7666739995548;3874.3994680824517;3882.4758657581147;3887.8142166639163;3890.610938906115;3915.490986171808;3671.1372827385676;3710.202306504101;3879.922401551967;3885.941710874339;3895.8831235062853;3852.438128644448;3855.20968201518;3858.2090671412575;3873.6707379872746;3882.2041481496226;3422.828858557062;3450.102973226979;3456.4988076728987;3473.201163732356;3481.147118955872;4425.8714027923;4674.649401294916;4681.836135735233;4687.929681054787;4707.29390591414;4313.503947046067;4346.282863327548;4350.282203436429;4355.453813896084;4359.629431498295;5081.441041485434;5085.694858308476;5100.974495127538;5107.4892510749;5109.6167787415725;3548.3435564420665;3587.5694916609914;3592.173800026009;3608.2963822054708;3615.2227271136567;5115.693058416507;5273.367195936474;5307.893842123174;5344.518993290622;5346.545543628797;3664.2488289900507;3665.157013886821;3669.412893936957;3686.5023221864703;3689.7639290837333;3721.292954338667;3769.266137576745;3792.051987003249;3794;3798.2023775007005;4084.4281800547947;4304.978475107604;4314.762688052125;4352.281873490839;4368.191884501377;5060.608332708534;5072.898542029138;5107.668001579886;5111.8722031948755;5123.2827404163445;1242.142921384242;1283.4160456992047;1287.3949243855373;1301.1217428235902;1322.358656051814;812.1147948735907;829.8547754143001;881.6693739847557;908.7228395339353;909.3861643390817;4497.9325310120375;4511.864644060618;4528.728276303366;4547.636189104864;4559.293309537027;5219;5240.449752775904;5249.606279529051;5255.923910055507;5260.395054568697;4399.934000989988;4643.930341044887;4645.744484053342;4651.116287905287;4666.2767271073035;2815.4087641595493;2860.2134413036583;2867.799254052238;2873.267316834194;2876.4822331980026;4845.407706876804;5120.820771273062;5121.28302037715;5136.357955255593;5139.357580302462;5479.53423958968;5489.972550137303;5503.642777905475;5504.9449505504435;5506.504414602705;5083.415407228142;5107.310513080686;5113.616478764033;5116.462771408948;5128.512791284822;5202.8959420812125;5217.973910130425;5294.802656897498;5352.732363381893;5367.624266301477;5191;5199.948000519947;5202.635815492879;5221.190715439113;5222.268882356397;5030.270610761492;5050.949490505195;5051.949480505295;5066.771995260148;5085.949140508547;3651.7036452060197;3700.7039436844448;3711.1278849469813;3733.757305775116;3756.8309426075343;5180.844574662766;5250.448702886295;5267.578593712417;5269.657472264291;5286.76209570578;5116.820911268088;5154.716490593053;5155.350287907833;5164.277001219757;5168.3797944246935;4931.580815630711;5107.624954396224;5134.7946082156295;5149.407818100966;5152.76812543429;4820.831270905502;4902.338184345068;4986.855652069645;5039.319691841554;5057.949420505895;5170.612204084633;5191.76637051326;5194.402643696023;5217.217417387422;5250.159974404077;5058.038972595195;5070.290159377616;5072.67027643202;5075.87310317245;5094.872628184325 05:14:14 INFO - PROCESS | 7429 | |5;yui.html;636.3572791480606;638.0907207229696;672.0255629337461;707.2149913595911;729.8248420379107;11494.36780977046;11818;12158.878411215885;12167.756644867097;12179.330136842482;12497;12616.243025418482;12623.431945562448;12643.62069137925;12693.80959285609;684.3122661724959;848.245061894914;864.0840708848609;880.8722735203391;885.623609965762;864.0754392799707;865.5758678247645;867.6572753762292;868.9739307820776;871.0331531999507;912.3248795891026;913.3834661603424;914.2000749344323;914.2320450821309;915.1809130827905;720.0603212807284;870.791010157564;885.5041176940933;915.6520522201588;917.4036876030567;673.4107655801174;678.5148618737626;678.5589366911497;679.0493309366876;680.0309558878578;11913.94043029788;11939.164258501909;11959.222650527689;11961.162718609701;11962.222455540363;12187.32969686667;12431.813522797165;12463.688407789787;12556.036021740007;12642.936785316106;10779.514921828459;10805.891941080567;10939.28894621847;11106.111511079094;11371.431428428545;4141.130362623852;4155.812988415529;4190.5180904195795;4358.019445624741;4364.934525982113;47046.529534704896;47058;47102.76448617735;48486.51513484891;48511.51488485105;10007.549660265306;10046;10151.441670708182;10275;10289.794204115875;18267.90866045661;18287.177077031567;18345.7248141278;18385.448436546925;18386.81613183878;6186.969065154735;6334.746610135543;6369.331220221903;6369.490440764727;6537.215534135934;3758.0980564664283;3764.5294338207723;3771.7548359356556;3788.5264341957254;3863.130795570974;2822.8588570571387;2921.6055832462343;2926.3708302715017;2931.3844092740337;2943.028800495831;542.8018773147852;558.8183840251935;562.3645280832633;573.037297340472;575.1459083261353;495.92561115832194;544.6459801129298;545.4164044472456;572.7766171193238;581.2037508613226;7243.311885370881;7706.009373787171;7709.460337776414;7739.7678069658;7752.379809615217;542.156945949053;604.4348534120611;613.4816080412045;615.1418770814688;635.8029011006603;3484.564429446319;3579.713622910161;3580.5703315601772;3589.9282014359565;3627;49975.75012124916;51040;64206.678966604864;65388.67305663441;65442.345576544576;49036;50042.74978625084;50475.24287135696;51244.48755512472;52567;47308;47591.76204119027;47597.28604070942;47603.285950710764;48703;7751.496152750054;7798.98613180283;7829.847951130136;7966.322862556747;8005.759827205193;31264.843675782384;31611.36777264396;31706.36587268288;32055.198620034687;32096.839515802272;38380.808095960456;40461.59538404578;42532.362014570426;42630.57369426266;43104;10545.73635659084;11027.889721102687;11044.502997364978;11072.889271107508;11097.11223102166;12009.81985270239;12295.815562766387;12369.505219791468;12436.875631243573;12459.252444853339;10603.363798172135;11053;11513.94243028813;11528.711782205512;11541.076713862703;11453.312801231952;11690.824637630272;12046.096542759504;12165.513379465076;12394.070444716863;10060.949695251476;10582.523786429783;10745.355278683304;10856.240063195817;10985.066269366873;9364.906350936404;9530.95234523823;9538.189253913495;9707.126358627758;9712.854307185256;9184.49485278316;9219.907800921905;9244;9300.441973481613;9342 05:14:14 INFO - PROCESS | 7429 | __end_tp_report 05:14:14 INFO - PROCESS | 7429 | __start_cc_report 05:14:14 INFO - PROCESS | 7429 | _x_x_mozilla_cycle_collect,991 05:14:14 INFO - PROCESS | 7429 | __end_cc_report 05:14:14 INFO - PROCESS | 7429 | __startTimestamp1463573654661__endTimestamp 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | ------- Summary: start ------- 05:14:14 INFO - PROCESS | 7429 | Number of tests: 6 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#0] dojo.html Cycles:165 Average:4752.84 Median:4881.61 stddev:493.52 (10.1%) stddev-sans-first:467.43 05:14:14 INFO - PROCESS | 7429 | Values: 2678.6 2703.9 2730.5 2736.8 2756.2 4680.4 4720.2 4767.1 4833.8 4871.2 4754.4 4769.6 4770.1 4811.7 4820.2 4222.3 4378.5 4439.7 4469.1 4600.9 4494.9 4535.9 4570.3 4575.1 4599.8 4348.7 4357.5 4375.2 4387.6 4395.4 4355.8 4362.3 4364.6 4394.9 4426.5 4390.5 4420.8 4421.0 4429.1 4460.6 4599.8 4661.6 4680.2 4681.1 4701.1 5133.3 5202.7 5206.4 5208.0 5210.9 5186.7 5208.3 5225.5 5236.5 5237.0 4666.2 4682.8 4741.0 4748.1 4772.3 5190.4 5260.2 5262.9 5265.6 5272.2 4881.6 4998.6 5013.1 5058.4 5059.6 5083.3 5134.4 5137.6 5138.2 5169.6 5093.6 5099.7 5104.7 5120.8 5170.6 4869.3 4904.3 5093.6 5109.0 5112.1 4366.5 4379.2 4381.8 4398.1 4431.2 3796.4 3804.0 3810.7 3837.8 3847.1 4304.3 4409.3 4415.1 4456.3 4462.1 5100.9 5152.9 5171.1 5171.1 5198.1 4450.3 4460.3 4463.3 4466.2 4507.7 4539.3 4630.4 4708.7 4714.3 4748.8 4873.4 4879.1 4914.6 4917.4 4956.1 5141.0 5157.9 5160.3 5161.5 5207.8 4710.1 4851.1 4877.6 4894.8 4911.8 5068.8 5093.3 5094.6 5097.6 5131.4 5166.8 5169.1 5169.1 5173.4 5200.8 4871.3 4973.2 5017.1 5017.3 5029.6 5004.7 5010.6 5028.8 5031.4 5080.6 4950.2 4959.6 4966.1 5012.8 5018.5 4895.2 5000.0 5025.1 5034.1 5077.3 4940.8 4969.4 4972.3 4975.9 5019.0 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#1] ext.html Cycles:180 Average:48229.32 Median:18973.85 stddev:87283.48 (460.0%) stddev-sans-first:87455.06 05:14:14 INFO - PROCESS | 7429 | Values: 595.6 605.4 607.8 623.0 633.5 28742.3 31545.0 31603.0 41947.2 42815.0 44252.2 44617.0 44720.8 44723.6 44795.8 7526.9 8088.8 8229.3 8233.1 8237.5 7579.3 7803.1 7809.0 10070.7 10361.1 10527.0 10576.0 10584.1 10585.5 10588.4 10447.1 10508.1 10514.1 10520.3 10521.6 7532.4 9924.3 10294.8 10302.8 10669.5 40658.8 41044.2 41173.0 41177.6 41204.2 3200.3 3290.8 3315.2 3359.7 3546.0 30193.8 30223.5 30517.4 30986.0 31167.7 3417.8 3420.6 3435.9 3438.4 3497.6 266498.0 268525.0 268911.8 268920.0 269770.0 55893.7 55951.2 56291.7 56316.0 56350.4 34989.0 35647.3 35663.3 37915.4 61107.0 13619.8 13684.0 13774.5 13799.6 13804.2 9246.8 10212.9 10311.1 10323.4 10324.0 19392.6 19660.4 19808.9 20667.9 20699.6 7061.9 7137.9 7175.1 7305.3 7392.6 814.1 832.8 881.2 915.9 956.8 29143.9 29170.1 29363.7 29364.3 29917.7 990.9 1010.9 1013.1 1047.0 1060.2 14444.6 14815.2 14955.0 15197.3 15211.6 405045.0 405793.0 407726.0 408389.0 409634.0 35914.5 36237.3 36259.3 36273.3 36288.3 1165.5 1197.9 1225.5 1249.0 1277.6 27154.9 29612.6 29678.7 29854.0 30098.2 45347.3 45795.5 45878.3 45878.5 45959.5 302297.0 302878.0 303438.0 304634.0 305225.0 22934.2 25381.2 26207.7 26248.5 26340.7 44747.8 44828.0 45335.8 46254.8 46382.5 36990.8 38102.4 38238.6 38589.2 38647.0 37838.8 37890.2 38044.2 38470.0 38516.6 37472.3 37806.4 38199.4 38383.0 38527.2 32997.2 34063.5 34509.3 34805.5 34868.7 23162.2 23250.3 23794.3 23794.6 23860.6 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#2] jquery.html Cycles:180 Average:23759.43 Median:194384.62 stddev:62106.59 (32.0%) stddev-sans-first:62256.00 05:14:14 INFO - PROCESS | 7429 | Values: 380.8 387.7 388.2 393.4 405.4 16035.8 17030.2 17738.4 17830.8 17848.6 14674.5 15206.8 15700.1 15718.8 15749.1 4776.6 4981.6 5011.3 5018.8 5019.2 3627.6 3790.2 5462.8 5766.7 5766.7 5635.6 5695.7 5713.2 5728.1 5735.5 5584.2 5749.9 5758.7 5761.1 5762.9 3476.7 3677.3 3677.7 3710.0 5177.4 12423.1 12815.2 12902.5 12922.3 12956.6 1853.2 2037.8 2083.3 2220.0 2289.2 9292.9 9507.0 9933.9 12231.0 12766.0 1660.8 1686.1 1719.3 1726.7 1775.1 70592.6 71227.3 72527.0 72640.0 72840.0 9900.8 9933.4 10559.7 10624.8 10687.9 14682.9 14876.1 14881.8 14904.4 14916.5 6915.3 7086.1 7280.5 7299.1 7303.3 6405.2 6438.6 6478.2 6577.9 6578.7 4530.3 4570.7 4578.7 4587.7 4658.9 1674.4 1795.9 1895.7 1906.5 1908.3 828.5 883.3 904.9 1000.2 1012.0 16555.7 16680.4 16921.4 17223.6 17345.1 866.2 868.7 879.4 901.8 936.0 7555.7 9673.6 9684.6 9723.4 9816.3 366515.0 367949.0 374728.0 376330.0 388381.0 75692.6 78733.6 79749.6 80249.0 80899.0 917.3 918.7 921.7 924.6 926.0 15273.6 15324.2 15425.9 15483.0 15880.3 33974.2 34711.8 34767.8 34791.7 35645.5 48278.5 49937.5 50856.5 51175.5 51214.0 7750.1 7992.7 8087.1 8103.8 8144.6 11587.2 11823.3 11829.7 11961.2 12326.3 10532.9 10579.6 10611.7 10631.1 10735.7 10331.2 10342.7 10370.8 10488.2 10526.9 10450.8 10548.6 10611.6 10673.9 11075.2 6866.8 7087.0 7419.9 7995.6 8090.8 9796.9 9900.8 9972.9 9990.0 10001.5 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#3] mootools.html Cycles:180 Average:5283.51 Median:5339.63 stddev:2942.42 (55.1%) stddev-sans-first:2935.46 05:14:14 INFO - PROCESS | 7429 | Values: 1302.3 1484.2 1512.6 1677.2 1829.4 6848.4 7718.6 7946.5 7982.0 8172.0 7868.3 8028.8 8031.8 8032.2 8033.4 1969.5 2027.0 2027.1 2253.3 2284.1 2028.5 2213.0 2292.5 2293.1 2327.3 2293.1 2295.5 2301.0 2304.4 2305.1 1910.7 2253.2 2254.4 2263.3 2264.7 2193.4 2275.2 2277.1 2281.7 2289.1 7998.9 8040.0 8041.8 8052.9 8055.6 4553.4 4688.0 4690.4 4696.2 4698.1 2969.1 3045.3 3094.7 3107.5 3128.5 867.4 924.1 924.8 940.3 990.2 10944.9 10953.1 10960.1 10962.2 10973.7 4321.6 4468.3 4470.8 4475.3 4478.7 9435.6 9493.1 9505.9 9514.7 9522.7 4714.7 4716.0 4717.6 4718.1 4718.7 4141.4 4164.4 4271.4 4317.5 4323.7 3683.5 3775.5 3816.1 3850.6 3890.8 1212.6 1221.6 1229.1 1232.4 1240.5 835.9 855.4 876.8 900.8 913.1 5331.1 5351.3 5513.1 5686.7 5740.0 853.1 887.5 924.8 949.9 954.5 3587.4 3727.4 3732.0 3737.3 3748.5 9625.9 9652.5 10063.1 10066.8 10072.2 9791.3 9843.4 9871.0 9871.9 9879.4 7501.3 7548.8 7667.3 7739.8 7744.0 5325.3 5332.3 5347.0 5433.5 5486.7 9033.7 9178.9 9251.5 9273.1 9277.2 8075.9 8745.9 8763.8 9134.9 9260.2 6567.3 6765.7 6913.4 6921.2 6925.8 7375.6 7624.0 7644.0 7701.3 7775.5 6814.9 6935.5 6949.6 6963.2 7018.2 6914.0 6988.5 7005.7 7022.6 7160.8 6607.4 6615.7 6652.9 6654.9 6658.0 4599.6 4669.5 4772.3 4779.7 4838.8 4537.5 4644.8 4668.1 4744.9 4746.8 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#4] prototype.html Cycles:180 Average:4270.00 Median:4839.91 stddev:1239.44 (25.6%) stddev-sans-first:1206.62 05:14:14 INFO - PROCESS | 7429 | Values: 303.0 315.1 322.7 324.3 324.7 4875.5 4883.2 4941.7 4958.9 4980.6 4604.3 4698.0 4733.3 4797.7 4834.4 3839.1 3874.7 3881.9 3887.4 3888.8 3874.4 3882.5 3887.8 3890.6 3915.5 3671.1 3710.2 3879.9 3885.9 3895.9 3852.4 3855.2 3858.2 3873.7 3882.2 3422.8 3450.1 3456.5 3473.2 3481.1 4425.9 4674.6 4681.8 4687.9 4707.3 4313.5 4346.3 4350.3 4355.5 4359.6 5081.4 5085.7 5101.0 5107.5 5109.6 3548.3 3587.6 3592.2 3608.3 3615.2 5115.7 5273.4 5307.9 5344.5 5346.5 3664.2 3665.2 3669.4 3686.5 3689.8 3721.3 3769.3 3792.1 3794.0 3798.2 4084.4 4305.0 4314.8 4352.3 4368.2 5060.6 5072.9 5107.7 5111.9 5123.3 1242.1 1283.4 1287.4 1301.1 1322.4 812.1 829.9 881.7 908.7 909.4 4497.9 4511.9 4528.7 4547.6 4559.3 5219.0 5240.4 5249.6 5255.9 5260.4 4399.9 4643.9 4645.7 4651.1 4666.3 2815.4 2860.2 2867.8 2873.3 2876.5 4845.4 5120.8 5121.3 5136.4 5139.4 5479.5 5490.0 5503.6 5504.9 5506.5 5083.4 5107.3 5113.6 5116.5 5128.5 5202.9 5218.0 5294.8 5352.7 5367.6 5191.0 5199.9 5202.6 5221.2 5222.3 5030.3 5050.9 5051.9 5066.8 5085.9 3651.7 3700.7 3711.1 3733.8 3756.8 5180.8 5250.4 5267.6 5269.7 5286.8 5116.8 5154.7 5155.4 5164.3 5168.4 4931.6 5107.6 5134.8 5149.4 5152.8 4820.8 4902.3 4986.9 5039.3 5057.9 5170.6 5191.8 5194.4 5217.2 5250.2 5058.0 5070.3 5072.7 5075.9 5094.9 05:14:14 INFO - PROCESS | 7429 | 05:14:14 INFO - PROCESS | 7429 | [#5] yui.html Cycles:180 Average:13494.06 Median:47052.26 stddev:15909.06 (33.8%) stddev-sans-first:15924.39 05:14:14 INFO - PROCESS | 7429 | Values: 636.4 638.1 672.0 707.2 729.8 11494.4 11818.0 12158.9 12167.8 12179.3 12497.0 12616.2 12623.4 12643.6 12693.8 684.3 848.2 864.1 880.9 885.6 864.1 865.6 867.7 869.0 871.0 912.3 913.4 914.2 914.2 915.2 720.1 870.8 885.5 915.7 917.4 673.4 678.5 678.6 679.0 680.0 11913.9 11939.2 11959.2 11961.2 11962.2 12187.3 12431.8 12463.7 12556.0 12642.9 10779.5 10805.9 10939.3 11106.1 11371.4 4141.1 4155.8 4190.5 4358.0 4364.9 47046.5 47058.0 47102.8 48486.5 48511.5 10007.5 10046.0 10151.4 10275.0 10289.8 18267.9 18287.2 18345.7 18385.4 18386.8 6187.0 6334.7 6369.3 6369.5 6537.2 3758.1 3764.5 3771.8 3788.5 3863.1 2822.9 2921.6 2926.4 2931.4 2943.0 542.8 558.8 562.4 573.0 575.1 495.9 544.6 545.4 572.8 581.2 7243.3 7706.0 7709.5 7739.8 7752.4 542.2 604.4 613.5 615.1 635.8 3484.6 3579.7 3580.6 3589.9 3627.0 49975.8 51040.0 64206.7 65388.7 65442.3 49036.0 50042.7 50475.2 51244.5 52567.0 47308.0 47591.8 47597.3 47603.3 48703.0 7751.5 7799.0 7829.8 7966.3 8005.8 31264.8 31611.4 31706.4 32055.2 32096.8 38380.8 40461.6 42532.4 42630.6 43104.0 10545.7 11027.9 11044.5 11072.9 11097.1 12009.8 12295.8 12369.5 12436.9 12459.3 10603.4 11053.0 11513.9 11528.7 11541.1 11453.3 11690.8 12046.1 12165.5 12394.1 10060.9 10582.5 10745.4 10856.2 10985.1 9364.9 9531.0 9538.2 9707.1 9712.9 9184.5 9219.9 9244.0 9300.4 9342.0 05:14:14 INFO - PROCESS | 7429 | -------- Summary: end -------- 05:14:14 INFO - PROCESS | 7429 | 05:14:15 INFO - TEST-INFO | 7429: exit 0 05:14:15 INFO - TEST-OK | dromaeo_css | took 1119392ms 05:14:15 INFO - TEST-START | kraken 05:14:15 INFO - operating with platform_type : linux_ 05:14:15 INFO - Initialising browser for kraken test... 05:14:15 INFO - TEST-INFO | started process 7602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfJdX86/profile http://localhost:47922/getInfo.html) 05:14:19 INFO - PROCESS | 7602 | __metrics Screen width/height:1600/1200 05:14:19 INFO - PROCESS | 7602 | colorDepth:24 05:14:19 INFO - PROCESS | 7602 | Browser inner width/height: 1024/697 05:14:19 INFO - PROCESS | 7602 | __metrics 05:14:20 ERROR - PROCESS | 7602 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:14:21 INFO - TEST-INFO | 7602: exit 0 05:14:21 INFO - Browser initialized. 05:14:21 INFO - Running cycle 1/1 for kraken test... 05:14:21 INFO - TEST-INFO | started process 7680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfJdX86/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:33 INFO - PROCESS | 7680 | RSS: Main: 154886144 05:14:33 INFO - PROCESS | 7680 | 05:14:36 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47922/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:37 INFO - PROCESS | 7680 | RSS: Main: 209870848 05:14:37 INFO - PROCESS | 7680 | 05:14:39 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47922/tests/kraken/driver.html?testName=audio-dft) 05:14:40 INFO - PROCESS | 7680 | RSS: Main: 198332416 05:14:40 INFO - PROCESS | 7680 | 05:14:43 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47922/tests/kraken/driver.html?testName=audio-fft) 05:14:44 INFO - PROCESS | 7680 | RSS: Main: 266645504 05:14:44 INFO - PROCESS | 7680 | 05:14:46 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47922/tests/kraken/driver.html?testName=audio-oscillator) 05:14:47 INFO - PROCESS | 7680 | RSS: Main: 175955968 05:14:47 INFO - PROCESS | 7680 | 05:14:49 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:50 INFO - PROCESS | 7680 | RSS: Main: 179306496 05:14:50 INFO - PROCESS | 7680 | 05:14:53 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47922/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:54 INFO - PROCESS | 7680 | RSS: Main: 215937024 05:14:54 INFO - PROCESS | 7680 | 05:14:57 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47922/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:58 INFO - PROCESS | 7680 | RSS: Main: 214691840 05:14:58 INFO - PROCESS | 7680 | 05:15:01 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47922/tests/kraken/driver.html?testName=json-parse-financial) 05:15:02 INFO - PROCESS | 7680 | RSS: Main: 215396352 05:15:02 INFO - PROCESS | 7680 | 05:15:04 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:04 INFO - PROCESS | 7680 | RSS: Main: 207695872 05:15:04 INFO - PROCESS | 7680 | 05:15:06 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:07 INFO - PROCESS | 7680 | RSS: Main: 212062208 05:15:07 INFO - PROCESS | 7680 | 05:15:09 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:10 INFO - PROCESS | 7680 | RSS: Main: 215613440 05:15:10 INFO - PROCESS | 7680 | 05:15:13 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:13 INFO - PROCESS | 7680 | RSS: Main: 220295168 05:15:13 INFO - PROCESS | 7680 | 05:15:16 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:17 INFO - PROCESS | 7680 | RSS: Main: 220119040 05:15:17 INFO - PROCESS | 7680 | 05:15:18 INFO - PROCESS | 7680 | Cycle 1(1): loaded http://localhost:47922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47922/tests/kraken/driver.html?testName=ai-astar) 05:15:19 INFO - PROCESS | 7680 | RSS: Main: 266514432 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | __start_tp_report 05:15:19 INFO - PROCESS | 7680 | _x_x_mozilla_page_load 05:15:19 INFO - PROCESS | 7680 | _x_x_mozilla_page_load_details 05:15:19 INFO - PROCESS | 7680 | |i|pagename|runs| 05:15:19 INFO - PROCESS | 7680 | |0;ai-astar;113;106;112;112;112;112;111;111;111;113 05:15:19 INFO - PROCESS | 7680 | |1;audio-beat-detection;154;129;155;219;129;152;153;131;195;132 05:15:19 INFO - PROCESS | 7680 | |2;audio-dft;161;160;162;161;162;162;161;161;163;160 05:15:19 INFO - PROCESS | 7680 | |3;audio-fft;79;76;76;144;78;75;77;74;124;75 05:15:19 INFO - PROCESS | 7680 | |4;audio-oscillator;93;93;158;92;94;92;119;92;91;121 05:15:19 INFO - PROCESS | 7680 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;116;116;117 05:15:19 INFO - PROCESS | 7680 | |6;imaging-darkroom;147;146;145;146;146;145;146;147;148;145 05:15:19 INFO - PROCESS | 7680 | |7;imaging-desaturate;95;95;94;95;94;95;95;94;95;94 05:15:19 INFO - PROCESS | 7680 | |8;json-parse-financial;64;64;65;63;64;64;64;65;64;64 05:15:19 INFO - PROCESS | 7680 | |9;json-stringify-tinderbox;64;65;64;65;64;66;65;65;65;64 05:15:19 INFO - PROCESS | 7680 | |10;stanford-crypto-aes;85;87;82;82;81;83;82;83;166;84 05:15:19 INFO - PROCESS | 7680 | |11;stanford-crypto-ccm;144;140;128;128;126;137;124;129;144;134 05:15:19 INFO - PROCESS | 7680 | |12;stanford-crypto-pbkdf2;167;166;165;164;166;166;165;166;165;170 05:15:19 INFO - PROCESS | 7680 | |13;stanford-crypto-sha256-iterative;67;69;65;65;66;64;64;65;65;64 05:15:19 INFO - PROCESS | 7680 | __end_tp_report 05:15:19 INFO - PROCESS | 7680 | __start_cc_report 05:15:19 INFO - PROCESS | 7680 | _x_x_mozilla_cycle_collect,2098 05:15:19 INFO - PROCESS | 7680 | __end_cc_report 05:15:19 INFO - PROCESS | 7680 | __startTimestamp1463573719207__endTimestamp 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | ------- Summary: start ------- 05:15:19 INFO - PROCESS | 7680 | Number of tests: 14 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.00 (1.8%) stddev-sans-first:2.03 05:15:19 INFO - PROCESS | 7680 | Values: 113.0 106.0 112.0 112.0 112.0 112.0 111.0 111.0 111.0 113.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:153.50 stddev:30.12 (19.6%) stddev-sans-first:31.95 05:15:19 INFO - PROCESS | 7680 | Values: 154.0 129.0 155.0 219.0 129.0 152.0 153.0 131.0 195.0 132.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:15:19 INFO - PROCESS | 7680 | Values: 161.0 160.0 162.0 161.0 162.0 162.0 161.0 161.0 163.0 160.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#3] audio-fft Cycles:10 Average:87.80 Median:76.00 stddev:24.85 (32.7%) stddev-sans-first:26.15 05:15:19 INFO - PROCESS | 7680 | Values: 79.0 76.0 76.0 144.0 78.0 75.0 77.0 74.0 124.0 75.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:92.00 stddev:22.04 (24.0%) stddev-sans-first:22.98 05:15:19 INFO - PROCESS | 7680 | Values: 93.0 93.0 158.0 92.0 94.0 92.0 119.0 92.0 91.0 121.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:15:19 INFO - PROCESS | 7680 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 05:15:19 INFO - PROCESS | 7680 | Values: 147.0 146.0 145.0 146.0 146.0 145.0 146.0 147.0 148.0 145.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:15:19 INFO - PROCESS | 7680 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:15:19 INFO - PROCESS | 7680 | Values: 64.0 64.0 65.0 63.0 64.0 64.0 64.0 65.0 64.0 64.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:15:19 INFO - PROCESS | 7680 | Values: 64.0 65.0 64.0 65.0 64.0 66.0 65.0 65.0 65.0 64.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:83.00 stddev:26.24 (31.6%) stddev-sans-first:27.72 05:15:19 INFO - PROCESS | 7680 | Values: 85.0 87.0 82.0 82.0 81.0 83.0 82.0 83.0 166.0 84.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:135.50 stddev:7.47 (5.5%) stddev-sans-first:6.87 05:15:19 INFO - PROCESS | 7680 | Values: 144.0 140.0 128.0 128.0 126.0 137.0 124.0 129.0 144.0 134.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 05:15:19 INFO - PROCESS | 7680 | Values: 167.0 166.0 165.0 164.0 166.0 166.0 165.0 166.0 165.0 170.0 05:15:19 INFO - PROCESS | 7680 | 05:15:19 INFO - PROCESS | 7680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.58 (2.4%) stddev-sans-first:1.56 05:15:19 INFO - PROCESS | 7680 | Values: 67.0 69.0 65.0 65.0 66.0 64.0 64.0 65.0 65.0 64.0 05:15:19 INFO - PROCESS | 7680 | -------- Summary: end -------- 05:15:19 INFO - PROCESS | 7680 | 05:15:20 INFO - TEST-INFO | 7680: exit 0 05:15:20 INFO - TEST-OK | kraken | took 65034ms 05:15:20 INFO - SUITE-END | took 1184s 05:15:20 INFO - Completed test suite (00:19:44) 05:15:20 INFO - javascript benchmark 05:15:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.5714285714284, 2703.918882433528, 2730.4812085703716, 2736.835789852609, 2756.1593713917246, 4680.4149481314835, 4720.244760838266, 4767.141914455401, 4833.78247978841, 4871.220604703248, 4754.381930349058, 4769.642276829234, 4770.09368220038, 4811.711297322163, 4820.180569303218, 4222.261104306749, 4378.496472905616, 4439.733615983036, 4469.061497085616, 4600.884977875547, 4494.887627809315, 4535.931961020588, 4570.291604801245, 4575.130725162225, 4599.770011499429, 4348.652107831397, 4357.520672725997, 4375.2124617568825, 4387.561243875619, 4395.406620106309, 4355.80398882051, 4362.258416069244, 4364.585364390409, 4394.912101757947, 4426.490953540352, 4390.473143222802, 4420.8452704155525, 4421.049474362995, 4429.058138256922, 4460.576245256695, 4599.83900563482, 4661.580457758784, 4680.227762419197, 4681.063787242531, 4701.059788042405, 5133.25567792668, 5202.739863006835, 5206.427292997767, 5208.0, 5210.921836172461, 5186.740662966837, 5208.2968799212, 5225.503577160163, 5236.528712415901, 5237.0, 4666.183417901888, 4682.789274482657, 4740.95259047412, 4748.145333839873, 4772.308015337757, 5190.351206099238, 5260.158374660113, 5262.868428289246, 5265.578753699695, 5272.209168624737, 4881.609471242292, 4998.600111991032, 5013.147764879979, 5058.418281897555, 5059.620528460307, 5083.339165908408, 5134.409542902614, 5137.588992880561, 5138.152204886227, 5169.612279079084, 5093.567046800989, 5099.6685215460875, 5104.668196567211, 5120.795168193231, 5170.638055336166, 4869.293952376956, 4904.2643603459765, 5093.643444958817, 5109.0, 5112.105381558213, 4366.541513141138, 4379.167958087953, 4381.846635367747, 4398.120375924827, 4431.224535706303, 3796.3925771876366, 3804.0, 3810.733248672622, 3837.7889216092826, 3847.0574709196426, 4304.332828411601, 4409.250427427345, 4415.072834704748, 4456.331550267486, 4462.062966777014, 5100.923486147711, 5152.948470515322, 5171.069207542679, 5171.146760784503, 5198.142306519458, 4450.287953927356, 4460.30865215892, 4463.2635615123145, 4466.173757854743, 4507.684462087623, 4539.341795439709, 4630.351750754897, 4708.693934894221, 4714.339992401066, 4748.7863046163, 4873.439554451213, 4879.121758083579, 4914.631402644744, 4917.434495032974, 4956.132676781477, 5141.048905952411, 5157.871053223699, 5160.329157209689, 5161.535461808456, 5207.765650545659, 4710.105080034782, 4851.054044461296, 4877.561019508261, 4894.755262236803, 4911.778969946433, 5068.797248110034, 5093.337866077386, 5094.617903657167, 5097.566706829961, 5131.435542090442, 5166.844994650167, 5169.121249387688, 5169.121249387688, 5173.40505841833, 5200.791968321376, 4871.293662419001, 4973.179425394914, 5017.147084995487, 5017.347744793154, 5029.59763218949, 5004.674696144739, 5010.624203184849, 5028.84913452597, 5031.3962324519825, 5080.568151707146, 4950.2079667253065, 4959.57843583285, 4966.081274964144, 5012.8496145115705, 5018.548330650259, 4895.16782147043, 5000.049990501793, 5025.095482813129, 5034.09386310453, 5077.289179514944, 4940.75296235194, 4969.403671559436, 4972.303877457087, 4975.850724478271, 5018.974905125451], "value": 4721.882155408705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5503594785936, 605.4308949587388, 607.844999525121, 622.9657368844714, 633.4520639646704, 28742.281442963937, 31545.0, 31603.0, 41947.161056778845, 42815.0, 44252.247207863016, 44617.0, 44720.77639611797, 44723.55276447235, 44795.77602111985, 7526.924730752705, 8088.797780055516, 8229.259366657, 8233.135520770293, 8237.50574965501, 7579.279968403021, 7803.141654418009, 7808.960955195216, 10070.748231294203, 10361.067503924645, 10527.0, 10576.0, 10584.100351470135, 10585.470726463685, 10588.3646981181, 10447.111995480393, 10508.106810921081, 10514.053735163872, 10520.263581549218, 10521.579136834518, 7532.39740820733, 9924.305298629099, 10294.794104117876, 10302.793944121151, 10669.466526673636, 40658.796706016576, 41044.17911641781, 41173.0, 41177.58822411797, 41204.1759164818, 3200.311932934407, 3290.8025518468967, 3315.2043509557775, 3359.7480188985924, 3546.0425685065147, 30193.849030754925, 30223.546646800314, 30517.389652207054, 30986.0, 31167.688323116705, 3417.8120203388803, 3420.589529256505, 3435.9484607730906, 3438.398280300937, 3497.615262321143, 266498.0, 268525.0, 268911.8316126298, 268920.0, 269770.0, 55893.720531397084, 55951.16073258904, 56291.71854140703, 56316.02893898776, 56350.36496350332, 34989.0, 35647.28705425877, 35663.286734265166, 37915.43126853099, 61107.0, 13619.795703064461, 13684.0, 13774.517891873737, 13799.586012419644, 13804.17174969505, 9246.815063698688, 10212.897871021343, 10311.07200351972, 10323.380597164043, 10324.0, 19392.61214775725, 19660.410187694106, 19808.929615909557, 20667.896660516602, 20699.58600827975, 7061.929380706127, 7137.857942729139, 7175.067241258603, 7305.269473052758, 7392.556446613113, 814.1166833985193, 832.8173992930053, 881.2157180109707, 915.945043297391, 956.8421210500329, 29143.854280728883, 29170.124896253146, 29363.706362936526, 29364.265893352836, 29917.70082299149, 990.9141257652682, 1010.9292349535461, 1013.1135256650431, 1046.9582765148725, 1060.188955449082, 14444.566663000127, 14815.185164815823, 14955.0, 15197.316120774592, 15211.619709507351, 405045.0, 405793.0, 407726.0, 408389.0, 409634.0, 35914.461283080775, 36237.275254494765, 36259.274814503566, 36273.27453450916, 36288.27423451569, 1165.4988355007258, 1197.9401029948467, 1225.5281716539196, 1248.9625311240677, 1277.5847849448967, 27154.913803447642, 29612.555811662412, 29678.703212967594, 29854.0, 30098.247543810703, 45347.31979020251, 45795.54204458046, 45878.31182532198, 45878.54121458743, 45959.54040459686, 302297.0, 302878.0, 303438.0, 304634.0, 305225.0, 22934.19730309431, 25381.238562843144, 26207.73792262129, 26248.475030499663, 26340.736592633828, 44747.77626111849, 44828.0, 45335.77332113318, 46254.7687261575, 46382.53617463782, 36990.815045924595, 38102.42846357251, 38238.6176138235, 38589.228215434974, 38647.0, 37838.810805945795, 37890.24219515539, 38044.23911521699, 38470.0, 38516.6148338513, 37472.250554989296, 37806.43290350592, 38199.427008594335, 38383.0, 38527.229455411296, 32997.17507062342, 34063.4890476648, 34509.30981380409, 34805.47791783074, 34868.65131348654, 23162.1893233736, 23250.3024909253, 23794.286171414886, 23794.643080354155, 23860.64209036831], "value": 18126.056252637907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7981769662079, 387.7053439386067, 388.2371140708509, 393.35293442287457, 405.37774516117764, 16035.759463608056, 17030.23363948622, 17738.379156729487, 17830.82169178308, 17848.64302713945, 14674.486392976249, 15206.847931520682, 15700.136492492937, 15718.842811571882, 15749.133797641125, 4776.641751868615, 4981.626378021663, 5011.3485246918035, 5018.849434516952, 5019.222020586797, 3627.6009638939695, 3790.1851102013197, 5462.8361149165585, 5766.711664416784, 5766.7404966776385, 5635.5773317001185, 5695.686737229451, 5713.228714123603, 5728.083506638938, 5735.541156707453, 5584.21820945068, 5749.856253593652, 5758.683272420015, 5761.107028410582, 5762.942370576283, 3476.6523347665284, 3677.3196958562485, 3677.724170687209, 3710.0168455359353, 5177.404598471187, 12423.130380873343, 12815.231086134861, 12902.548410805577, 12922.28927408992, 12956.611301660965, 1853.156813649786, 2037.7554693436734, 2083.2500299892026, 2220.0, 2289.1873384948435, 9292.860607090899, 9506.954235034209, 9933.90066099337, 12231.0, 12765.978721702242, 1660.8007039155257, 1686.072660036987, 1719.2864961041153, 1726.7064599018197, 1775.1035726957932, 70592.647036765, 71227.28772712259, 72527.0, 72640.0, 72840.0, 9900.752481187883, 9933.3543319684, 10559.683209503728, 10624.840627390595, 10687.893121068846, 14682.926585367219, 14876.107433554022, 14881.776773348409, 14904.403823846924, 14916.477923272634, 6915.308469153045, 7086.114235720535, 7280.490365674458, 7299.05112335393, 7303.342699157101, 6405.19935008124, 6438.6136831790245, 6478.1578394808375, 6577.901331480031, 6578.671066446658, 4530.343100250445, 4570.7486088264795, 4578.702384345007, 4587.72473651582, 4658.883527911829, 1674.4390629139132, 1795.9281628734705, 1895.734597156399, 1906.5424298168616, 1908.2557802457052, 828.5484410996022, 883.2908322396183, 904.8868891388577, 1000.1798525209258, 1011.9797604047877, 16555.6688866222, 16680.416185433693, 16921.407750728664, 17223.56941076458, 17345.13274336278, 866.1598249697784, 868.7133246028795, 879.4415546128255, 901.832127395025, 935.9766005849908, 7555.697772089165, 9673.613055477703, 9684.56419461126, 9723.367981081206, 9816.312858100007, 366515.0, 367949.0, 374728.0, 376330.0, 388381.0, 75692.62153689197, 78733.60633196797, 79749.60125199454, 80249.0, 80899.0, 917.2982668258787, 918.6600957645713, 921.6820197032014, 924.6440120553501, 925.9861102083474, 15273.6181595461, 15324.157171355682, 15425.922870385577, 15483.0, 15880.285387157375, 33974.15064623404, 34711.82644086763, 34767.82616086904, 34791.65208347884, 35645.465318019735, 48278.5172148274, 49937.500624993285, 50856.491435085176, 51175.48824511707, 51214.0, 7750.147483776893, 7992.720254791287, 8087.069986951576, 8103.8379232413845, 8144.5520496373265, 11587.246828956091, 11823.290602563873, 11829.704257393634, 11961.162718609614, 12326.260424374566, 10532.89467105319, 10579.576816927236, 10611.681649550526, 10631.149508039493, 10735.677929662123, 10331.22515811302, 10342.741431464274, 10370.792584148125, 10488.213383996079, 10526.947365263124, 10450.843237351597, 10548.63240036636, 10611.628592999208, 10673.946630266799, 11075.169362298022, 6866.828329291808, 7087.0, 7419.851602967802, 7995.560244186626, 8090.757277281691, 9796.9020309796, 9900.801983960424, 9972.900270997487, 9990.0, 10001.499925003574], "value": 8123.6780885682665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.3293004102882, 1484.2282013353054, 1512.5613572064099, 1677.2452396421613, 1829.3962992212562, 6848.417884479819, 7718.614069296534, 7946.523208607473, 7982.0, 8172.0, 7868.2918537331625, 8028.839423211532, 8031.799205019863, 8032.196780321965, 8033.357331413487, 1969.5470041890374, 2026.9797302026939, 2027.1182035814395, 2253.346529506445, 2284.0635339510804, 2028.4523178741804, 2213.015208232337, 2292.5300313435787, 2293.0713061210154, 2327.3134425344565, 2293.0713061210236, 2295.540891821642, 2300.9654855177187, 2304.435413323738, 2305.1125316753005, 1910.703840904662, 2253.2451628704403, 2254.447660323215, 2263.321003698884, 2264.728232612089, 2193.3529608765452, 2275.24916777463, 2277.077783497686, 2281.6691579720846, 2289.0614847912443, 7998.920010799876, 8039.959800200962, 8041.758747237593, 8052.919470805334, 8055.63749631268, 4553.408056952608, 4688.038952014863, 4690.366800481926, 4696.2486002239475, 4698.060387922429, 2969.094426200008, 3045.345250771095, 3094.675059118805, 3107.5494053362363, 3128.4525208088494, 867.3841572483544, 924.0528458330198, 924.8057907839362, 940.3464592108487, 990.1929927109383, 10944.945275273652, 10953.123750099972, 10960.12319014477, 10962.232643714942, 10973.725656858562, 4321.611055005002, 4468.285074388147, 4470.821167153343, 4475.3217543421215, 4478.731276123443, 9435.575399107056, 9493.050694930589, 9505.90494095064, 9514.666986655573, 9522.714318570454, 4714.669973101919, 4716.033213191287, 4717.599004084623, 4718.127146477913, 4718.669693121448, 4141.420201171838, 4164.37534369847, 4271.380649805761, 4317.546657600907, 4323.740575565476, 3683.4843121962945, 3775.452559378875, 3816.1413681921345, 3850.5764365919727, 3890.7665540067687, 1212.5513559982687, 1221.5541327415428, 1229.0843321725372, 1232.3591732299153, 1240.528599132324, 835.8996920369594, 855.4482358878488, 876.8071024374627, 900.7522931193843, 913.1051569461832, 5331.120365139708, 5351.25082488452, 5513.062779327443, 5686.744096515667, 5740.0, 853.0871966995379, 887.4675194883018, 924.778053267211, 949.924006079512, 954.5418199264392, 3587.3901436755814, 3727.366347720894, 3732.0, 3737.3085979093953, 3748.5126933498473, 9625.855612165824, 9652.517374131265, 10063.094321511098, 10066.848997265048, 10072.194224462026, 9791.265655075898, 9843.360181588174, 9870.950645246729, 9871.901280987242, 9879.407235565888, 7501.324880760758, 7548.773536793905, 7667.309942105126, 7739.845203096019, 7744.0, 5325.334333208349, 5332.253484512094, 5347.0, 5433.5381492572, 5486.725663716878, 9033.683821066494, 9178.852643419572, 9251.491167985825, 9273.119053689888, 9277.16505514507, 8075.9192408077515, 8745.91254087451, 8763.824723505366, 9134.862977055216, 9260.212881905114, 6567.310432404529, 6765.695543700447, 6913.41235994926, 6921.169459664872, 6925.792226233221, 7375.557466552024, 7624.0, 7643.961780191064, 7701.3068823806125, 7775.455718099679, 6814.93185068143, 6935.549189302679, 6949.583025018515, 6963.199232088375, 7018.227994920657, 6914.0, 6988.475864310095, 7005.684744186626, 7022.613756243456, 7160.785176444715, 6607.438367738796, 6615.66921653925, 6652.90020649681, 6654.900176497454, 6658.034584985053, 4599.563041511051, 4669.509701481295, 4772.284157376283, 4779.665423420327, 4838.830640927551, 4537.546245375436, 4644.801974065652, 4668.08573832984, 4744.9051018978735, 4746.762661866962], "value": 4264.843122192248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.9984850075751, 315.147525942326, 322.68054625920314, 324.2509802356557, 324.7061409424471, 4875.488073752258, 4883.19427294496, 4941.652714960392, 4958.900821983558, 4980.605430479467, 4604.263317869141, 4697.953020469794, 4733.313669517918, 4797.712137271767, 4834.419869615642, 3839.0978120141745, 3874.651281384675, 3881.864134755277, 3887.358585833334, 3888.7666739995548, 3874.3994680824517, 3882.4758657581147, 3887.8142166639163, 3890.610938906115, 3915.490986171808, 3671.1372827385676, 3710.202306504101, 3879.922401551967, 3885.941710874339, 3895.8831235062853, 3852.438128644448, 3855.20968201518, 3858.2090671412575, 3873.6707379872746, 3882.2041481496226, 3422.828858557062, 3450.102973226979, 3456.4988076728987, 3473.201163732356, 3481.147118955872, 4425.8714027923, 4674.649401294916, 4681.836135735233, 4687.929681054787, 4707.29390591414, 4313.503947046067, 4346.282863327548, 4350.282203436429, 4355.453813896084, 4359.629431498295, 5081.441041485434, 5085.694858308476, 5100.974495127538, 5107.4892510749, 5109.6167787415725, 3548.3435564420665, 3587.5694916609914, 3592.173800026009, 3608.2963822054708, 3615.2227271136567, 5115.693058416507, 5273.367195936474, 5307.893842123174, 5344.518993290622, 5346.545543628797, 3664.2488289900507, 3665.157013886821, 3669.412893936957, 3686.5023221864703, 3689.7639290837333, 3721.292954338667, 3769.266137576745, 3792.051987003249, 3794.0, 3798.2023775007005, 4084.4281800547947, 4304.978475107604, 4314.762688052125, 4352.281873490839, 4368.191884501377, 5060.608332708534, 5072.898542029138, 5107.668001579886, 5111.8722031948755, 5123.2827404163445, 1242.142921384242, 1283.4160456992047, 1287.3949243855373, 1301.1217428235902, 1322.358656051814, 812.1147948735907, 829.8547754143001, 881.6693739847557, 908.7228395339353, 909.3861643390817, 4497.9325310120375, 4511.864644060618, 4528.728276303366, 4547.636189104864, 4559.293309537027, 5219.0, 5240.449752775904, 5249.606279529051, 5255.923910055507, 5260.395054568697, 4399.934000989988, 4643.930341044887, 4645.744484053342, 4651.116287905287, 4666.2767271073035, 2815.4087641595493, 2860.2134413036583, 2867.799254052238, 2873.267316834194, 2876.4822331980026, 4845.407706876804, 5120.820771273062, 5121.28302037715, 5136.357955255593, 5139.357580302462, 5479.53423958968, 5489.972550137303, 5503.642777905475, 5504.9449505504435, 5506.504414602705, 5083.415407228142, 5107.310513080686, 5113.616478764033, 5116.462771408948, 5128.512791284822, 5202.8959420812125, 5217.973910130425, 5294.802656897498, 5352.732363381893, 5367.624266301477, 5191.0, 5199.948000519947, 5202.635815492879, 5221.190715439113, 5222.268882356397, 5030.270610761492, 5050.949490505195, 5051.949480505295, 5066.771995260148, 5085.949140508547, 3651.7036452060197, 3700.7039436844448, 3711.1278849469813, 3733.757305775116, 3756.8309426075343, 5180.844574662766, 5250.448702886295, 5267.578593712417, 5269.657472264291, 5286.76209570578, 5116.820911268088, 5154.716490593053, 5155.350287907833, 5164.277001219757, 5168.3797944246935, 4931.580815630711, 5107.624954396224, 5134.7946082156295, 5149.407818100966, 5152.76812543429, 4820.831270905502, 4902.338184345068, 4986.855652069645, 5039.319691841554, 5057.949420505895, 5170.612204084633, 5191.76637051326, 5194.402643696023, 5217.217417387422, 5250.159974404077, 5058.038972595195, 5070.290159377616, 5072.67027643202, 5075.87310317245, 5094.872628184325], "value": 3878.8946707112264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.3572791480606, 638.0907207229696, 672.0255629337461, 707.2149913595911, 729.8248420379107, 11494.36780977046, 11818.0, 12158.878411215885, 12167.756644867097, 12179.330136842482, 12497.0, 12616.243025418482, 12623.431945562448, 12643.62069137925, 12693.80959285609, 684.3122661724959, 848.245061894914, 864.0840708848609, 880.8722735203391, 885.623609965762, 864.0754392799707, 865.5758678247645, 867.6572753762292, 868.9739307820776, 871.0331531999507, 912.3248795891026, 913.3834661603424, 914.2000749344323, 914.2320450821309, 915.1809130827905, 720.0603212807284, 870.791010157564, 885.5041176940933, 915.6520522201588, 917.4036876030567, 673.4107655801174, 678.5148618737626, 678.5589366911497, 679.0493309366876, 680.0309558878578, 11913.94043029788, 11939.164258501909, 11959.222650527689, 11961.162718609701, 11962.222455540363, 12187.32969686667, 12431.813522797165, 12463.688407789787, 12556.036021740007, 12642.936785316106, 10779.514921828459, 10805.891941080567, 10939.28894621847, 11106.111511079094, 11371.431428428545, 4141.130362623852, 4155.812988415529, 4190.5180904195795, 4358.019445624741, 4364.934525982113, 47046.529534704896, 47058.0, 47102.76448617735, 48486.51513484891, 48511.51488485105, 10007.549660265306, 10046.0, 10151.441670708182, 10275.0, 10289.794204115875, 18267.90866045661, 18287.177077031567, 18345.7248141278, 18385.448436546925, 18386.81613183878, 6186.969065154735, 6334.746610135543, 6369.331220221903, 6369.490440764727, 6537.215534135934, 3758.0980564664283, 3764.5294338207723, 3771.7548359356556, 3788.5264341957254, 3863.130795570974, 2822.8588570571387, 2921.6055832462343, 2926.3708302715017, 2931.3844092740337, 2943.028800495831, 542.8018773147852, 558.8183840251935, 562.3645280832633, 573.037297340472, 575.1459083261353, 495.92561115832194, 544.6459801129298, 545.4164044472456, 572.7766171193238, 581.2037508613226, 7243.311885370881, 7706.009373787171, 7709.460337776414, 7739.7678069658, 7752.379809615217, 542.156945949053, 604.4348534120611, 613.4816080412045, 615.1418770814688, 635.8029011006603, 3484.564429446319, 3579.713622910161, 3580.5703315601772, 3589.9282014359565, 3627.0, 49975.75012124916, 51040.0, 64206.678966604864, 65388.67305663441, 65442.345576544576, 49036.0, 50042.74978625084, 50475.24287135696, 51244.48755512472, 52567.0, 47308.0, 47591.76204119027, 47597.28604070942, 47603.285950710764, 48703.0, 7751.496152750054, 7798.98613180283, 7829.847951130136, 7966.322862556747, 8005.759827205193, 31264.843675782384, 31611.36777264396, 31706.36587268288, 32055.198620034687, 32096.839515802272, 38380.808095960456, 40461.59538404578, 42532.362014570426, 42630.57369426266, 43104.0, 10545.73635659084, 11027.889721102687, 11044.502997364978, 11072.889271107508, 11097.11223102166, 12009.81985270239, 12295.815562766387, 12369.505219791468, 12436.875631243573, 12459.252444853339, 10603.363798172135, 11053.0, 11513.94243028813, 11528.711782205512, 11541.076713862703, 11453.312801231952, 11690.824637630272, 12046.096542759504, 12165.513379465076, 12394.070444716863, 10060.949695251476, 10582.523786429783, 10745.355278683304, 10856.240063195817, 10985.066269366873, 9364.906350936404, 9530.95234523823, 9538.189253913495, 9707.126358627758, 9712.854307185256, 9184.49485278316, 9219.907800921905, 9244.0, 9300.441973481613, 9342.0], "value": 6127.9581649074225, "unit": "score"}], "name": "dromaeo_css", "value": 6427.238840074253, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 155.0, 219.0, 129.0, 152.0, 153.0, 131.0, 195.0, 132.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 76.0, 144.0, 78.0, 75.0, 77.0, 74.0, 124.0, 75.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 92.0, 94.0, 92.0, 119.0, 92.0, 91.0, 121.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 148.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 82.0, 82.0, 81.0, 83.0, 82.0, 83.0, 166.0, 84.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 128.0, 128.0, 126.0, 137.0, 124.0, 129.0, 144.0, 134.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 164.0, 166.0, 166.0, 165.0, 166.0, 165.0, 170.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1562.0000000000002, "alertThreshold": 2.0}]} 05:15:20 INFO - Return code: 0 05:15:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:21 ERROR - # TBPL SUCCESS # 05:15:21 INFO - Running post-action listener: _resource_record_post_action 05:15:21 INFO - ##### 05:15:21 INFO - ##### Finished run-tests step (success) 05:15:21 INFO - ##### 05:15:21 INFO - Running post-run listener: _resource_record_post_run 05:15:21 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 495566848; Read time: 8; Write time: 535168 05:15:21 INFO - TinderboxPrint: CPU usage
13.1% 05:15:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:15:21 INFO - TinderboxPrint: I/O write bytes / time
495,566,848 / 535,168 05:15:21 INFO - TinderboxPrint: CPU idle
8,338.1 (86.9%) 05:15:21 INFO - TinderboxPrint: CPU user
1,211.7 (12.6%) 05:15:21 INFO - TinderboxPrint: Swap in / out
0 / 0 05:15:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 200388608; Read time: 0; Write time: 281980 05:15:21 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292843520; Read time: 8; Write time: 253084 05:15:21 INFO - Running post-run listener: _upload_blobber_files 05:15:21 INFO - Blob upload gear active. 05:15:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:15:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:22 INFO - (blobuploader) - INFO - Done attempting. 05:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:15:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:23 INFO - (blobuploader) - INFO - Done attempting. 05:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:27 INFO - (blobuploader) - INFO - Done attempting. 05:15:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:27 INFO - Return code: 0 05:15:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:15:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/479dd0264764b507854444ce037640c2452b2e5b20716a364846abcf443a5275f3ec7e99cde66293834e3905ce0e2f4475eeb035cb23795b420859d5bf372c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/270117a4594931393877d1a23da319aaaff2960de47be63411a6d80c70f5c8eeee2c42c6182524da8dace2aa599afeae245cedc274bde69e48e36f7e9f80ba22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d595eed71cde8c070892f8569105f659dbbeda114873afc3fc9e834cd6139b0ce4e1e006e637397d217669a4671cb72d3ba56ab0468c5705ab3e710cea90a49"} 05:15:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:15:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:15:27 INFO - Contents: 05:15:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/479dd0264764b507854444ce037640c2452b2e5b20716a364846abcf443a5275f3ec7e99cde66293834e3905ce0e2f4475eeb035cb23795b420859d5bf372c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/270117a4594931393877d1a23da319aaaff2960de47be63411a6d80c70f5c8eeee2c42c6182524da8dace2aa599afeae245cedc274bde69e48e36f7e9f80ba22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d595eed71cde8c070892f8569105f659dbbeda114873afc3fc9e834cd6139b0ce4e1e006e637397d217669a4671cb72d3ba56ab0468c5705ab3e710cea90a49"} 05:15:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:15:27 INFO - Copying logs to upload dir... 05:15:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:15:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.590515 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-18 05:15:27.447011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 05:15:27.453874) ========= 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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 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/479dd0264764b507854444ce037640c2452b2e5b20716a364846abcf443a5275f3ec7e99cde66293834e3905ce0e2f4475eeb035cb23795b420859d5bf372c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/270117a4594931393877d1a23da319aaaff2960de47be63411a6d80c70f5c8eeee2c42c6182524da8dace2aa599afeae245cedc274bde69e48e36f7e9f80ba22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d595eed71cde8c070892f8569105f659dbbeda114873afc3fc9e834cd6139b0ce4e1e006e637397d217669a4671cb72d3ba56ab0468c5705ab3e710cea90a49"} build_url:https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/AxPmuLOWQDeJ5QKPhcDNMQ/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/479dd0264764b507854444ce037640c2452b2e5b20716a364846abcf443a5275f3ec7e99cde66293834e3905ce0e2f4475eeb035cb23795b420859d5bf372c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/270117a4594931393877d1a23da319aaaff2960de47be63411a6d80c70f5c8eeee2c42c6182524da8dace2aa599afeae245cedc274bde69e48e36f7e9f80ba22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d595eed71cde8c070892f8569105f659dbbeda114873afc3fc9e834cd6139b0ce4e1e006e637397d217669a4671cb72d3ba56ab0468c5705ab3e710cea90a49"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 05:15:27.725179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 05:15:27.725867) ========= 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=62c568580acbfdaac3eec7be000001dc-1463572355.736923-791649480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 05:15:27.807604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 05:15:27.807983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 05:15:27.808339) ========= ========= Total master_lag: 0.45 =========