builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1464607893.04 results: success (0) buildid: 20160530032935 builduid: 18982da13ac846d09057dbf62e0f9603 revision: f03b60a446f193327a21e0e2ca9892538b44b2f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.041975) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.042451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.042758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.057511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.057901) ========= 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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 04:31: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-30 04:31:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118426 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.190146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.190465) ========= 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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:33.240397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 04:31:33.240791) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f03b60a446f193327a21e0e2ca9892538b44b2f9 --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 f03b60a446f193327a21e0e2ca9892538b44b2f9 --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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 04:31:33,429 truncating revision to first 12 chars 2016-05-30 04:31:33,429 Setting DEBUG logging. 2016-05-30 04:31:33,429 attempt 1/10 2016-05-30 04:31:33,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f03b60a446f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 04:31:34,332 unpacking tar archive at: fx-team-f03b60a446f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 04:31:34.500780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:34.501147) ========= script_repo_revision: f03b60a446f193327a21e0e2ca9892538b44b2f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:34.501599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:34.501875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 04:31:34.513189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-05-30 04:31:34.513585) ========= /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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:34 INFO - MultiFileLogger online at 20160530 04:31:34 in /builds/slave/test 04:31: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:31:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:34 INFO - {'append_to_log': False, 04:31:34 INFO - 'base_work_dir': '/builds/slave/test', 04:31:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:31:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:31:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:34 INFO - 'config_files': ('talos/linux_config.py',), 04:31:34 INFO - 'default_actions': ('clobber', 04:31:34 INFO - 'read-buildbot-config', 04:31:34 INFO - 'download-and-extract', 04:31:34 INFO - 'populate-webroot', 04:31:34 INFO - 'create-virtualenv', 04:31:34 INFO - 'install', 04:31:34 INFO - 'run-tests'), 04:31:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:34 INFO - 'download_minidump_stackwalk': True, 04:31:34 INFO - 'download_symbols': 'ondemand', 04:31:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:34 INFO - 'installer_path': 'installer.exe', 04:31:34 INFO - 'log_level': 'info', 04:31:34 INFO - 'log_name': 'talos', 04:31:34 INFO - 'log_to_console': True, 04:31:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:34 INFO - 'opt_config_files': (), 04:31:34 INFO - 'pip_index': False, 04:31:34 INFO - 'sps_profile': False, 04:31:34 INFO - 'sps_profile_interval': 0, 04:31:34 INFO - 'suite': 'dromaeojs', 04:31:34 INFO - 'system_bits': '32', 04:31:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:34 INFO - 'title': 'talos-linux64-ix-063', 04:31:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:34 INFO - 'use_talos_json': True, 04:31:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:34 INFO - 'work_dir': 'build'} 04:31:34 INFO - ##### 04:31:34 INFO - ##### Running clobber step. 04:31:34 INFO - ##### 04:31:34 INFO - Running pre-action listener: _resource_record_pre_action 04:31:34 INFO - Running main action method: clobber 04:31:34 INFO - rmtree: /builds/slave/test/build 04:31:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:35 INFO - Running post-action listener: _resource_record_post_action 04:31:35 INFO - ##### 04:31:35 INFO - ##### Finished clobber step (success) 04:31:35 INFO - ##### 04:31:35 INFO - ##### 04:31:35 INFO - ##### Running read-buildbot-config step. 04:31:35 INFO - ##### 04:31:35 INFO - Running pre-action listener: _resource_record_pre_action 04:31:35 INFO - Running main action method: read_buildbot_config 04:31:35 INFO - Using buildbot properties: 04:31:35 INFO - { 04:31:35 INFO - "project": "", 04:31:35 INFO - "product": "firefox", 04:31:35 INFO - "script_repo_revision": "production", 04:31:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:31:35 INFO - "repository": "", 04:31:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:31:35 INFO - "buildid": "20160530032935", 04:31:35 INFO - "pgo_build": "False", 04:31:35 INFO - "basedir": "/builds/slave/test", 04:31:35 INFO - "buildnumber": 1803, 04:31:35 INFO - "slavename": "talos-linux64-ix-063", 04:31:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:31:35 INFO - "platform": "ubuntu64_hw", 04:31:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:31:35 INFO - "branch": "fx-team", 04:31:35 INFO - "repo_path": "integration/fx-team", 04:31:35 INFO - "revision": "f03b60a446f193327a21e0e2ca9892538b44b2f9", 04:31:35 INFO - "stage_platform": "linux64", 04:31:35 INFO - "builduid": "18982da13ac846d09057dbf62e0f9603", 04:31:35 INFO - "slavebuilddir": "test" 04:31:35 INFO - } 04:31:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:31:35 INFO - Running post-action listener: _resource_record_post_action 04:31:35 INFO - ##### 04:31:35 INFO - ##### Finished read-buildbot-config step (success) 04:31:35 INFO - ##### 04:31:35 INFO - ##### 04:31:35 INFO - ##### Running download-and-extract step. 04:31:35 INFO - ##### 04:31:35 INFO - Running pre-action listener: _resource_record_pre_action 04:31:35 INFO - Running main action method: download_and_extract 04:31:35 INFO - mkdir: /builds/slave/test/build/tests 04:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:35 INFO - https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:35 INFO - Downloaded 1361 bytes. 04:31:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:31:35 INFO - Using the following test package requirements: 04:31:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'jsshell-linux-x86_64.zip'], 04:31:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:35 INFO - https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:37 INFO - Downloaded 22837897 bytes. 04:31:37 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:31:37 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:31:38 INFO - Return code: 0 04:31:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:38 INFO - https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:39 INFO - Downloaded 22837897 bytes. 04:31:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:42 INFO - Return code: 0 04:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:42 INFO - https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:48 INFO - Downloaded 10834034 bytes. 04:31:48 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:31:48 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:31:48 INFO - Return code: 0 04:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:48 INFO - https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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:31:50 INFO - Downloaded 54851309 bytes. 04:31:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:50 INFO - mkdir: /builds/slave/test/properties 04:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:50 INFO - Contents: 04:31:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:31:51 INFO - Running post-action listener: _resource_record_post_action 04:31:51 INFO - Running post-action listener: set_extra_try_arguments 04:31:51 INFO - ##### 04:31:51 INFO - ##### Finished download-and-extract step (success) 04:31:51 INFO - ##### 04:31:51 INFO - ##### 04:31:51 INFO - ##### Running populate-webroot step. 04:31:51 INFO - ##### 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: populate_webroot 04:31:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:51 INFO - '--tppagecycles', 04:31:51 INFO - '7'], 04:31:51 INFO - 'tests': ['tsvgm']}}, 04:31:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['damp', 'tps']}, 04:31:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'tests': ['damp', 'tps']}, 04:31:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['dromaeo_dom']}, 04:31:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['a11yr', 04:31:51 INFO - 'ts_paint', 04:31:51 INFO - 'tpaint', 04:31:51 INFO - 'sessionrestore', 04:31:51 INFO - 'sessionrestore_no_auto_restore', 04:31:51 INFO - 'tabpaint']}, 04:31:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['tsvgx', 04:31:51 INFO - 'tsvgr_opacity', 04:31:51 INFO - 'tart', 04:31:51 INFO - 'tscrollx', 04:31:51 INFO - 'cart']}, 04:31:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:51 INFO - 'tsvgr_opacity', 04:31:51 INFO - 'tart', 04:31:51 INFO - 'tscrollx', 04:31:51 INFO - 'cart']}, 04:31:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'talos_options': ['--disable-e10s'], 04:31:51 INFO - 'tests': ['tp5o']}, 04:31:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'tests': ['tp5o']}, 04:31:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'talos_options': ['--disable-e10s', 04:31:51 INFO - '--xperf_path', 04:31:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:51 INFO - 'tests': ['tp5n']}, 04:31:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:51 INFO - 'talos_options': ['--xperf_path', 04:31:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:51 INFO - 'tests': ['tp5n']}}, 04:31:51 INFO - 'talos.zip': {'path': '', 04:31:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:51 INFO - Running post-action listener: _resource_record_post_action 04:31:51 INFO - ##### 04:31:51 INFO - ##### Finished populate-webroot step (success) 04:31:51 INFO - ##### 04:31:51 INFO - ##### 04:31:51 INFO - ##### Running create-virtualenv step. 04:31:51 INFO - ##### 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: create_virtualenv 04:31:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:51 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:31:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:51 INFO - Using real prefix '/usr' 04:31:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:54 INFO - Installing pip.................done. 04:31:54 INFO - Return code: 0 04:31:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:54 INFO - Using env: {'DISPLAY': ':0', 04:31:54 INFO - 'HOME': '/home/cltbld', 04:31:54 INFO - 'LANG': 'en_US.UTF-8', 04:31:54 INFO - 'LANGUAGE': 'en_US:en', 04:31:54 INFO - 'LOGNAME': 'cltbld', 04:31:54 INFO - 'MAIL': '/var/mail/cltbld', 04:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:54 INFO - 'MOZ_NO_REMOTE': '1', 04:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:54 INFO - 'NO_EM_RESTART': '1', 04:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:54 INFO - 'PWD': '/builds/slave/test', 04:31:54 INFO - 'SHELL': '/bin/bash', 04:31:54 INFO - 'SHLVL': '1', 04:31:54 INFO - 'TERM': 'linux', 04:31:54 INFO - 'TMOUT': '86400', 04:31:54 INFO - 'USER': 'cltbld', 04:31:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:54 INFO - '_': '/tools/buildbot/bin/python'} 04:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:54 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:31:54 INFO - Cleaning up... 04:31:54 INFO - Return code: 0 04:31:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:54 INFO - Using env: {'DISPLAY': ':0', 04:31:54 INFO - 'HOME': '/home/cltbld', 04:31:54 INFO - 'LANG': 'en_US.UTF-8', 04:31:54 INFO - 'LANGUAGE': 'en_US:en', 04:31:54 INFO - 'LOGNAME': 'cltbld', 04:31:54 INFO - 'MAIL': '/var/mail/cltbld', 04:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:54 INFO - 'MOZ_NO_REMOTE': '1', 04:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:54 INFO - 'NO_EM_RESTART': '1', 04:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:54 INFO - 'PWD': '/builds/slave/test', 04:31:54 INFO - 'SHELL': '/bin/bash', 04:31:54 INFO - 'SHLVL': '1', 04:31:54 INFO - 'TERM': 'linux', 04:31:54 INFO - 'TMOUT': '86400', 04:31:54 INFO - 'USER': 'cltbld', 04:31:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:54 INFO - '_': '/tools/buildbot/bin/python'} 04:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:54 INFO - Downloading/unpacking psutil>=3.1.1 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:56 INFO - Installing collected packages: psutil 04:31:56 INFO - Running setup.py install for psutil 04:31:56 INFO - building 'psutil._psutil_linux' extension 04:31:56 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:31:57 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:31:57 INFO - building 'psutil._psutil_posix' extension 04:31:57 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:31:57 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:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:57 INFO - Successfully installed psutil 04:31:57 INFO - Cleaning up... 04:31:57 INFO - Return code: 0 04:31:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:57 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:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:31:57 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:31:57 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:31:57 INFO - Using env: {'DISPLAY': ':0', 04:31:57 INFO - 'HOME': '/home/cltbld', 04:31:57 INFO - 'LANG': 'en_US.UTF-8', 04:31:57 INFO - 'LANGUAGE': 'en_US:en', 04:31:57 INFO - 'LOGNAME': 'cltbld', 04:31:57 INFO - 'MAIL': '/var/mail/cltbld', 04:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:57 INFO - 'MOZ_NO_REMOTE': '1', 04:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:57 INFO - 'NO_EM_RESTART': '1', 04:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:57 INFO - 'PWD': '/builds/slave/test', 04:31:57 INFO - 'SHELL': '/bin/bash', 04:31:57 INFO - 'SHLVL': '1', 04:31:57 INFO - 'TERM': 'linux', 04:31:57 INFO - 'TMOUT': '86400', 04:31:57 INFO - 'USER': 'cltbld', 04:31:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:57 INFO - '_': '/tools/buildbot/bin/python'} 04:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:59 INFO - Installing collected packages: mozsystemmonitor 04:31:59 INFO - Running setup.py install for mozsystemmonitor 04:31:59 INFO - Successfully installed mozsystemmonitor 04:31:59 INFO - Cleaning up... 04:31:59 INFO - Return code: 0 04:31:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31: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:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', '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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31: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 blobuploader==1.2.4 04:31:59 INFO - Using env: {'DISPLAY': ':0', 04:31:59 INFO - 'HOME': '/home/cltbld', 04:31:59 INFO - 'LANG': 'en_US.UTF-8', 04:31:59 INFO - 'LANGUAGE': 'en_US:en', 04:31:59 INFO - 'LOGNAME': 'cltbld', 04:31:59 INFO - 'MAIL': '/var/mail/cltbld', 04:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:59 INFO - 'MOZ_NO_REMOTE': '1', 04:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:59 INFO - 'NO_EM_RESTART': '1', 04:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:59 INFO - 'PWD': '/builds/slave/test', 04:31:59 INFO - 'SHELL': '/bin/bash', 04:31:59 INFO - 'SHLVL': '1', 04:31:59 INFO - 'TERM': 'linux', 04:31:59 INFO - 'TMOUT': '86400', 04:31:59 INFO - 'USER': 'cltbld', 04:31:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:59 INFO - '_': '/tools/buildbot/bin/python'} 04:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:31: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:31: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:31: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:31: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:31: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:31: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:32:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32: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:32: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:32: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:32: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:32: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:32: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:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:02 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:32:02 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:32:02 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:32:02 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:32:02 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:32:02 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:32:02 INFO - Downloading docopt-0.6.1.tar.gz 04:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:02 INFO - Running setup.py install for blobuploader 04:32:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:02 INFO - Running setup.py install for requests 04:32:02 INFO - Running setup.py install for docopt 04:32:03 INFO - Successfully installed blobuploader requests docopt 04:32:03 INFO - Cleaning up... 04:32:03 INFO - Return code: 0 04:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:03 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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:32:03 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:32:03 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:32:03 INFO - Using env: {'DISPLAY': ':0', 04:32:03 INFO - 'HOME': '/home/cltbld', 04:32:03 INFO - 'LANG': 'en_US.UTF-8', 04:32:03 INFO - 'LANGUAGE': 'en_US:en', 04:32:03 INFO - 'LOGNAME': 'cltbld', 04:32:03 INFO - 'MAIL': '/var/mail/cltbld', 04:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:03 INFO - 'MOZ_NO_REMOTE': '1', 04:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:03 INFO - 'NO_EM_RESTART': '1', 04:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:03 INFO - 'PWD': '/builds/slave/test', 04:32:03 INFO - 'SHELL': '/bin/bash', 04:32:03 INFO - 'SHLVL': '1', 04:32:03 INFO - 'TERM': 'linux', 04:32:03 INFO - 'TMOUT': '86400', 04:32:03 INFO - 'USER': 'cltbld', 04:32:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:03 INFO - '_': '/tools/buildbot/bin/python'} 04:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:03 INFO - Running setup.py (path:/tmp/pip-5Nrrr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:03 INFO - Running setup.py (path:/tmp/pip-wZPygv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:03 INFO - Running setup.py (path:/tmp/pip-RPR7Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:03 INFO - Running setup.py (path:/tmp/pip-LvDSK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:03 INFO - Running setup.py (path:/tmp/pip-kl8Vm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:03 INFO - Running setup.py (path:/tmp/pip-ehwCrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:03 INFO - Running setup.py (path:/tmp/pip-hOA0Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:03 INFO - Running setup.py (path:/tmp/pip-6NAcAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:03 INFO - Running setup.py (path:/tmp/pip-jZCZUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:03 INFO - Running setup.py (path:/tmp/pip-EbTXf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:04 INFO - Running setup.py (path:/tmp/pip-lr5vhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:04 INFO - Running setup.py (path:/tmp/pip-Owhq6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:04 INFO - Running setup.py (path:/tmp/pip-J8hlJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:04 INFO - Running setup.py (path:/tmp/pip-WgGUV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:04 INFO - Running setup.py (path:/tmp/pip-htfr7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:04 INFO - Running setup.py (path:/tmp/pip-s5jndg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:04 INFO - Running setup.py (path:/tmp/pip-CbAzoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:04 INFO - Running setup.py install for manifestparser 04:32:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:04 INFO - Running setup.py install for mozcrash 04:32:04 INFO - Running setup.py install for mozdebug 04:32:04 INFO - Running setup.py install for mozdevice 04:32:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:04 INFO - Running setup.py install for mozfile 04:32:05 INFO - Running setup.py install for mozhttpd 04:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozinfo 04:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozInstall 04:32:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozleak 04:32:05 INFO - Running setup.py install for mozlog 04:32:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for moznetwork 04:32:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozprocess 04:32:05 INFO - Running setup.py install for mozprofile 04:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozrunner 04:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:05 INFO - Running setup.py install for mozscreenshot 04:32:06 INFO - Running setup.py install for moztest 04:32:06 INFO - Running setup.py install for mozversion 04:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:06 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:06 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:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:32:06 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:32:06 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:32:06 INFO - Using env: {'DISPLAY': ':0', 04:32:06 INFO - 'HOME': '/home/cltbld', 04:32:06 INFO - 'LANG': 'en_US.UTF-8', 04:32:06 INFO - 'LANGUAGE': 'en_US:en', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MAIL': '/var/mail/cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SHLVL': '1', 04:32:06 INFO - 'TERM': 'linux', 04:32:06 INFO - 'TMOUT': '86400', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - '_': '/tools/buildbot/bin/python'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:06 INFO - Running setup.py (path:/tmp/pip-ZVlKvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:06 INFO - Running setup.py (path:/tmp/pip-lDzXIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:06 INFO - Running setup.py (path:/tmp/pip-mnEB_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:06 INFO - Running setup.py (path:/tmp/pip-ff4vNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:06 INFO - Running setup.py (path:/tmp/pip-WyeRQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:06 INFO - Running setup.py (path:/tmp/pip-6vkmhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:06 INFO - Running setup.py (path:/tmp/pip-0vXcqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:06 INFO - Running setup.py (path:/tmp/pip-9w3nWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:07 INFO - Running setup.py (path:/tmp/pip-uz7fX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:07 INFO - Running setup.py (path:/tmp/pip-xJlCxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:07 INFO - Running setup.py (path:/tmp/pip-G1gMUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:07 INFO - Running setup.py (path:/tmp/pip-aPLsDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:07 INFO - Running setup.py (path:/tmp/pip-WJ62ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:07 INFO - Running setup.py (path:/tmp/pip-DQFhuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:07 INFO - Running setup.py (path:/tmp/pip-od5JTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:07 INFO - Running setup.py (path:/tmp/pip-qcNuEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:07 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:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:07 INFO - Running setup.py (path:/tmp/pip-RYbrwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:07 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:32:07 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:32:07 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:32:07 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:32:07 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:32:07 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:32:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:09 INFO - Downloading blessings-1.6.tar.gz 04:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:09 INFO - Installing collected packages: blessings 04:32:09 INFO - Running setup.py install for blessings 04:32:09 INFO - Successfully installed blessings 04:32:09 INFO - Cleaning up... 04:32:09 INFO - Return code: 0 04:32:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:10 INFO - Reading from file tmpfile_stdout 04:32:10 INFO - Current package versions: 04:32:10 INFO - argparse == 1.2.1 04:32:10 INFO - blessings == 1.6 04:32:10 INFO - blobuploader == 1.2.4 04:32:10 INFO - docopt == 0.6.1 04:32:10 INFO - manifestparser == 1.1 04:32:10 INFO - mozInstall == 1.12 04:32:10 INFO - mozcrash == 0.17 04:32:10 INFO - mozdebug == 0.1 04:32:10 INFO - mozdevice == 0.48 04:32:10 INFO - mozfile == 1.2 04:32:10 INFO - mozhttpd == 0.7 04:32:10 INFO - mozinfo == 0.9 04:32:10 INFO - mozleak == 0.1 04:32:10 INFO - mozlog == 3.2 04:32:10 INFO - moznetwork == 0.27 04:32:10 INFO - mozprocess == 0.22 04:32:10 INFO - mozprofile == 0.28 04:32:10 INFO - mozrunner == 6.11 04:32:10 INFO - mozscreenshot == 0.1 04:32:10 INFO - mozsystemmonitor == 0.3 04:32:10 INFO - moztest == 0.7 04:32:10 INFO - mozversion == 1.4 04:32:10 INFO - psutil == 3.1.1 04:32:10 INFO - requests == 1.2.3 04:32:10 INFO - wsgiref == 0.1.2 04:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:10 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:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:32:10 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:32:10 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:32:10 INFO - Using env: {'DISPLAY': ':0', 04:32:10 INFO - 'HOME': '/home/cltbld', 04:32:10 INFO - 'LANG': 'en_US.UTF-8', 04:32:10 INFO - 'LANGUAGE': 'en_US:en', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MAIL': '/var/mail/cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SHLVL': '1', 04:32:10 INFO - 'TERM': 'linux', 04:32:10 INFO - 'TMOUT': '86400', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - '_': '/tools/buildbot/bin/python'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 INFO - Cleaning up... 04:32:10 INFO - Return code: 0 04:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:10 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:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:32:10 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:32:10 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:32:10 INFO - Using env: {'DISPLAY': ':0', 04:32:10 INFO - 'HOME': '/home/cltbld', 04:32:10 INFO - 'LANG': 'en_US.UTF-8', 04:32:10 INFO - 'LANGUAGE': 'en_US:en', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MAIL': '/var/mail/cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SHLVL': '1', 04:32:10 INFO - 'TERM': 'linux', 04:32:10 INFO - 'TMOUT': '86400', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - '_': '/tools/buildbot/bin/python'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 INFO - Downloading/unpacking jsonschema 04:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:10 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:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:12 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32: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:32: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:32: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:32: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:32: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:32: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:32:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:12 INFO - warning: no files found matching '*.txt' 04:32:12 INFO - no previously-included directories found matching 'build' 04:32:12 INFO - no previously-included directories found matching 'dist' 04:32:12 INFO - no previously-included directories found matching '.git*' 04:32:12 INFO - Installing collected packages: jsonschema, functools32 04:32:12 INFO - Running setup.py install for functools32 04:32:12 INFO - warning: no files found matching '*.txt' 04:32:12 INFO - no previously-included directories found matching 'build' 04:32:12 INFO - no previously-included directories found matching 'dist' 04:32:12 INFO - no previously-included directories found matching '.git*' 04:32:12 INFO - Successfully installed jsonschema functools32 04:32:12 INFO - Cleaning up... 04:32:12 INFO - Return code: 0 04:32:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32: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:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16d8bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, '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': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', '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:32: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', 'flake8'] in /builds/slave/test/build 04:32: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 flake8 04:32:12 INFO - Using env: {'DISPLAY': ':0', 04:32:12 INFO - 'HOME': '/home/cltbld', 04:32:12 INFO - 'LANG': 'en_US.UTF-8', 04:32:12 INFO - 'LANGUAGE': 'en_US:en', 04:32:12 INFO - 'LOGNAME': 'cltbld', 04:32:12 INFO - 'MAIL': '/var/mail/cltbld', 04:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:12 INFO - 'MOZ_NO_REMOTE': '1', 04:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:12 INFO - 'NO_EM_RESTART': '1', 04:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:12 INFO - 'PWD': '/builds/slave/test', 04:32:12 INFO - 'SHELL': '/bin/bash', 04:32:12 INFO - 'SHLVL': '1', 04:32:12 INFO - 'TERM': 'linux', 04:32:12 INFO - 'TMOUT': '86400', 04:32:12 INFO - 'USER': 'cltbld', 04:32:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:12 INFO - '_': '/tools/buildbot/bin/python'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Downloading/unpacking flake8 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32: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:32: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:32: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:32: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:32: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:32: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:32:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:15 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:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:15 INFO - no previously-included directories found matching 'docs/_build' 04:32:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:16 INFO - Running setup.py install for pep8 04:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:17 INFO - no previously-included directories found matching 'docs/_build' 04:32:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:17 INFO - Cleaning up... 04:32:25 INFO - Return code: 0 04:32:25 INFO - Running post-action listener: _resource_record_post_action 04:32:25 INFO - Running post-action listener: _start_resource_monitoring 04:32:34 INFO - Starting resource monitoring. 04:32:34 INFO - ##### 04:32:34 INFO - ##### Finished create-virtualenv step (success) 04:32:34 INFO - ##### 04:32:34 INFO - ##### 04:32:34 INFO - ##### Running install step. 04:32:34 INFO - ##### 04:32:34 INFO - Running pre-action listener: _resource_record_pre_action 04:32:34 INFO - Running main action method: install 04:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:34 INFO - Reading from file tmpfile_stdout 04:32:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:34 INFO - Reading from file tmpfile_stdout 04:32:34 INFO - Output received: 04:32:34 INFO - Usage: mozinstall [options] installer 04:32:34 INFO - Options: 04:32:34 INFO - -h, --help show this help message and exit 04:32:34 INFO - -d DEST, --destination=DEST 04:32:34 INFO - Directory to install application into. [default: 04:32:34 INFO - "/builds/slave/test"] 04:32:34 INFO - --app=APP Application being installed. [default: firefox] 04:32:34 INFO - mkdir: /builds/slave/test/build/application 04:32:34 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:32:34 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:32:50 INFO - Reading from file tmpfile_stdout 04:32:50 INFO - Output received: 04:32:50 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:50 INFO - Running post-action listener: _resource_record_post_action 04:32:50 INFO - ##### 04:32:50 INFO - ##### Finished install step (success) 04:32:50 INFO - ##### 04:32:50 INFO - ##### 04:32:50 INFO - ##### Running run-tests step. 04:32:50 INFO - ##### 04:32:50 INFO - Running pre-action listener: _resource_record_pre_action 04:32:50 INFO - Running main action method: run_tests 04:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:50 INFO - Python 2.7.3 04:32:50 INFO - Return code: 0 04:32:50 INFO - grabbing minidump binary from tooltool 04:32: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:32:50 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 0x25889c0>, '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 0x25898c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:50 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:32:50 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:32:50 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:32:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:50 INFO - Return code: 0 04:32:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:51 INFO - Return code: 0 04:32:51 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/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:32:51 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/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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:32:51 INFO - Using env: {'DISPLAY': ':0', 04:32:51 INFO - 'HOME': '/home/cltbld', 04:32:51 INFO - 'LANG': 'en_US.UTF-8', 04:32:51 INFO - 'LANGUAGE': 'en_US:en', 04:32:51 INFO - 'LOGNAME': 'cltbld', 04:32:51 INFO - 'MAIL': '/var/mail/cltbld', 04:32:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:51 INFO - 'MOZ_NO_REMOTE': '1', 04:32:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:51 INFO - 'NO_EM_RESTART': '1', 04:32:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:51 INFO - 'PWD': '/builds/slave/test', 04:32:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:51 INFO - 'SHELL': '/bin/bash', 04:32:51 INFO - 'SHLVL': '1', 04:32:51 INFO - 'TERM': 'linux', 04:32:51 INFO - 'TMOUT': '86400', 04:32:51 INFO - 'USER': 'cltbld', 04:32:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818', 04:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:51 INFO - '_': '/tools/buildbot/bin/python'} 04:32:51 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/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:32:51 INFO - mozversion application_buildid: 20160530032935 04:32:51 INFO - mozversion application_changeset: f03b60a446f193327a21e0e2ca9892538b44b2f9 04:32:51 INFO - mozversion application_display_name: Nightly 04:32:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:51 INFO - mozversion application_name: Firefox 04:32:51 INFO - mozversion application_remotingname: firefox 04:32:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:32:51 INFO - mozversion application_vendor: Mozilla 04:32:51 INFO - mozversion application_version: 49.0a1 04:32:51 INFO - mozversion platform_buildid: 20160530032935 04:32:51 INFO - mozversion platform_changeset: f03b60a446f193327a21e0e2ca9892538b44b2f9 04:32:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:32:51 INFO - mozversion platform_version: 49.0a1 04:32:51 INFO - using testdate: 1464607971 04:32:51 INFO - actual date: 1464607971 04:32:51 INFO - starting webserver on 'localhost:40682' 04:32:51 INFO - SUITE-START | Running 2 tests 04:32:51 INFO - TEST-START | dromaeo_css 04:32:51 INFO - operating with platform_type : linux_ 04:32:51 INFO - Initialising browser for dromaeo_css test... 04:32:51 INFO - TEST-INFO | started process 13736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjccHDW/profile http://localhost:40682/getInfo.html) 04:32:57 INFO - PROCESS | 13736 | __metrics Screen width/height:1600/1200 04:32:57 INFO - PROCESS | 13736 | colorDepth:24 04:32:57 INFO - PROCESS | 13736 | Browser inner width/height: 1024/697 04:32:57 INFO - PROCESS | 13736 | __metrics 04:32:59 ERROR - PROCESS | 13736 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:33:00 INFO - TEST-INFO | 13736: exit 0 04:33:00 INFO - Browser initialized. 04:33:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:00 INFO - TEST-INFO | started process 13819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjccHDW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:12 INFO - PROCESS | 13819 | RSS: Main: 157286400 04:33:12 INFO - PROCESS | 13819 | 04:34:04 INFO - PROCESS | 13819 | 1464608044253 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:36:16 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40682/tests/dromaeo/cssquery-ext.html) 04:36:17 INFO - PROCESS | 13819 | RSS: Main: 240652288 04:36:17 INFO - PROCESS | 13819 | 04:39:20 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-ext.html (next: http://localhost:40682/tests/dromaeo/cssquery-jquery.html) 04:39:21 INFO - PROCESS | 13819 | RSS: Main: 238551040 04:39:21 INFO - PROCESS | 13819 | 04:42:23 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40682/tests/dromaeo/cssquery-mootools.html) 04:42:23 INFO - PROCESS | 13819 | RSS: Main: 239095808 04:42:23 INFO - PROCESS | 13819 | 04:45:26 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40682/tests/dromaeo/cssquery-prototype.html) 04:45:26 INFO - PROCESS | 13819 | RSS: Main: 241246208 04:45:26 INFO - PROCESS | 13819 | 04:48:29 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40682/tests/dromaeo/cssquery-yui.html) 04:48:30 INFO - PROCESS | 13819 | RSS: Main: 224636928 04:48:30 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | Cycle 1(1): loaded http://localhost:40682/tests/dromaeo/cssquery-yui.html (next: http://localhost:40682/tests/dromaeo/cssquery-dojo.html) 04:51:33 INFO - PROCESS | 13819 | RSS: Main: 318541824 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | __start_tp_report 04:51:33 INFO - PROCESS | 13819 | _x_x_mozilla_page_load 04:51:33 INFO - PROCESS | 13819 | _x_x_mozilla_page_load_details 04:51:33 INFO - PROCESS | 13819 | |i|pagename|runs| 04:51:33 INFO - PROCESS | 13819 | |0;dojo.html;2663.720309367516;2673.5989601559777;2705.012670375313;2715.1990162901943;2728.877200525976;4628.930566041504;4669.206234940059;4672.836450724225;4773.3078703588;4822.734749588772;4750.263709125083;4794.544518270759;4813.735244561548;4849.199882019462;4857.562819346258;4375.190589740901;4432.490263619693;4471.262241730111;4525.796339164729;4613.100445413146;4515.887102822423;4549.795259213343;4562.064776720781;4576.199165146103;4593.931091033637;4302.892427689317;4355.477342718894;4395.890102747425;4403.6256918162;4447.777611119431;4346.1090476452255;4387.078713470175;4391.758453285068;4441.888952776174;4446.399736035626;4420;4424.137293227822;4435.090806384684;4478.037221997253;4478.373027776114;4619.376384188159;4661.137689527414;4748.145333839908;4752.382190315237;4771.260454629503;5167.276581278624;5198.428172900978;5230.163173892197;5234.842954711365;5236.293100431431;5206.140986737221;5209.583233341324;5225.111731005738;5244.39689435716;5264.8683782905355;4702.106599746072;4779.5220477951925;4843.95156048435;4845;4907.9263811042865;5352.143657014937;5400.567954563626;5412.296401467784;5415.783368665288;5417.51242388187;4948.925766113512;5166.844994650167;5170.922436163461;5174.197999310113;5176.068307704574;5137.6660517066275;5177;5180.119379705384;5186.273921650972;5200.76596553156;5144.6655967362;5151.793928242828;5157.7679004444135;5160.354955630546;5214.32213812202;4966.850994470172;5020.648554601216;5102.311187989574;5120.155174396183;5129.538341549279;4309.07354918694;4315.352697095461;4338.544452832407;4368.082702632482;4372.8906777330185;3777.8866634001024;3779.7732136071922;3793.7344385893275;3813.8855834325013;3831.3678243090135;4319;4379.080393117481;4412.36020776992;4436.955630443719;4468.709533880287;5120.359955005624;5145.76844042019;5161.948380516147;5207.427183009866;5212.40057393397;4428;4454.28731402974;4456.799444025027;4464.709793863389;4504.301833215857;4561.29299958507;4653.906921861544;4666.556677115736;4696.365990591226;4717;4939.259111133359;4956.826511072095;4963.10664080469;4995.300657907896;5006.349174607278;5227.947720522746;5242.606804489755;5245.501677340647;5253.973730131325;5284.154535274338;4650.558196971282;4820.517948205152;4827;4839.056384005085;4946.233333833262;5188.896222075462;5213.426523082534;5216.66091704038;5217.139172036572;5252.711100889335;5285.788568457372;5306;5307.601929855354;5314.415414304501;5361.115415956324;4908.067467181224;4997.275395067768;5063.493650635054;5070.6957582545165;5139.820106296262;5063.620228482805;5073.086844368049;5085.262636917701;5085.389753229636;5126.128558145198;4822.324874517501;5005.649604527794;5014.674046186986;5020.3724534433195;5053.065182941167;5047.419546752024;5099.719515426687;5105.948940510547;5106.055379754757;5106.770195341144;4988.176950803222;5011.774470148779;5014.774335155;5018.949810501995;5070.721110338966 04:51:33 INFO - PROCESS | 13819 | |1;ext.html;597.5667640960304;605.6487237402307;607.4259824465879;613.8772245550891;621.3382747374044;27990.720092799067;30501.69498305016;36615.81692091542;36699.63300366996;36829;42397.36403953935;43150.7842460788;43193.03280122779;43196.56803431965;43239.13521729563;7791.571463569501;7956.0850502192125;7965.561894095851;7968.402369822257;7971.96014019929;7489.138749043876;10083.798324033514;10403.427811470367;10408.843867341995;10418.583256669763;10171.135453486462;10276.486175691223;10281.588736450532;10284.58861645537;10290.897091029106;7479.102507699056;9903.554340054714;10123.29136960413;10249.07758301749;10270.845937310947;9717.31978761487;9831.655892043744;9836.950815245878;9844.3601165924;9847.55685994132;38337.616623833965;38691.61308386908;38749;38818;38855.22289554221;3037.271054946797;3221.0819916323735;3221.355728854215;3321.4685650295837;3604.9098772530633;29191.70808291911;29598.40803183946;29909.40181196364;29944.401111977855;30970.53544196839;3535.9116022099397;3543.9291214175573;3561.6082230954576;3656.3601369760186;3680.8159592020293;189050;189113;189128.0543597287;189771;189943;31316.686833131378;52920.47079529233;53239;53295.467045329824;53437.73281133569;32365.676343236268;34084;34292.48561271583;34343.535340405586;34352.141196470286;10899.073578745736;11040.227184097197;11044.447777611247;11072.944635276772;11095.278806877526;7829.882551761728;8383.119772423808;8549.145085491402;8670.609822557873;8776.648934042694;7880.2513761192595;7895.368370530344;7927.484713493604;7972.2824945755165;8020.679172833022;3086.6913308669405;3094.6441159266974;3136.2943337748825;3144.261098641817;3147.0716138739126;808.9433739638287;877.3770622857843;883.8011447424278;971.7764914069803;1016.6035246253966;28020.579691304647;28467;28481;29002.27494312617;29087.41825163485;883.1521739130507;899.8020435504178;943.8442656961524;1002.6089824968268;1014.5434554450379;14768.113913165245;15077.095374277578;15273.234942162124;15329.540113796604;15508.457203997807;365848;369919;371007;372181;372863;49623;49968;50050;50066;50102.49897500978;1070.9089727373262;1157.5196293538088;1193.2780667696093;1215.2344023265287;1219.8170274458903;27944.30139246535;28619.570706439004;28968.42063158683;29362.265943351587;29452.263693407836;41597.79201104096;45494;47075.058498829145;47110.76444617755;50957.235641464664;290236;292663;292820;294058;294380;32277.193070172496;36771.63228367789;37109.81445092757;38335.61664383321;41051.58948410478;40724.38913416242;41361.75914722563;41616.3757543631;41762.1647567053;41827;35985.28029439449;36045.45931811077;36353.636463635026;36539;36964.44553331756;35308.82345588256;35510.46734298936;35814.53683979925;36007.27985440329;36012;31947.36105277835;32161.195970100936;32797.672023280415;35838.46242306315;36108.09729756672;31437.685623143476;32203.2798342616;32283.19292017718;32331.51502727508;32797;24749.876250619353;24901.750982489943;25039.643359363254;25253.621195681713;25748 04:51:33 INFO - PROCESS | 13819 | |2;jquery.html;379.4952712891853;385.22954091816365;387.3956627660849;398.4899328859061;402.2477966203199;12973.675658108552;13564.796528052062;15547.222638868054;17161.2277447515;17184.140792960363;14983.92508037461;15437.536873893772;15569;17950.640987180283;17978.280868765265;4558.8632341029825;5051.823186188493;5064.164412871872;5209.166533354664;5238.449962753894;5146.639735218536;5155.046316431472;5170.353705786777;5196.272521846944;5199.402068762103;4946.233333833262;5148;5153.252778347138;5158.071547121516;5158.819441319554;5196.246544251081;5282.260483532308;5284.550813180885;5306.893862122755;5307.469253074701;5009.699418034929;5161.122609156452;5190.870228244286;5192.039472697563;5265.315508983846;11963.700907477383;11985.760284794342;11994.400279986054;12167.087468439813;12168.330741809197;1748.195829918239;1887.292265400475;1993;2195.868247905131;2330.7436182019965;8956.417832840909;8980;8996.145366190201;9307.76730581741;9448.52757362136;1717;1760.1903124562716;1764.6235935969964;1785.366195000769;1802.9549261268442;64259;64970;65553;65589.3441065588;65989.67005164991;10026.19528484865;10050.547725352377;10058.547365368577;10061.899381006097;10172.338797978107;12011.519539218509;12083.697907552205;13542.526011589547;13544.796828047587;13549.322533873266;6446.580972236789;6470.508854091115;6482.967585162139;6530;6640.734370625121;5972.940270597325;6033.607815491979;6036.8188954331445;6128.142060111588;6145;3850.2492014057552;3875.9418608720894;4080.2451546464;4188.434561334181;4222.9577704223175;1780.2967827707982;1798.0739918941756;1806.9277228910696;1832;1854.9072546372627;825.7729124490693;841.5287439034161;845;853.4921721575653;939.2720641502754;16254.349826006828;16414.753778693328;16432.917835410986;16510.33958641641;16903.154842257838;812.5003123079264;820.0364571628313;835.6532039203662;850.1073872433919;893.6738090596886;8627.266682331947;9350.345475816763;9389.812203755886;9397.436153830655;9470.078983893665;392356;393393;394442;406177;407786;76466.6176669113;78537;78617.60691196508;78931.78312260956;79223.20776792159;972.0376826941277;985.6205360936091;993.2816227925729;1018.8115198688118;1022.9539670714836;11940.880591193976;15499.845001550291;15690.137042462775;15802.051876887424;16026.759598606264;30845.691543084282;34377.48433773445;35118.29763404769;35237.64762352344;36098;47225.527744722116;47253.76373118113;48125;48127.5187248137;48132;7207.9279207207255;7366.77899663011;7525.247475252431;7563.205863384265;7719.652615632198;10929.83605245906;11782.351970641354;11808.291502509877;11817;12028.578999734968;9587;9858.950705246429;10194.337368071348;10321.63874264397;10392.493088502277;9816.361936474106;9847.556859941464;10060.84908726355;10067.899321006696;10116.03897629724;9673.419594824332;9738.902610973799;9893.159081477866;10067.69796906094;10350.5342259597;7210;7249.746258880914;7374.262573742582;7569.8107547309555;7610.847783044197;7177.138743350832;8365.24712775853;9525.952370238105;10003.899961000297;10085.092341689284 04:51:33 INFO - PROCESS | 13819 | |3;mootools.html;1212.2908098762223;1371.047122250036;1420.3750349846066;1502.308937888571;1716.982830171698;6698.430633396161;7458.403327733782;7670.463067585271;7683.57740324282;7858;7611.61941902904;7764.068311802592;7765.223477652232;7766.534007959513;7768.145503994556;1893.4319704088787;2153.9569208615817;2184.3446965910243;2213.269621025066;2244.932652020442;2238.104758096758;2259.6836442898007;2261.298997310839;2262;2263.649134384173;2148.79586439288;2166.068590506082;2243.069126312578;2243.349428665685;2249.0441562336023;1802.6394721055776;2059.814616684498;2072.4197224777085;2132.701421800949;2133.5306232628795;2113.1019316790457;2121.628714974873;2128.6168489671854;2128.9254876079417;2129.3079749081458;7758.379329653614;7801.180876007994;7810.1799311072655;7810.453268271223;7823.569703666296;4583.335416364642;4711.599514041311;4714.316424118518;4715.410573678256;4716.151092803294;2749.230215539652;2880.8415537145447;2902.34697193132;2921.7662586992988;2930.369970456341;849.7110982266059;854.4403415762686;877.32007694037;882.1707594860875;897.8024834536392;10607.20445966548;10622.15022798182;10634.680959571226;10647.467626618638;10656.893431065668;4307.655387568987;4367.5414081520985;4418.955810441918;4433.844815431445;4441.200583894865;9090.590923408463;9198.126178013077;9199.586018629177;9208.12522810332;9212.493312867722;4788.377510923558;4851.393575803025;4855.660103792771;4858.271259311132;4858.319835223001;3655.3968595182027;4179;4311.892202694958;4330.28550289205;4379.1022840317655;3580.212353282274;3631.654992775682;3680.9263814723554;3725.0314918120944;3734.533183352081;1210.0924306769923;1220.9511619535297;1237.5482948723652;1243.2043492165021;1281.8397700287464;802.7872613757359;829.0383155539545;892.5537231384308;909.9272058235325;912.5665308978182;5158.767855446514;5468.371137319259;5503.944960550343;5512.6968016759465;5787.07406814916;848.554508882829;889.6130183370254;894.6734441928779;908.4776253654176;917.5779141594941;3631;3676.3382591133854;3680.227152297994;3711.5175027246287;3763.510743603314;9395.765105872408;9509.619615215452;9730.756731081638;9741.415515069119;9755.756106097404;9333.626654933727;9627.181689556326;9740.853887191697;9774.462404567817;9781.070798274153;7028.4025857801635;7034.472414568928;7063.682134304071;7067.187273463617;7126.2873712628325;5141.511556402136;5207.843764687065;5256.816011439581;5388.164834450667;5407.64850284746;8451.112633173674;8455;8499.277561407349;8736.563171841255;8743.91256087431;8617.913820861711;8812.51531165792;8839.29285657133;8868.423552469068;8937.553122343726;5856.824295271149;6235.784022115644;6299.181106456132;6378.362163783585;6461.386168314003;7649.196834332315;7671.578063206577;7677.155512893689;7729.381649468141;7738.032745906762;6627.801165965029;6787.864242715019;6827.89758153638;6876.724931002704;6981;6795.7961261162245;6818.829529261808;6879.036934829228;6889.345512176335;6947.79156625302;6459.709313080829;6479.449246814073;6543.051257567721;6558.508111891531;6560.803175904731;4443.777811109367;4500.257457519603;4650.441946966385;4664.836730714409;4723.645726570452;4544.772761361853;4547.52251013652;4566.70316429431;4609.516000819865;4752.667313288037 04:51:33 INFO - PROCESS | 13819 | |4;prototype.html;288.5340175616379;296.73886979458075;300.3752195433497;300.91875193697695;303.72209428373014;4636.675432719702;4754.477007529169;4785.593224575915;4803.775037365472;4808.134535783557;4620.306953956908;4728.456227533835;4731.219348807451;4733;4814.085323788478;3769.2273084017847;3773.5660399054186;3786.318462676724;3790.919587917444;3832.367659336206;3571.2321850802073;3652.6712595866366;3779.130799916021;3806.9238615227678;3827.7129215308964;3709.849946516575;3745.7565258258264;3750.75620084695;3753.1930634913488;3760.191558814854;3717.3308804415196;3720.572134204574;3723.553173619156;3749.4375843623675;3754.9812250938844;3328.900132996014;3334.533165356852;3338.5159151923076;3341.913877989639;3349.246419555605;4508.391367165424;4521.841735539273;4621.653375996813;4628.884277893046;4640.976795116037;4303.91392172158;4314.374415709736;4314.546972567867;4330.826766929319;4356.586124318184;5009.44896061433;5027.572656324217;5027.84916452507;5028.7988480460735;5052.216906379517;3337.2324365395853;3550.343186510478;3553.1472446612884;3631.1466805300734;3638.6712503997464;5267.394249661262;5281.287026251445;5294.549963253166;5297.152455607123;5307.522322990911;3649.61679023704;3662.1577037281572;3663.8351274192723;3667.963320366762;3675.889723308305;3722.683571896365;3726.124360775216;3734.7945862977253;3737.177820879402;3747.194353214072;4015.277250095011;4215.873523794291;4222.303319952173;4228.23891699497;4234.946051165182;4718.4809670936165;4977.552020318189;4988.376452943382;5008.424031236382;5043.033217045355;1213.9393030348447;1247.515456606635;1252.6367353467574;1253.1228140301826;1259.439549400508;794.7006644136762;801.4710291207775;815.5269943432795;820.3191351178508;822.366777581259;3987.4218238355857;3988.74073185242;3994.940075898864;4028.3554631259444;4038.45480860086;4549.795259213277;4584.17484852723;4598.816047358135;4606.700564463299;4626.537346265347;3964.4647972523917;3994.980025099856;4003.459532963071;4004.9199016020098;4058.7215027266316;2344.6834677318684;2428.6357046443177;2433.989894193925;2440.7681270279295;2459.95080098397;4324.329728892027;4377.854851122926;4382;4405.537418571068;4442.089371678798;4727.550882666142;4741.028089241697;4744.312074749142;4776.426828780499;4778.5699287064335;4078.3882417636996;4359.760213188305;4370.912581748411;4402.691811573223;4407.096545208225;4527.932081018722;4553.362529245842;4554.020885509632;4571.542845715402;4591.977040114912;4510.977445112753;4511.751853648081;4513.052259025641;4526.32105184225;4556.88607784808;4162.917641413193;4336.241157797436;4371.431713877176;4376;4383.7588932609015;3329.467285234351;3331.566896303562;3333.5333053373033;3336.232666486673;3341.9665803342627;4514.593686568224;4584.977075114603;4594.954050459452;4597.747123908217;4992.800287988585;4874.195757699939;4996.200607902863;5017.899642007213;5020.297158397901;5050.393952725696;4976.427710813303;5027.416363845377;5027.773750181177;5044.672096313728;5051.823186188466;4777.187878060808;4967.857392799749;4973.378327709036;4982.900341993212;4995;5054.433125731035;5054.545090941686;5065.518775716301;5066.164082926276;5077.466865979019;4949.9257511138085;4960.851174464772;4975.626827987843;4994.850154495371;5009.524095210949 04:51:33 INFO - PROCESS | 13819 | |5;yui.html;656.681509467908;659.4757168051399;769.342212408391;789.5696845219355;795.1968511803077;13064.673383165426;13190.142640728345;13481.056326057167;13493.055486115976;13502.9197664187;13006.73986520269;13126;13132.540361087364;13148.737025259488;13159.342032898341;642.2710223895865;790.0835031363605;799.9160088190744;804.7263930263709;805.569020573993;817.4318848400364;819.7868554175927;819.9385046121565;820.1429506166041;820.3806126374578;850.7915560687609;851.5912362066211;851.638053827124;851.8381507513584;852.2585350744861;664.621165935417;830.1200727229096;842.5787106446777;844.2612713875297;847.1401527449643;621.9813405597839;623.4638211138417;623.9906401403982;624.9156363890862;625.2184769038702;11735.178537502377;11743.94128029363;11792.056635469142;11858.822117668242;11957.641270761891;11928.284302941764;12015.459304331325;12196.695082622917;12286.75426491465;12317.753644927141;11064.834027489514;11158.888411115948;11227.32636041832;11266.774664506664;11278.379689117095;4105.856295029689;4215.262329092397;4223.070924396628;4349.782510874444;4380.233459144669;46453.30320045202;46936.530634693896;46954.29568556474;46989.29516057262;47160.7641961788;10095.9495202525;10163.288569800043;10340.689779306633;10385.480725963671;10446.216533759998;16478.09370484635;16483.423080192137;16502.75245871313;16505.752413713803;16515.83484165143;6962.443004559725;6980.755673551503;7094.11323584552;7167.569945803269;7171.462140339496;3780.773153610792;3797.715171362159;3822.7706337619834;3829.6170382962036;3836.76979381238;2761.5443451830624;2884.7115288470986;2885.177724348551;2889.046614617171;2896.551034589642;537.5135502370362;544.5833937038169;551.4311782977422;558.9413111623221;571.665575638248;366.4448360733491;621.4613304650463;627.9905801412982;638.9041643753382;640.4908098062052;7830.2169783021245;7845.254700803414;7955.920440795518;7996.240357166176;8156.143604921398;642.6593905230235;643.5173619785161;651.1457087413417;658.9209294884548;659.7427003468651;3503.667151620592;3774.997379860374;3827.5287262510456;3832.9233415332096;3862.806859657062;52480.737596311774;54058;54219.72890135524;54394.72802635962;54966;48125.75937120292;48636;48812.755936220805;48990.26514602284;50310.49689503131;43253.35119973203;43768;43779.34330985038;44553.77723111428;44580.77709611431;7715.652795624323;7854.293113619801;7931.960340198262;8004.279614834692;8035.196480351918;29826.403471930873;30665;30673.693263067085;30706.385872281982;31578.052658420285;38523.42214866723;38531.6146838528;38797;39108.413373798845;39584.40623390594;11080.833787493355;11082.16883733707;11197.160212983896;11231.382273974683;11340.432978351215;11851.644450666148;12016.939915300367;12265.69335766613;12486.12597118193;12606.369681515704;10351.534180961724;10703.785924281316;10853.511591978222;10942.945285273523;11187.496562654538;10172.796544069226;10474.633387831389;10498;11399.373034483184;11427.257228280136;10732.73168170802;10970.835437468284;11336.206465547333;11352;11452.255603386087;9470.71587852338;9491.430514168896;9576.329656923948;9657;9974;8655.6970506032;8746.868796967923;8841.292696584387;8935.731928042169;9010.459372437675 04:51:33 INFO - PROCESS | 13819 | __end_tp_report 04:51:33 INFO - PROCESS | 13819 | __start_cc_report 04:51:33 INFO - PROCESS | 13819 | _x_x_mozilla_cycle_collect,838 04:51:33 INFO - PROCESS | 13819 | __end_cc_report 04:51:33 INFO - PROCESS | 13819 | __startTimestamp1464609093564__endTimestamp 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | ------- Summary: start ------- 04:51:33 INFO - PROCESS | 13819 | Number of tests: 6 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#0] dojo.html Cycles:165 Average:4788.80 Median:4946.23 stddev:521.34 (10.5%) stddev-sans-first:495.57 04:51:33 INFO - PROCESS | 13819 | Values: 2663.7 2673.6 2705.0 2715.2 2728.9 4628.9 4669.2 4672.8 4773.3 4822.7 4750.3 4794.5 4813.7 4849.2 4857.6 4375.2 4432.5 4471.3 4525.8 4613.1 4515.9 4549.8 4562.1 4576.2 4593.9 4302.9 4355.5 4395.9 4403.6 4447.8 4346.1 4387.1 4391.8 4441.9 4446.4 4420.0 4424.1 4435.1 4478.0 4478.4 4619.4 4661.1 4748.1 4752.4 4771.3 5167.3 5198.4 5230.2 5234.8 5236.3 5206.1 5209.6 5225.1 5244.4 5264.9 4702.1 4779.5 4844.0 4845.0 4907.9 5352.1 5400.6 5412.3 5415.8 5417.5 4948.9 5166.8 5170.9 5174.2 5176.1 5137.7 5177.0 5180.1 5186.3 5200.8 5144.7 5151.8 5157.8 5160.4 5214.3 4966.9 5020.6 5102.3 5120.2 5129.5 4309.1 4315.4 4338.5 4368.1 4372.9 3777.9 3779.8 3793.7 3813.9 3831.4 4319.0 4379.1 4412.4 4437.0 4468.7 5120.4 5145.8 5161.9 5207.4 5212.4 4428.0 4454.3 4456.8 4464.7 4504.3 4561.3 4653.9 4666.6 4696.4 4717.0 4939.3 4956.8 4963.1 4995.3 5006.3 5227.9 5242.6 5245.5 5254.0 5284.2 4650.6 4820.5 4827.0 4839.1 4946.2 5188.9 5213.4 5216.7 5217.1 5252.7 5285.8 5306.0 5307.6 5314.4 5361.1 4908.1 4997.3 5063.5 5070.7 5139.8 5063.6 5073.1 5085.3 5085.4 5126.1 4822.3 5005.6 5014.7 5020.4 5053.1 5047.4 5099.7 5105.9 5106.1 5106.8 4988.2 5011.8 5014.8 5018.9 5070.7 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#1] ext.html Cycles:180 Average:43888.95 Median:19688.07 stddev:77364.97 (393.0%) stddev-sans-first:77513.72 04:51:33 INFO - PROCESS | 13819 | Values: 597.6 605.6 607.4 613.9 621.3 27990.7 30501.7 36615.8 36699.6 36829.0 42397.4 43150.8 43193.0 43196.6 43239.1 7791.6 7956.1 7965.6 7968.4 7972.0 7489.1 10083.8 10403.4 10408.8 10418.6 10171.1 10276.5 10281.6 10284.6 10290.9 7479.1 9903.6 10123.3 10249.1 10270.8 9717.3 9831.7 9837.0 9844.4 9847.6 38337.6 38691.6 38749.0 38818.0 38855.2 3037.3 3221.1 3221.4 3321.5 3604.9 29191.7 29598.4 29909.4 29944.4 30970.5 3535.9 3543.9 3561.6 3656.4 3680.8 189050.0 189113.0 189128.1 189771.0 189943.0 31316.7 52920.5 53239.0 53295.5 53437.7 32365.7 34084.0 34292.5 34343.5 34352.1 10899.1 11040.2 11044.4 11072.9 11095.3 7829.9 8383.1 8549.1 8670.6 8776.6 7880.3 7895.4 7927.5 7972.3 8020.7 3086.7 3094.6 3136.3 3144.3 3147.1 808.9 877.4 883.8 971.8 1016.6 28020.6 28467.0 28481.0 29002.3 29087.4 883.2 899.8 943.8 1002.6 1014.5 14768.1 15077.1 15273.2 15329.5 15508.5 365848.0 369919.0 371007.0 372181.0 372863.0 49623.0 49968.0 50050.0 50066.0 50102.5 1070.9 1157.5 1193.3 1215.2 1219.8 27944.3 28619.6 28968.4 29362.3 29452.3 41597.8 45494.0 47075.1 47110.8 50957.2 290236.0 292663.0 292820.0 294058.0 294380.0 32277.2 36771.6 37109.8 38335.6 41051.6 40724.4 41361.8 41616.4 41762.2 41827.0 35985.3 36045.5 36353.6 36539.0 36964.4 35308.8 35510.5 35814.5 36007.3 36012.0 31947.4 32161.2 32797.7 35838.5 36108.1 31437.7 32203.3 32283.2 32331.5 32797.0 24749.9 24901.8 25039.6 25253.6 25748.0 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#2] jquery.html Cycles:180 Average:23829.15 Median:48126.26 stddev:65799.19 (136.7%) stddev-sans-first:65960.22 04:51:33 INFO - PROCESS | 13819 | Values: 379.5 385.2 387.4 398.5 402.2 12973.7 13564.8 15547.2 17161.2 17184.1 14983.9 15437.5 15569.0 17950.6 17978.3 4558.9 5051.8 5064.2 5209.2 5238.4 5146.6 5155.0 5170.4 5196.3 5199.4 4946.2 5148.0 5153.3 5158.1 5158.8 5196.2 5282.3 5284.6 5306.9 5307.5 5009.7 5161.1 5190.9 5192.0 5265.3 11963.7 11985.8 11994.4 12167.1 12168.3 1748.2 1887.3 1993.0 2195.9 2330.7 8956.4 8980.0 8996.1 9307.8 9448.5 1717.0 1760.2 1764.6 1785.4 1803.0 64259.0 64970.0 65553.0 65589.3 65989.7 10026.2 10050.5 10058.5 10061.9 10172.3 12011.5 12083.7 13542.5 13544.8 13549.3 6446.6 6470.5 6483.0 6530.0 6640.7 5972.9 6033.6 6036.8 6128.1 6145.0 3850.2 3875.9 4080.2 4188.4 4223.0 1780.3 1798.1 1806.9 1832.0 1854.9 825.8 841.5 845.0 853.5 939.3 16254.3 16414.8 16432.9 16510.3 16903.2 812.5 820.0 835.7 850.1 893.7 8627.3 9350.3 9389.8 9397.4 9470.1 392356.0 393393.0 394442.0 406177.0 407786.0 76466.6 78537.0 78617.6 78931.8 79223.2 972.0 985.6 993.3 1018.8 1023.0 11940.9 15499.8 15690.1 15802.1 16026.8 30845.7 34377.5 35118.3 35237.6 36098.0 47225.5 47253.8 48125.0 48127.5 48132.0 7207.9 7366.8 7525.2 7563.2 7719.7 10929.8 11782.4 11808.3 11817.0 12028.6 9587.0 9859.0 10194.3 10321.6 10392.5 9816.4 9847.6 10060.8 10067.9 10116.0 9673.4 9738.9 9893.2 10067.7 10350.5 7210.0 7249.7 7374.3 7569.8 7610.8 7177.1 8365.2 9526.0 10003.9 10085.1 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#3] mootools.html Cycles:180 Average:5141.52 Median:5438.01 stddev:2851.74 (52.4%) stddev-sans-first:2844.45 04:51:33 INFO - PROCESS | 13819 | Values: 1212.3 1371.0 1420.4 1502.3 1717.0 6698.4 7458.4 7670.5 7683.6 7858.0 7611.6 7764.1 7765.2 7766.5 7768.1 1893.4 2154.0 2184.3 2213.3 2244.9 2238.1 2259.7 2261.3 2262.0 2263.6 2148.8 2166.1 2243.1 2243.3 2249.0 1802.6 2059.8 2072.4 2132.7 2133.5 2113.1 2121.6 2128.6 2128.9 2129.3 7758.4 7801.2 7810.2 7810.5 7823.6 4583.3 4711.6 4714.3 4715.4 4716.2 2749.2 2880.8 2902.3 2921.8 2930.4 849.7 854.4 877.3 882.2 897.8 10607.2 10622.2 10634.7 10647.5 10656.9 4307.7 4367.5 4419.0 4433.8 4441.2 9090.6 9198.1 9199.6 9208.1 9212.5 4788.4 4851.4 4855.7 4858.3 4858.3 3655.4 4179.0 4311.9 4330.3 4379.1 3580.2 3631.7 3680.9 3725.0 3734.5 1210.1 1221.0 1237.5 1243.2 1281.8 802.8 829.0 892.6 909.9 912.6 5158.8 5468.4 5503.9 5512.7 5787.1 848.6 889.6 894.7 908.5 917.6 3631.0 3676.3 3680.2 3711.5 3763.5 9395.8 9509.6 9730.8 9741.4 9755.8 9333.6 9627.2 9740.9 9774.5 9781.1 7028.4 7034.5 7063.7 7067.2 7126.3 5141.5 5207.8 5256.8 5388.2 5407.6 8451.1 8455.0 8499.3 8736.6 8743.9 8617.9 8812.5 8839.3 8868.4 8937.6 5856.8 6235.8 6299.2 6378.4 6461.4 7649.2 7671.6 7677.2 7729.4 7738.0 6627.8 6787.9 6827.9 6876.7 6981.0 6795.8 6818.8 6879.0 6889.3 6947.8 6459.7 6479.4 6543.1 6558.5 6560.8 4443.8 4500.3 4650.4 4664.8 4723.6 4544.8 4547.5 4566.7 4609.5 4752.7 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#4] prototype.html Cycles:180 Average:4009.99 Median:4393.23 stddev:1159.25 (26.4%) stddev-sans-first:1128.35 04:51:33 INFO - PROCESS | 13819 | Values: 288.5 296.7 300.4 300.9 303.7 4636.7 4754.5 4785.6 4803.8 4808.1 4620.3 4728.5 4731.2 4733.0 4814.1 3769.2 3773.6 3786.3 3790.9 3832.4 3571.2 3652.7 3779.1 3806.9 3827.7 3709.8 3745.8 3750.8 3753.2 3760.2 3717.3 3720.6 3723.6 3749.4 3755.0 3328.9 3334.5 3338.5 3341.9 3349.2 4508.4 4521.8 4621.7 4628.9 4641.0 4303.9 4314.4 4314.5 4330.8 4356.6 5009.4 5027.6 5027.8 5028.8 5052.2 3337.2 3550.3 3553.1 3631.1 3638.7 5267.4 5281.3 5294.5 5297.2 5307.5 3649.6 3662.2 3663.8 3668.0 3675.9 3722.7 3726.1 3734.8 3737.2 3747.2 4015.3 4215.9 4222.3 4228.2 4234.9 4718.5 4977.6 4988.4 5008.4 5043.0 1213.9 1247.5 1252.6 1253.1 1259.4 794.7 801.5 815.5 820.3 822.4 3987.4 3988.7 3994.9 4028.4 4038.5 4549.8 4584.2 4598.8 4606.7 4626.5 3964.5 3995.0 4003.5 4004.9 4058.7 2344.7 2428.6 2434.0 2440.8 2460.0 4324.3 4377.9 4382.0 4405.5 4442.1 4727.6 4741.0 4744.3 4776.4 4778.6 4078.4 4359.8 4370.9 4402.7 4407.1 4527.9 4553.4 4554.0 4571.5 4592.0 4511.0 4511.8 4513.1 4526.3 4556.9 4162.9 4336.2 4371.4 4376.0 4383.8 3329.5 3331.6 3333.5 3336.2 3342.0 4514.6 4585.0 4595.0 4597.7 4992.8 4874.2 4996.2 5017.9 5020.3 5050.4 4976.4 5027.4 5027.8 5044.7 5051.8 4777.2 4967.9 4973.4 4982.9 4995.0 5054.4 5054.5 5065.5 5066.2 5077.5 4949.9 4960.9 4975.6 4994.9 5009.5 04:51:33 INFO - PROCESS | 13819 | 04:51:33 INFO - PROCESS | 13819 | [#5] yui.html Cycles:180 Average:13071.88 Median:24058.89 stddev:14891.52 (61.9%) stddev-sans-first:14904.11 04:51:33 INFO - PROCESS | 13819 | Values: 656.7 659.5 769.3 789.6 795.2 13064.7 13190.1 13481.1 13493.1 13502.9 13006.7 13126.0 13132.5 13148.7 13159.3 642.3 790.1 799.9 804.7 805.6 817.4 819.8 819.9 820.1 820.4 850.8 851.6 851.6 851.8 852.3 664.6 830.1 842.6 844.3 847.1 622.0 623.5 624.0 624.9 625.2 11735.2 11743.9 11792.1 11858.8 11957.6 11928.3 12015.5 12196.7 12286.8 12317.8 11064.8 11158.9 11227.3 11266.8 11278.4 4105.9 4215.3 4223.1 4349.8 4380.2 46453.3 46936.5 46954.3 46989.3 47160.8 10095.9 10163.3 10340.7 10385.5 10446.2 16478.1 16483.4 16502.8 16505.8 16515.8 6962.4 6980.8 7094.1 7167.6 7171.5 3780.8 3797.7 3822.8 3829.6 3836.8 2761.5 2884.7 2885.2 2889.0 2896.6 537.5 544.6 551.4 558.9 571.7 366.4 621.5 628.0 638.9 640.5 7830.2 7845.3 7955.9 7996.2 8156.1 642.7 643.5 651.1 658.9 659.7 3503.7 3775.0 3827.5 3832.9 3862.8 52480.7 54058.0 54219.7 54394.7 54966.0 48125.8 48636.0 48812.8 48990.3 50310.5 43253.4 43768.0 43779.3 44553.8 44580.8 7715.7 7854.3 7932.0 8004.3 8035.2 29826.4 30665.0 30673.7 30706.4 31578.1 38523.4 38531.6 38797.0 39108.4 39584.4 11080.8 11082.2 11197.2 11231.4 11340.4 11851.6 12016.9 12265.7 12486.1 12606.4 10351.5 10703.8 10853.5 10942.9 11187.5 10172.8 10474.6 10498.0 11399.4 11427.3 10732.7 10970.8 11336.2 11352.0 11452.3 9470.7 9491.4 9576.3 9657.0 9974.0 8655.7 8746.9 8841.3 8935.7 9010.5 04:51:33 INFO - PROCESS | 13819 | -------- Summary: end -------- 04:51:33 INFO - PROCESS | 13819 | 04:51:34 INFO - TEST-INFO | 13819: exit 0 04:51:34 INFO - TEST-OK | dromaeo_css | took 1123253ms 04:51:34 INFO - TEST-START | kraken 04:51:34 INFO - operating with platform_type : linux_ 04:51:34 INFO - Initialising browser for kraken test... 04:51:34 INFO - TEST-INFO | started process 13995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Ypr5w/profile http://localhost:40682/getInfo.html) 04:51:41 INFO - PROCESS | 13995 | __metrics Screen width/height:1600/1200 04:51:41 INFO - PROCESS | 13995 | colorDepth:24 04:51:41 INFO - PROCESS | 13995 | Browser inner width/height: 1024/697 04:51:41 INFO - PROCESS | 13995 | __metrics 04:51:42 ERROR - PROCESS | 13995 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:51:42 INFO - PROCESS | 13995 | console.error: PushService: 04:51:42 INFO - PROCESS | 13995 | stateChangeProcessEnqueue: Error transitioning state 04:51:42 INFO - PROCESS | 13995 | UnknownError 04:51:43 INFO - TEST-INFO | 13995: exit 0 04:51:43 INFO - Browser initialized. 04:51:43 INFO - Running cycle 1/1 for kraken test... 04:51:43 INFO - TEST-INFO | started process 14075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Ypr5w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:55 INFO - PROCESS | 14075 | RSS: Main: 157409280 04:51:55 INFO - PROCESS | 14075 | 04:51:58 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40682/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:59 INFO - PROCESS | 14075 | RSS: Main: 214523904 04:51:59 INFO - PROCESS | 14075 | 04:52:02 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40682/tests/kraken/driver.html?testName=audio-dft) 04:52:02 INFO - PROCESS | 14075 | RSS: Main: 203575296 04:52:02 INFO - PROCESS | 14075 | 04:52:06 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40682/tests/kraken/driver.html?testName=audio-fft) 04:52:06 INFO - PROCESS | 14075 | RSS: Main: 270004224 04:52:06 INFO - PROCESS | 14075 | 04:52:08 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40682/tests/kraken/driver.html?testName=audio-oscillator) 04:52:09 INFO - PROCESS | 14075 | RSS: Main: 180248576 04:52:09 INFO - PROCESS | 14075 | 04:52:11 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:12 INFO - PROCESS | 14075 | RSS: Main: 184610816 04:52:12 INFO - PROCESS | 14075 | 04:52:15 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40682/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:16 INFO - PROCESS | 14075 | RSS: Main: 220459008 04:52:16 INFO - PROCESS | 14075 | 04:52:19 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40682/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:20 INFO - PROCESS | 14075 | RSS: Main: 216846336 04:52:20 INFO - PROCESS | 14075 | 04:52:23 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40682/tests/kraken/driver.html?testName=json-parse-financial) 04:52:23 INFO - PROCESS | 14075 | RSS: Main: 219131904 04:52:23 INFO - PROCESS | 14075 | 04:52:25 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:26 INFO - PROCESS | 14075 | RSS: Main: 208728064 04:52:26 INFO - PROCESS | 14075 | 04:52:27 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:28 INFO - PROCESS | 14075 | RSS: Main: 212725760 04:52:28 INFO - PROCESS | 14075 | 04:52:30 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:31 INFO - PROCESS | 14075 | RSS: Main: 217354240 04:52:31 INFO - PROCESS | 14075 | 04:52:34 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:34 INFO - PROCESS | 14075 | RSS: Main: 222953472 04:52:34 INFO - PROCESS | 14075 | 04:52:37 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:38 INFO - PROCESS | 14075 | RSS: Main: 222052352 04:52:38 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | Cycle 1(1): loaded http://localhost:40682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40682/tests/kraken/driver.html?testName=ai-astar) 04:52:40 INFO - PROCESS | 14075 | RSS: Main: 264302592 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | __start_tp_report 04:52:40 INFO - PROCESS | 14075 | _x_x_mozilla_page_load 04:52:40 INFO - PROCESS | 14075 | _x_x_mozilla_page_load_details 04:52:40 INFO - PROCESS | 14075 | |i|pagename|runs| 04:52:40 INFO - PROCESS | 14075 | |0;ai-astar;115;108;113;113;116;114;113;113;115;115 04:52:40 INFO - PROCESS | 14075 | |1;audio-beat-detection;154;133;132;182;129;131;154;130;167;129 04:52:40 INFO - PROCESS | 14075 | |2;audio-dft;161;160;161;160;162;163;161;161;161;160 04:52:40 INFO - PROCESS | 14075 | |3;audio-fft;75;77;76;119;76;76;75;76;97;76 04:52:40 INFO - PROCESS | 14075 | |4;audio-oscillator;83;84;111;85;85;86;124;86;86;119 04:52:40 INFO - PROCESS | 14075 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;119 04:52:40 INFO - PROCESS | 14075 | |6;imaging-darkroom;147;146;147;147;147;146;147;147;146;147 04:52:40 INFO - PROCESS | 14075 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;96;95 04:52:40 INFO - PROCESS | 14075 | |8;json-parse-financial;64;64;64;64;64;65;65;63;64;64 04:52:40 INFO - PROCESS | 14075 | |9;json-stringify-tinderbox;65;65;66;65;65;65;65;65;66;66 04:52:40 INFO - PROCESS | 14075 | |10;stanford-crypto-aes;83;81;88;83;85;83;88;83;114;86 04:52:40 INFO - PROCESS | 14075 | |11;stanford-crypto-ccm;142;130;130;129;131;141;125;133;133;132 04:52:40 INFO - PROCESS | 14075 | |12;stanford-crypto-pbkdf2;174;171;172;168;175;172;174;172;173;169 04:52:40 INFO - PROCESS | 14075 | |13;stanford-crypto-sha256-iterative;67;66;66;65;69;67;67;68;65;65 04:52:40 INFO - PROCESS | 14075 | __end_tp_report 04:52:40 INFO - PROCESS | 14075 | __start_cc_report 04:52:40 INFO - PROCESS | 14075 | _x_x_mozilla_cycle_collect,1816 04:52:40 INFO - PROCESS | 14075 | __end_cc_report 04:52:40 INFO - PROCESS | 14075 | __startTimestamp1464609160342__endTimestamp 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | ------- Summary: start ------- 04:52:40 INFO - PROCESS | 14075 | Number of tests: 14 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:2.22 (1.9%) stddev-sans-first:2.29 04:52:40 INFO - PROCESS | 14075 | Values: 115.0 108.0 113.0 113.0 116.0 114.0 113.0 113.0 115.0 115.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:143.50 stddev:19.01 (13.2%) stddev-sans-first:19.82 04:52:40 INFO - PROCESS | 14075 | Values: 154.0 133.0 132.0 182.0 129.0 131.0 154.0 130.0 167.0 129.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 04:52:40 INFO - PROCESS | 14075 | Values: 161.0 160.0 161.0 160.0 162.0 163.0 161.0 161.0 161.0 160.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:14.51 (19.1%) stddev-sans-first:15.15 04:52:40 INFO - PROCESS | 14075 | Values: 75.0 77.0 76.0 119.0 76.0 76.0 75.0 76.0 97.0 76.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:85.00 stddev:16.26 (19.1%) stddev-sans-first:16.67 04:52:40 INFO - PROCESS | 14075 | Values: 83.0 84.0 111.0 85.0 85.0 86.0 124.0 86.0 86.0 119.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:52:40 INFO - PROCESS | 14075 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 119.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:52:40 INFO - PROCESS | 14075 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:52:40 INFO - PROCESS | 14075 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:52:40 INFO - PROCESS | 14075 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 65.0 63.0 64.0 64.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:52:40 INFO - PROCESS | 14075 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:84.00 stddev:9.63 (11.5%) stddev-sans-first:10.08 04:52:40 INFO - PROCESS | 14075 | Values: 83.0 81.0 88.0 83.0 85.0 83.0 88.0 83.0 114.0 86.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.50 stddev:5.23 (3.9%) stddev-sans-first:4.30 04:52:40 INFO - PROCESS | 14075 | Values: 142.0 130.0 130.0 129.0 131.0 141.0 125.0 133.0 133.0 132.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:2.21 (1.3%) stddev-sans-first:2.22 04:52:40 INFO - PROCESS | 14075 | Values: 174.0 171.0 172.0 168.0 175.0 172.0 174.0 172.0 173.0 169.0 04:52:40 INFO - PROCESS | 14075 | 04:52:40 INFO - PROCESS | 14075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 04:52:40 INFO - PROCESS | 14075 | Values: 67.0 66.0 66.0 65.0 69.0 67.0 67.0 68.0 65.0 65.0 04:52:40 INFO - PROCESS | 14075 | -------- Summary: end -------- 04:52:40 INFO - PROCESS | 14075 | 04:52:41 INFO - TEST-INFO | 14075: exit 0 04:52:41 INFO - TEST-OK | kraken | took 66910ms 04:52:41 INFO - SUITE-END | took 1190s 04:52:42 INFO - Completed test suite (00:19:50) 04:52:42 INFO - javascript benchmark 04:52:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.720309367516, 2673.5989601559777, 2705.012670375313, 2715.1990162901943, 2728.877200525976, 4628.930566041504, 4669.206234940059, 4672.836450724225, 4773.3078703588, 4822.734749588772, 4750.263709125083, 4794.544518270759, 4813.735244561548, 4849.199882019462, 4857.562819346258, 4375.190589740901, 4432.490263619693, 4471.262241730111, 4525.796339164729, 4613.100445413146, 4515.887102822423, 4549.795259213343, 4562.064776720781, 4576.199165146103, 4593.931091033637, 4302.892427689317, 4355.477342718894, 4395.890102747425, 4403.6256918162, 4447.777611119431, 4346.1090476452255, 4387.078713470175, 4391.758453285068, 4441.888952776174, 4446.399736035626, 4420.0, 4424.137293227822, 4435.090806384684, 4478.037221997253, 4478.373027776114, 4619.376384188159, 4661.137689527414, 4748.145333839908, 4752.382190315237, 4771.260454629503, 5167.276581278624, 5198.428172900978, 5230.163173892197, 5234.842954711365, 5236.293100431431, 5206.140986737221, 5209.583233341324, 5225.111731005738, 5244.39689435716, 5264.8683782905355, 4702.106599746072, 4779.5220477951925, 4843.95156048435, 4845.0, 4907.9263811042865, 5352.143657014937, 5400.567954563626, 5412.296401467784, 5415.783368665288, 5417.51242388187, 4948.925766113512, 5166.844994650167, 5170.922436163461, 5174.197999310113, 5176.068307704574, 5137.6660517066275, 5177.0, 5180.119379705384, 5186.273921650972, 5200.76596553156, 5144.6655967362, 5151.793928242828, 5157.7679004444135, 5160.354955630546, 5214.32213812202, 4966.850994470172, 5020.648554601216, 5102.311187989574, 5120.155174396183, 5129.538341549279, 4309.07354918694, 4315.352697095461, 4338.544452832407, 4368.082702632482, 4372.8906777330185, 3777.8866634001024, 3779.7732136071922, 3793.7344385893275, 3813.8855834325013, 3831.3678243090135, 4319.0, 4379.080393117481, 4412.36020776992, 4436.955630443719, 4468.709533880287, 5120.359955005624, 5145.76844042019, 5161.948380516147, 5207.427183009866, 5212.40057393397, 4428.0, 4454.28731402974, 4456.799444025027, 4464.709793863389, 4504.301833215857, 4561.29299958507, 4653.906921861544, 4666.556677115736, 4696.365990591226, 4717.0, 4939.259111133359, 4956.826511072095, 4963.10664080469, 4995.300657907896, 5006.349174607278, 5227.947720522746, 5242.606804489755, 5245.501677340647, 5253.973730131325, 5284.154535274338, 4650.558196971282, 4820.517948205152, 4827.0, 4839.056384005085, 4946.233333833262, 5188.896222075462, 5213.426523082534, 5216.66091704038, 5217.139172036572, 5252.711100889335, 5285.788568457372, 5306.0, 5307.601929855354, 5314.415414304501, 5361.115415956324, 4908.067467181224, 4997.275395067768, 5063.493650635054, 5070.6957582545165, 5139.820106296262, 5063.620228482805, 5073.086844368049, 5085.262636917701, 5085.389753229636, 5126.128558145198, 4822.324874517501, 5005.649604527794, 5014.674046186986, 5020.3724534433195, 5053.065182941167, 5047.419546752024, 5099.719515426687, 5105.948940510547, 5106.055379754757, 5106.770195341144, 4988.176950803222, 5011.774470148779, 5014.774335155, 5018.949810501995, 5070.721110338966], "value": 4754.620589543783, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5667640960304, 605.6487237402307, 607.4259824465879, 613.8772245550891, 621.3382747374044, 27990.720092799067, 30501.69498305016, 36615.81692091542, 36699.63300366996, 36829.0, 42397.36403953935, 43150.7842460788, 43193.03280122779, 43196.56803431965, 43239.13521729563, 7791.571463569501, 7956.0850502192125, 7965.561894095851, 7968.402369822257, 7971.96014019929, 7489.138749043876, 10083.798324033514, 10403.427811470367, 10408.843867341995, 10418.583256669763, 10171.135453486462, 10276.486175691223, 10281.588736450532, 10284.58861645537, 10290.897091029106, 7479.102507699056, 9903.554340054714, 10123.29136960413, 10249.07758301749, 10270.845937310947, 9717.31978761487, 9831.655892043744, 9836.950815245878, 9844.3601165924, 9847.55685994132, 38337.616623833965, 38691.61308386908, 38749.0, 38818.0, 38855.22289554221, 3037.271054946797, 3221.0819916323735, 3221.355728854215, 3321.4685650295837, 3604.9098772530633, 29191.70808291911, 29598.40803183946, 29909.40181196364, 29944.401111977855, 30970.53544196839, 3535.9116022099397, 3543.9291214175573, 3561.6082230954576, 3656.3601369760186, 3680.8159592020293, 189050.0, 189113.0, 189128.0543597287, 189771.0, 189943.0, 31316.686833131378, 52920.47079529233, 53239.0, 53295.467045329824, 53437.73281133569, 32365.676343236268, 34084.0, 34292.48561271583, 34343.535340405586, 34352.141196470286, 10899.073578745736, 11040.227184097197, 11044.447777611247, 11072.944635276772, 11095.278806877526, 7829.882551761728, 8383.119772423808, 8549.145085491402, 8670.609822557873, 8776.648934042694, 7880.2513761192595, 7895.368370530344, 7927.484713493604, 7972.2824945755165, 8020.679172833022, 3086.6913308669405, 3094.6441159266974, 3136.2943337748825, 3144.261098641817, 3147.0716138739126, 808.9433739638287, 877.3770622857843, 883.8011447424278, 971.7764914069803, 1016.6035246253966, 28020.579691304647, 28467.0, 28481.0, 29002.27494312617, 29087.41825163485, 883.1521739130507, 899.8020435504178, 943.8442656961524, 1002.6089824968268, 1014.5434554450379, 14768.113913165245, 15077.095374277578, 15273.234942162124, 15329.540113796604, 15508.457203997807, 365848.0, 369919.0, 371007.0, 372181.0, 372863.0, 49623.0, 49968.0, 50050.0, 50066.0, 50102.49897500978, 1070.9089727373262, 1157.5196293538088, 1193.2780667696093, 1215.2344023265287, 1219.8170274458903, 27944.30139246535, 28619.570706439004, 28968.42063158683, 29362.265943351587, 29452.263693407836, 41597.79201104096, 45494.0, 47075.058498829145, 47110.76444617755, 50957.235641464664, 290236.0, 292663.0, 292820.0, 294058.0, 294380.0, 32277.193070172496, 36771.63228367789, 37109.81445092757, 38335.61664383321, 41051.58948410478, 40724.38913416242, 41361.75914722563, 41616.3757543631, 41762.1647567053, 41827.0, 35985.28029439449, 36045.45931811077, 36353.636463635026, 36539.0, 36964.44553331756, 35308.82345588256, 35510.46734298936, 35814.53683979925, 36007.27985440329, 36012.0, 31947.36105277835, 32161.195970100936, 32797.672023280415, 35838.46242306315, 36108.09729756672, 31437.685623143476, 32203.2798342616, 32283.19292017718, 32331.51502727508, 32797.0, 24749.876250619353, 24901.750982489943, 25039.643359363254, 25253.621195681713, 25748.0], "value": 16746.07572993301, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.4952712891853, 385.22954091816365, 387.3956627660849, 398.4899328859061, 402.2477966203199, 12973.675658108552, 13564.796528052062, 15547.222638868054, 17161.2277447515, 17184.140792960363, 14983.92508037461, 15437.536873893772, 15569.0, 17950.640987180283, 17978.280868765265, 4558.8632341029825, 5051.823186188493, 5064.164412871872, 5209.166533354664, 5238.449962753894, 5146.639735218536, 5155.046316431472, 5170.353705786777, 5196.272521846944, 5199.402068762103, 4946.233333833262, 5148.0, 5153.252778347138, 5158.071547121516, 5158.819441319554, 5196.246544251081, 5282.260483532308, 5284.550813180885, 5306.893862122755, 5307.469253074701, 5009.699418034929, 5161.122609156452, 5190.870228244286, 5192.039472697563, 5265.315508983846, 11963.700907477383, 11985.760284794342, 11994.400279986054, 12167.087468439813, 12168.330741809197, 1748.195829918239, 1887.292265400475, 1993.0, 2195.868247905131, 2330.7436182019965, 8956.417832840909, 8980.0, 8996.145366190201, 9307.76730581741, 9448.52757362136, 1717.0, 1760.1903124562716, 1764.6235935969964, 1785.366195000769, 1802.9549261268442, 64259.0, 64970.0, 65553.0, 65589.3441065588, 65989.67005164991, 10026.19528484865, 10050.547725352377, 10058.547365368577, 10061.899381006097, 10172.338797978107, 12011.519539218509, 12083.697907552205, 13542.526011589547, 13544.796828047587, 13549.322533873266, 6446.580972236789, 6470.508854091115, 6482.967585162139, 6530.0, 6640.734370625121, 5972.940270597325, 6033.607815491979, 6036.8188954331445, 6128.142060111588, 6145.0, 3850.2492014057552, 3875.9418608720894, 4080.2451546464, 4188.434561334181, 4222.9577704223175, 1780.2967827707982, 1798.0739918941756, 1806.9277228910696, 1832.0, 1854.9072546372627, 825.7729124490693, 841.5287439034161, 845.0, 853.4921721575653, 939.2720641502754, 16254.349826006828, 16414.753778693328, 16432.917835410986, 16510.33958641641, 16903.154842257838, 812.5003123079264, 820.0364571628313, 835.6532039203662, 850.1073872433919, 893.6738090596886, 8627.266682331947, 9350.345475816763, 9389.812203755886, 9397.436153830655, 9470.078983893665, 392356.0, 393393.0, 394442.0, 406177.0, 407786.0, 76466.6176669113, 78537.0, 78617.60691196508, 78931.78312260956, 79223.20776792159, 972.0376826941277, 985.6205360936091, 993.2816227925729, 1018.8115198688118, 1022.9539670714836, 11940.880591193976, 15499.845001550291, 15690.137042462775, 15802.051876887424, 16026.759598606264, 30845.691543084282, 34377.48433773445, 35118.29763404769, 35237.64762352344, 36098.0, 47225.527744722116, 47253.76373118113, 48125.0, 48127.5187248137, 48132.0, 7207.9279207207255, 7366.77899663011, 7525.247475252431, 7563.205863384265, 7719.652615632198, 10929.83605245906, 11782.351970641354, 11808.291502509877, 11817.0, 12028.578999734968, 9587.0, 9858.950705246429, 10194.337368071348, 10321.63874264397, 10392.493088502277, 9816.361936474106, 9847.556859941464, 10060.84908726355, 10067.899321006696, 10116.03897629724, 9673.419594824332, 9738.902610973799, 9893.159081477866, 10067.69796906094, 10350.5342259597, 7210.0, 7249.746258880914, 7374.262573742582, 7569.8107547309555, 7610.847783044197, 7177.138743350832, 8365.24712775853, 9525.952370238105, 10003.899961000297, 10085.092341689284], "value": 7860.264189561102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.2908098762223, 1371.047122250036, 1420.3750349846066, 1502.308937888571, 1716.982830171698, 6698.430633396161, 7458.403327733782, 7670.463067585271, 7683.57740324282, 7858.0, 7611.61941902904, 7764.068311802592, 7765.223477652232, 7766.534007959513, 7768.145503994556, 1893.4319704088787, 2153.9569208615817, 2184.3446965910243, 2213.269621025066, 2244.932652020442, 2238.104758096758, 2259.6836442898007, 2261.298997310839, 2262.0, 2263.649134384173, 2148.79586439288, 2166.068590506082, 2243.069126312578, 2243.349428665685, 2249.0441562336023, 1802.6394721055776, 2059.814616684498, 2072.4197224777085, 2132.701421800949, 2133.5306232628795, 2113.1019316790457, 2121.628714974873, 2128.6168489671854, 2128.9254876079417, 2129.3079749081458, 7758.379329653614, 7801.180876007994, 7810.1799311072655, 7810.453268271223, 7823.569703666296, 4583.335416364642, 4711.599514041311, 4714.316424118518, 4715.410573678256, 4716.151092803294, 2749.230215539652, 2880.8415537145447, 2902.34697193132, 2921.7662586992988, 2930.369970456341, 849.7110982266059, 854.4403415762686, 877.32007694037, 882.1707594860875, 897.8024834536392, 10607.20445966548, 10622.15022798182, 10634.680959571226, 10647.467626618638, 10656.893431065668, 4307.655387568987, 4367.5414081520985, 4418.955810441918, 4433.844815431445, 4441.200583894865, 9090.590923408463, 9198.126178013077, 9199.586018629177, 9208.12522810332, 9212.493312867722, 4788.377510923558, 4851.393575803025, 4855.660103792771, 4858.271259311132, 4858.319835223001, 3655.3968595182027, 4179.0, 4311.892202694958, 4330.28550289205, 4379.1022840317655, 3580.212353282274, 3631.654992775682, 3680.9263814723554, 3725.0314918120944, 3734.533183352081, 1210.0924306769923, 1220.9511619535297, 1237.5482948723652, 1243.2043492165021, 1281.8397700287464, 802.7872613757359, 829.0383155539545, 892.5537231384308, 909.9272058235325, 912.5665308978182, 5158.767855446514, 5468.371137319259, 5503.944960550343, 5512.6968016759465, 5787.07406814916, 848.554508882829, 889.6130183370254, 894.6734441928779, 908.4776253654176, 917.5779141594941, 3631.0, 3676.3382591133854, 3680.227152297994, 3711.5175027246287, 3763.510743603314, 9395.765105872408, 9509.619615215452, 9730.756731081638, 9741.415515069119, 9755.756106097404, 9333.626654933727, 9627.181689556326, 9740.853887191697, 9774.462404567817, 9781.070798274153, 7028.4025857801635, 7034.472414568928, 7063.682134304071, 7067.187273463617, 7126.2873712628325, 5141.511556402136, 5207.843764687065, 5256.816011439581, 5388.164834450667, 5407.64850284746, 8451.112633173674, 8455.0, 8499.277561407349, 8736.563171841255, 8743.91256087431, 8617.913820861711, 8812.51531165792, 8839.29285657133, 8868.423552469068, 8937.553122343726, 5856.824295271149, 6235.784022115644, 6299.181106456132, 6378.362163783585, 6461.386168314003, 7649.196834332315, 7671.578063206577, 7677.155512893689, 7729.381649468141, 7738.032745906762, 6627.801165965029, 6787.864242715019, 6827.89758153638, 6876.724931002704, 6981.0, 6795.7961261162245, 6818.829529261808, 6879.036934829228, 6889.345512176335, 6947.79156625302, 6459.709313080829, 6479.449246814073, 6543.051257567721, 6558.508111891531, 6560.803175904731, 4443.777811109367, 4500.257457519603, 4650.441946966385, 4664.836730714409, 4723.645726570452, 4544.772761361853, 4547.52251013652, 4566.70316429431, 4609.516000819865, 4752.667313288037], "value": 4150.766717731554, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5340175616379, 296.73886979458075, 300.3752195433497, 300.91875193697695, 303.72209428373014, 4636.675432719702, 4754.477007529169, 4785.593224575915, 4803.775037365472, 4808.134535783557, 4620.306953956908, 4728.456227533835, 4731.219348807451, 4733.0, 4814.085323788478, 3769.2273084017847, 3773.5660399054186, 3786.318462676724, 3790.919587917444, 3832.367659336206, 3571.2321850802073, 3652.6712595866366, 3779.130799916021, 3806.9238615227678, 3827.7129215308964, 3709.849946516575, 3745.7565258258264, 3750.75620084695, 3753.1930634913488, 3760.191558814854, 3717.3308804415196, 3720.572134204574, 3723.553173619156, 3749.4375843623675, 3754.9812250938844, 3328.900132996014, 3334.533165356852, 3338.5159151923076, 3341.913877989639, 3349.246419555605, 4508.391367165424, 4521.841735539273, 4621.653375996813, 4628.884277893046, 4640.976795116037, 4303.91392172158, 4314.374415709736, 4314.546972567867, 4330.826766929319, 4356.586124318184, 5009.44896061433, 5027.572656324217, 5027.84916452507, 5028.7988480460735, 5052.216906379517, 3337.2324365395853, 3550.343186510478, 3553.1472446612884, 3631.1466805300734, 3638.6712503997464, 5267.394249661262, 5281.287026251445, 5294.549963253166, 5297.152455607123, 5307.522322990911, 3649.61679023704, 3662.1577037281572, 3663.8351274192723, 3667.963320366762, 3675.889723308305, 3722.683571896365, 3726.124360775216, 3734.7945862977253, 3737.177820879402, 3747.194353214072, 4015.277250095011, 4215.873523794291, 4222.303319952173, 4228.23891699497, 4234.946051165182, 4718.4809670936165, 4977.552020318189, 4988.376452943382, 5008.424031236382, 5043.033217045355, 1213.9393030348447, 1247.515456606635, 1252.6367353467574, 1253.1228140301826, 1259.439549400508, 794.7006644136762, 801.4710291207775, 815.5269943432795, 820.3191351178508, 822.366777581259, 3987.4218238355857, 3988.74073185242, 3994.940075898864, 4028.3554631259444, 4038.45480860086, 4549.795259213277, 4584.17484852723, 4598.816047358135, 4606.700564463299, 4626.537346265347, 3964.4647972523917, 3994.980025099856, 4003.459532963071, 4004.9199016020098, 4058.7215027266316, 2344.6834677318684, 2428.6357046443177, 2433.989894193925, 2440.7681270279295, 2459.95080098397, 4324.329728892027, 4377.854851122926, 4382.0, 4405.537418571068, 4442.089371678798, 4727.550882666142, 4741.028089241697, 4744.312074749142, 4776.426828780499, 4778.5699287064335, 4078.3882417636996, 4359.760213188305, 4370.912581748411, 4402.691811573223, 4407.096545208225, 4527.932081018722, 4553.362529245842, 4554.020885509632, 4571.542845715402, 4591.977040114912, 4510.977445112753, 4511.751853648081, 4513.052259025641, 4526.32105184225, 4556.88607784808, 4162.917641413193, 4336.241157797436, 4371.431713877176, 4376.0, 4383.7588932609015, 3329.467285234351, 3331.566896303562, 3333.5333053373033, 3336.232666486673, 3341.9665803342627, 4514.593686568224, 4584.977075114603, 4594.954050459452, 4597.747123908217, 4992.800287988585, 4874.195757699939, 4996.200607902863, 5017.899642007213, 5020.297158397901, 5050.393952725696, 4976.427710813303, 5027.416363845377, 5027.773750181177, 5044.672096313728, 5051.823186188466, 4777.187878060808, 4967.857392799749, 4973.378327709036, 4982.900341993212, 4995.0, 5054.433125731035, 5054.545090941686, 5065.518775716301, 5066.164082926276, 5077.466865979019, 4949.9257511138085, 4960.851174464772, 4975.626827987843, 4994.850154495371, 5009.524095210949], "value": 3644.108438622477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.681509467908, 659.4757168051399, 769.342212408391, 789.5696845219355, 795.1968511803077, 13064.673383165426, 13190.142640728345, 13481.056326057167, 13493.055486115976, 13502.9197664187, 13006.73986520269, 13126.0, 13132.540361087364, 13148.737025259488, 13159.342032898341, 642.2710223895865, 790.0835031363605, 799.9160088190744, 804.7263930263709, 805.569020573993, 817.4318848400364, 819.7868554175927, 819.9385046121565, 820.1429506166041, 820.3806126374578, 850.7915560687609, 851.5912362066211, 851.638053827124, 851.8381507513584, 852.2585350744861, 664.621165935417, 830.1200727229096, 842.5787106446777, 844.2612713875297, 847.1401527449643, 621.9813405597839, 623.4638211138417, 623.9906401403982, 624.9156363890862, 625.2184769038702, 11735.178537502377, 11743.94128029363, 11792.056635469142, 11858.822117668242, 11957.641270761891, 11928.284302941764, 12015.459304331325, 12196.695082622917, 12286.75426491465, 12317.753644927141, 11064.834027489514, 11158.888411115948, 11227.32636041832, 11266.774664506664, 11278.379689117095, 4105.856295029689, 4215.262329092397, 4223.070924396628, 4349.782510874444, 4380.233459144669, 46453.30320045202, 46936.530634693896, 46954.29568556474, 46989.29516057262, 47160.7641961788, 10095.9495202525, 10163.288569800043, 10340.689779306633, 10385.480725963671, 10446.216533759998, 16478.09370484635, 16483.423080192137, 16502.75245871313, 16505.752413713803, 16515.83484165143, 6962.443004559725, 6980.755673551503, 7094.11323584552, 7167.569945803269, 7171.462140339496, 3780.773153610792, 3797.715171362159, 3822.7706337619834, 3829.6170382962036, 3836.76979381238, 2761.5443451830624, 2884.7115288470986, 2885.177724348551, 2889.046614617171, 2896.551034589642, 537.5135502370362, 544.5833937038169, 551.4311782977422, 558.9413111623221, 571.665575638248, 366.4448360733491, 621.4613304650463, 627.9905801412982, 638.9041643753382, 640.4908098062052, 7830.2169783021245, 7845.254700803414, 7955.920440795518, 7996.240357166176, 8156.143604921398, 642.6593905230235, 643.5173619785161, 651.1457087413417, 658.9209294884548, 659.7427003468651, 3503.667151620592, 3774.997379860374, 3827.5287262510456, 3832.9233415332096, 3862.806859657062, 52480.737596311774, 54058.0, 54219.72890135524, 54394.72802635962, 54966.0, 48125.75937120292, 48636.0, 48812.755936220805, 48990.26514602284, 50310.49689503131, 43253.35119973203, 43768.0, 43779.34330985038, 44553.77723111428, 44580.77709611431, 7715.652795624323, 7854.293113619801, 7931.960340198262, 8004.279614834692, 8035.196480351918, 29826.403471930873, 30665.0, 30673.693263067085, 30706.385872281982, 31578.052658420285, 38523.42214866723, 38531.6146838528, 38797.0, 39108.413373798845, 39584.40623390594, 11080.833787493355, 11082.16883733707, 11197.160212983896, 11231.382273974683, 11340.432978351215, 11851.644450666148, 12016.939915300367, 12265.69335766613, 12486.12597118193, 12606.369681515704, 10351.534180961724, 10703.785924281316, 10853.511591978222, 10942.945285273523, 11187.496562654538, 10172.796544069226, 10474.633387831389, 10498.0, 11399.373034483184, 11427.257228280136, 10732.73168170802, 10970.835437468284, 11336.206465547333, 11352.0, 11452.255603386087, 9470.71587852338, 9491.430514168896, 9576.329656923948, 9657.0, 9974.0, 8655.6970506032, 8746.868796967923, 8841.292696584387, 8935.731928042169, 9010.459372437675], "value": 6066.443699174073, "unit": "score"}], "name": "dromaeo_css", "value": 6211.4745255453845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 113.0, 116.0, 114.0, 113.0, 113.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 132.0, 182.0, 129.0, 131.0, 154.0, 130.0, 167.0, 129.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 119.0, 76.0, 76.0, 75.0, 76.0, 97.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 85.0, 85.0, 86.0, 124.0, 86.0, 86.0, 119.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 88.0, 83.0, 85.0, 83.0, 88.0, 83.0, 114.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 130.0, 129.0, 131.0, 141.0, 125.0, 133.0, 133.0, 132.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 172.0, 168.0, 175.0, 172.0, 174.0, 172.0, 173.0, 169.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 69.0, 67.0, 67.0, 68.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1542.6, "alertThreshold": 2.0}]} 04:52:42 INFO - Return code: 0 04:52:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:42 ERROR - # TBPL SUCCESS # 04:52:42 INFO - Running post-action listener: _resource_record_post_action 04:52:42 INFO - ##### 04:52:42 INFO - ##### Finished run-tests step (success) 04:52:42 INFO - ##### 04:52:42 INFO - Running post-run listener: _resource_record_post_run 04:52:42 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282304512; Read time: 16; Write time: 1092184 04:52:42 INFO - TinderboxPrint: CPU usage
13.3% 04:52:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:52:42 INFO - TinderboxPrint: I/O write bytes / time
282,304,512 / 1,092,184 04:52:42 INFO - TinderboxPrint: CPU idle
8,355.5 (86.6%) 04:52:42 INFO - TinderboxPrint: CPU user
1,221.2 (12.7%) 04:52:42 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5443584; Read time: 0; Write time: 3880 04:52:42 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275664896; Read time: 16; Write time: 1088224 04:52:42 INFO - Running post-run listener: _upload_blobber_files 04:52:42 INFO - Blob upload gear active. 04:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:42 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 04:52:42 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'] 04:52:42 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 04:52:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:43 INFO - (blobuploader) - INFO - Done attempting. 04:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:47 INFO - (blobuploader) - INFO - Done attempting. 04:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:48 INFO - (blobuploader) - INFO - Done attempting. 04:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:48 INFO - Return code: 0 04:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/088e630ab4e502b156837981e3749f77db326b67bf9fb749bb9ca7b2864ab251f1bba0844fa96b3b03401f871308a2784e27ed151028ade9c054921ccc52be9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108fb7b330cc1b5004f863ef7d0fe710b7a775cf79c0d0fd2e3f28f4e3bb5e7db207a66cd260b40670727cfc20434effdfdda93694631129117207b421c1db05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94028d7df02262daf2ab23858b2e04effe88c5277b5f9dc35ba10aa93782e2f184d1a2454bde162702e1d0af29b1ace27418bebad6cdf1cb14c2c022cd893ada"} 04:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:48 INFO - Contents: 04:52:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/088e630ab4e502b156837981e3749f77db326b67bf9fb749bb9ca7b2864ab251f1bba0844fa96b3b03401f871308a2784e27ed151028ade9c054921ccc52be9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108fb7b330cc1b5004f863ef7d0fe710b7a775cf79c0d0fd2e3f28f4e3bb5e7db207a66cd260b40670727cfc20434effdfdda93694631129117207b421c1db05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94028d7df02262daf2ab23858b2e04effe88c5277b5f9dc35ba10aa93782e2f184d1a2454bde162702e1d0af29b1ace27418bebad6cdf1cb14c2c022cd893ada"} 04:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:48 INFO - Copying logs to upload dir... 04:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.995494 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-05-30 04:52:48.511287) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 04:52:48.514986) ========= 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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 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/088e630ab4e502b156837981e3749f77db326b67bf9fb749bb9ca7b2864ab251f1bba0844fa96b3b03401f871308a2784e27ed151028ade9c054921ccc52be9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108fb7b330cc1b5004f863ef7d0fe710b7a775cf79c0d0fd2e3f28f4e3bb5e7db207a66cd260b40670727cfc20434effdfdda93694631129117207b421c1db05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94028d7df02262daf2ab23858b2e04effe88c5277b5f9dc35ba10aa93782e2f184d1a2454bde162702e1d0af29b1ace27418bebad6cdf1cb14c2c022cd893ada"} build_url:https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/Vf52iJIWR8u8kXbqZwFwFA/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/088e630ab4e502b156837981e3749f77db326b67bf9fb749bb9ca7b2864ab251f1bba0844fa96b3b03401f871308a2784e27ed151028ade9c054921ccc52be9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108fb7b330cc1b5004f863ef7d0fe710b7a775cf79c0d0fd2e3f28f4e3bb5e7db207a66cd260b40670727cfc20434effdfdda93694631129117207b421c1db05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94028d7df02262daf2ab23858b2e04effe88c5277b5f9dc35ba10aa93782e2f184d1a2454bde162702e1d0af29b1ace27418bebad6cdf1cb14c2c022cd893ada"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 04:52:48.540092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:52:48.540423) ========= 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=33d5923976266a1c518c4bf7000001ab-1464607892.507445-1632055818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 04:52:48.624431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 04:52:48.624763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 04:52:48.625060) ========= ========= Total master_lag: 0.15 =========