builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1464905132.43 results: success (0) buildid: 20160602132435 builduid: af06dce269a04441a450a5ce56122df0 revision: 28e5f7d006ddb08850ee04a6b22178376c8797c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.431326) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.431769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.432042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.446734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.447017) ========= 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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 15:05:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.81M=0.001s 2016-06-02 15:05:33 (8.81 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.305845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.766572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.766897) ========= 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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022488 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:32.817961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 15:05:32.818545) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 28e5f7d006ddb08850ee04a6b22178376c8797c4 --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 28e5f7d006ddb08850ee04a6b22178376c8797c4 --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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 15:05:33,318 truncating revision to first 12 chars 2016-06-02 15:05:33,318 Setting DEBUG logging. 2016-06-02 15:05:33,318 attempt 1/10 2016-06-02 15:05:33,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/28e5f7d006dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 15:05:34,000 unpacking tar archive at: fx-team-28e5f7d006dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 15:05:33.871575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:33.871909) ========= script_repo_revision: 28e5f7d006ddb08850ee04a6b22178376c8797c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:33.872847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:33.873374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 15:05:33.884447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-02 15:05:33.884739) ========= /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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:34 INFO - MultiFileLogger online at 20160602 15:05:34 in /builds/slave/test 15:05: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 15:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:34 INFO - {'append_to_log': False, 15:05:34 INFO - 'base_work_dir': '/builds/slave/test', 15:05:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:34 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:34 INFO - 'config_files': ('talos/linux_config.py',), 15:05:34 INFO - 'default_actions': ('clobber', 15:05:34 INFO - 'read-buildbot-config', 15:05:34 INFO - 'download-and-extract', 15:05:34 INFO - 'populate-webroot', 15:05:34 INFO - 'create-virtualenv', 15:05:34 INFO - 'install', 15:05:34 INFO - 'run-tests'), 15:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:34 INFO - 'download_minidump_stackwalk': True, 15:05:34 INFO - 'download_symbols': 'ondemand', 15:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:34 INFO - 'installer_path': 'installer.exe', 15:05:34 INFO - 'log_level': 'info', 15:05:34 INFO - 'log_name': 'talos', 15:05:34 INFO - 'log_to_console': True, 15:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:34 INFO - 'opt_config_files': (), 15:05:34 INFO - 'pip_index': False, 15:05:34 INFO - 'sps_profile': False, 15:05:34 INFO - 'sps_profile_interval': 0, 15:05:34 INFO - 'suite': 'dromaeojs', 15:05:34 INFO - 'system_bits': '32', 15:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:34 INFO - 'title': 'talos-linux64-ix-032', 15:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:34 INFO - 'use_talos_json': True, 15:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:34 INFO - 'work_dir': 'build'} 15:05:34 INFO - ##### 15:05:34 INFO - ##### Running clobber step. 15:05:34 INFO - ##### 15:05:34 INFO - Running pre-action listener: _resource_record_pre_action 15:05:34 INFO - Running main action method: clobber 15:05:34 INFO - rmtree: /builds/slave/test/build 15:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:34 INFO - Running post-action listener: _resource_record_post_action 15:05:34 INFO - ##### 15:05:34 INFO - ##### Finished clobber step (success) 15:05:34 INFO - ##### 15:05:34 INFO - ##### 15:05:34 INFO - ##### Running read-buildbot-config step. 15:05:34 INFO - ##### 15:05:34 INFO - Running pre-action listener: _resource_record_pre_action 15:05:34 INFO - Running main action method: read_buildbot_config 15:05:34 INFO - Using buildbot properties: 15:05:34 INFO - { 15:05:34 INFO - "project": "", 15:05:34 INFO - "product": "firefox", 15:05:34 INFO - "script_repo_revision": "production", 15:05:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:05:34 INFO - "repository": "", 15:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:05:34 INFO - "buildid": "20160602132435", 15:05:34 INFO - "pgo_build": "False", 15:05:34 INFO - "basedir": "/builds/slave/test", 15:05:34 INFO - "buildnumber": 3040, 15:05:34 INFO - "slavename": "talos-linux64-ix-032", 15:05:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:34 INFO - "platform": "ubuntu64_hw", 15:05:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:34 INFO - "branch": "fx-team", 15:05:34 INFO - "repo_path": "integration/fx-team", 15:05:34 INFO - "revision": "28e5f7d006ddb08850ee04a6b22178376c8797c4", 15:05:34 INFO - "stage_platform": "linux64", 15:05:34 INFO - "builduid": "af06dce269a04441a450a5ce56122df0", 15:05:34 INFO - "slavebuilddir": "test" 15:05:34 INFO - } 15:05:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:05:34 INFO - Running post-action listener: _resource_record_post_action 15:05:34 INFO - ##### 15:05:34 INFO - ##### Finished read-buildbot-config step (success) 15:05:34 INFO - ##### 15:05:34 INFO - ##### 15:05:34 INFO - ##### Running download-and-extract step. 15:05:34 INFO - ##### 15:05:34 INFO - Running pre-action listener: _resource_record_pre_action 15:05:34 INFO - Running main action method: download_and_extract 15:05:34 INFO - mkdir: /builds/slave/test/build/tests 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:35 INFO - Downloaded 1361 bytes. 15:05:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:05:35 INFO - Using the following test package requirements: 15:05:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'jsshell-linux-x86_64.zip'], 15:05:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05: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')]} 15:05:35 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:36 INFO - Downloaded 22866938 bytes. 15:05:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:05:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:05:37 INFO - Return code: 0 15:05:37 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 15:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:37 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:39 INFO - Downloaded 22866938 bytes. 15:05: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'] 15:05: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 15:05:40 INFO - Return code: 0 15:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:40 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:41 INFO - Downloaded 10834055 bytes. 15:05:41 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'] 15:05:41 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 15:05:42 INFO - Return code: 0 15:05: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')]} 15:05:42 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:05:43 INFO - Downloaded 55084756 bytes. 15:05:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:43 INFO - mkdir: /builds/slave/test/properties 15:05:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:43 INFO - Contents: 15:05:43 INFO - build_url:https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - Running post-action listener: set_extra_try_arguments 15:05:44 INFO - ##### 15:05:44 INFO - ##### Finished download-and-extract step (success) 15:05:44 INFO - ##### 15:05:44 INFO - ##### 15:05:44 INFO - ##### Running populate-webroot step. 15:05:44 INFO - ##### 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: populate_webroot 15:05:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:44 INFO - '--tppagecycles', 15:05:44 INFO - '7'], 15:05:44 INFO - 'tests': ['tsvgm']}}, 15:05:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'cart']}, 15:05:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'cart']}, 15:05:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s'], 15:05:44 INFO - 'tests': ['tp5o']}, 15:05:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'tests': ['tp5o']}, 15:05:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-e10s', 15:05:44 INFO - '--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}, 15:05:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:44 INFO - 'talos_options': ['--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}}, 15:05:44 INFO - 'talos.zip': {'path': '', 15:05:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - ##### 15:05:44 INFO - ##### Finished populate-webroot step (success) 15:05:44 INFO - ##### 15:05:44 INFO - ##### 15:05:44 INFO - ##### Running create-virtualenv step. 15:05:44 INFO - ##### 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: create_virtualenv 15:05:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:05:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:44 INFO - Using real prefix '/usr' 15:05:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:46 INFO - Installing pip.................done. 15:05:46 INFO - Return code: 0 15:05:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:46 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:46 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 15:05:46 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 15:05:46 INFO - Using env: {'DISPLAY': ':0', 15:05:46 INFO - 'HOME': '/home/cltbld', 15:05:46 INFO - 'LANG': 'en_US.UTF-8', 15:05:46 INFO - 'LANGUAGE': 'en_US:en', 15:05:46 INFO - 'LOGNAME': 'cltbld', 15:05:46 INFO - 'MAIL': '/var/mail/cltbld', 15:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:46 INFO - 'MOZ_NO_REMOTE': '1', 15:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:46 INFO - 'NO_EM_RESTART': '1', 15:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:46 INFO - 'PWD': '/builds/slave/test', 15:05:46 INFO - 'SHELL': '/bin/bash', 15:05:46 INFO - 'SHLVL': '1', 15:05:46 INFO - 'TERM': 'linux', 15:05:46 INFO - 'TMOUT': '86400', 15:05:46 INFO - 'USER': 'cltbld', 15:05:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:46 INFO - '_': '/tools/buildbot/bin/python'} 15:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:46 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 15:05:46 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Downloading/unpacking psutil>=3.1.1 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:49 INFO - Installing collected packages: psutil 15:05:49 INFO - Running setup.py install for psutil 15:05:49 INFO - building 'psutil._psutil_linux' extension 15:05:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:05:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:05:49 INFO - building 'psutil._psutil_posix' extension 15:05:49 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 15:05:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:49 INFO - Successfully installed psutil 15:05:49 INFO - Cleaning up... 15:05:49 INFO - Return code: 0 15:05:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:49 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 15:05:49 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 15:05:49 INFO - Using env: {'DISPLAY': ':0', 15:05:49 INFO - 'HOME': '/home/cltbld', 15:05:49 INFO - 'LANG': 'en_US.UTF-8', 15:05:49 INFO - 'LANGUAGE': 'en_US:en', 15:05:49 INFO - 'LOGNAME': 'cltbld', 15:05:49 INFO - 'MAIL': '/var/mail/cltbld', 15:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:49 INFO - 'MOZ_NO_REMOTE': '1', 15:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:49 INFO - 'NO_EM_RESTART': '1', 15:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:49 INFO - 'PWD': '/builds/slave/test', 15:05:49 INFO - 'SHELL': '/bin/bash', 15:05:49 INFO - 'SHLVL': '1', 15:05:49 INFO - 'TERM': 'linux', 15:05:49 INFO - 'TMOUT': '86400', 15:05:49 INFO - 'USER': 'cltbld', 15:05:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:49 INFO - '_': '/tools/buildbot/bin/python'} 15:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:51 INFO - Installing collected packages: mozsystemmonitor 15:05:51 INFO - Running setup.py install for mozsystemmonitor 15:05:52 INFO - Successfully installed mozsystemmonitor 15:05:52 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05: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 15:05:54 INFO - Downloading docopt-0.6.1.tar.gz 15:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:55 INFO - Running setup.py install for blobuploader 15:05:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:55 INFO - Running setup.py install for requests 15:05:55 INFO - Running setup.py install for docopt 15:05:55 INFO - Successfully installed blobuploader requests docopt 15:05:55 INFO - Cleaning up... 15:05:55 INFO - Return code: 0 15:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:55 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:55 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 15:05:55 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 15:05:55 INFO - Using env: {'DISPLAY': ':0', 15:05:55 INFO - 'HOME': '/home/cltbld', 15:05:55 INFO - 'LANG': 'en_US.UTF-8', 15:05:55 INFO - 'LANGUAGE': 'en_US:en', 15:05:55 INFO - 'LOGNAME': 'cltbld', 15:05:55 INFO - 'MAIL': '/var/mail/cltbld', 15:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:55 INFO - 'MOZ_NO_REMOTE': '1', 15:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:55 INFO - 'NO_EM_RESTART': '1', 15:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:55 INFO - 'PWD': '/builds/slave/test', 15:05:55 INFO - 'SHELL': '/bin/bash', 15:05:55 INFO - 'SHLVL': '1', 15:05:55 INFO - 'TERM': 'linux', 15:05:55 INFO - 'TMOUT': '86400', 15:05:55 INFO - 'USER': 'cltbld', 15:05:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:55 INFO - '_': '/tools/buildbot/bin/python'} 15:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:55 INFO - Running setup.py (path:/tmp/pip-6Kntg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:55 INFO - Running setup.py (path:/tmp/pip-4R8wFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:55 INFO - Running setup.py (path:/tmp/pip-CUdjz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:56 INFO - Running setup.py (path:/tmp/pip-cFjKWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:56 INFO - Running setup.py (path:/tmp/pip-TuXwWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:56 INFO - Running setup.py (path:/tmp/pip-_rck4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:56 INFO - Running setup.py (path:/tmp/pip-Btbz5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:56 INFO - Running setup.py (path:/tmp/pip-TFt9_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:56 INFO - Running setup.py (path:/tmp/pip-2bgwkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:56 INFO - Running setup.py (path:/tmp/pip-zkImXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:56 INFO - Running setup.py (path:/tmp/pip-IixCpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:56 INFO - Running setup.py (path:/tmp/pip-RgPm4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:56 INFO - Running setup.py (path:/tmp/pip-U831N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:56 INFO - Running setup.py (path:/tmp/pip-sYOFFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:56 INFO - Running setup.py (path:/tmp/pip-KrhSmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:56 INFO - Running setup.py (path:/tmp/pip-UVWvQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:56 INFO - Running setup.py (path:/tmp/pip-wsIWcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:57 INFO - Running setup.py install for manifestparser 15:05:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Running setup.py install for mozcrash 15:05:57 INFO - Running setup.py install for mozdebug 15:05:57 INFO - Running setup.py install for mozdevice 15:05:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Running setup.py install for mozfile 15:05:57 INFO - Running setup.py install for mozhttpd 15:05:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Running setup.py install for mozinfo 15:05:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Running setup.py install for mozInstall 15:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:57 INFO - Running setup.py install for mozleak 15:05:57 INFO - Running setup.py install for mozlog 15:05:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for moznetwork 15:05:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozprocess 15:05:58 INFO - Running setup.py install for mozprofile 15:05:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozrunner 15:05:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozscreenshot 15:05:58 INFO - Running setup.py install for moztest 15:05:58 INFO - Running setup.py install for mozversion 15:05:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:58 INFO - Cleaning up... 15:05:58 INFO - Return code: 0 15:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:58 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')]} 15:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 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')]} 15:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:58 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:05:58 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 15:05:58 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 15:05:58 INFO - Using env: {'DISPLAY': ':0', 15:05:58 INFO - 'HOME': '/home/cltbld', 15:05:58 INFO - 'LANG': 'en_US.UTF-8', 15:05:58 INFO - 'LANGUAGE': 'en_US:en', 15:05:58 INFO - 'LOGNAME': 'cltbld', 15:05:58 INFO - 'MAIL': '/var/mail/cltbld', 15:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:58 INFO - 'MOZ_NO_REMOTE': '1', 15:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:58 INFO - 'NO_EM_RESTART': '1', 15:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:58 INFO - 'PWD': '/builds/slave/test', 15:05:58 INFO - 'SHELL': '/bin/bash', 15:05:58 INFO - 'SHLVL': '1', 15:05:58 INFO - 'TERM': 'linux', 15:05:58 INFO - 'TMOUT': '86400', 15:05:58 INFO - 'USER': 'cltbld', 15:05:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:58 INFO - '_': '/tools/buildbot/bin/python'} 15:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:59 INFO - Running setup.py (path:/tmp/pip-nvuHct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:59 INFO - Running setup.py (path:/tmp/pip-Q5XIHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:59 INFO - Running setup.py (path:/tmp/pip-ZLYoFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:59 INFO - Running setup.py (path:/tmp/pip-z67pyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:59 INFO - Running setup.py (path:/tmp/pip-lTaExZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:59 INFO - Running setup.py (path:/tmp/pip-ehzMiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:59 INFO - Running setup.py (path:/tmp/pip-hfp0pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:59 INFO - Running setup.py (path:/tmp/pip-tHNDoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:59 INFO - Running setup.py (path:/tmp/pip-_F2jWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:59 INFO - Running setup.py (path:/tmp/pip-NQ1xQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:59 INFO - Running setup.py (path:/tmp/pip-jPd1yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:59 INFO - Running setup.py (path:/tmp/pip-NWmfy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:59 INFO - Running setup.py (path:/tmp/pip-4ys98u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:59 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)) 15:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:00 INFO - Running setup.py (path:/tmp/pip-1DRq2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:00 INFO - Running setup.py (path:/tmp/pip-Ga62zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:00 INFO - Running setup.py (path:/tmp/pip-Whdwca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:00 INFO - Running setup.py (path:/tmp/pip-AVVVtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:06:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:02 INFO - Downloading blessings-1.6.tar.gz 15:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:02 INFO - Installing collected packages: blessings 15:06:02 INFO - Running setup.py install for blessings 15:06:02 INFO - Successfully installed blessings 15:06:02 INFO - Cleaning up... 15:06:02 INFO - Return code: 0 15:06:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:02 INFO - Reading from file tmpfile_stdout 15:06:02 INFO - Current package versions: 15:06:02 INFO - argparse == 1.2.1 15:06:02 INFO - blessings == 1.6 15:06:02 INFO - blobuploader == 1.2.4 15:06:02 INFO - docopt == 0.6.1 15:06:02 INFO - manifestparser == 1.1 15:06:02 INFO - mozInstall == 1.12 15:06:02 INFO - mozcrash == 0.17 15:06:02 INFO - mozdebug == 0.1 15:06:02 INFO - mozdevice == 0.48 15:06:02 INFO - mozfile == 1.2 15:06:02 INFO - mozhttpd == 0.7 15:06:02 INFO - mozinfo == 0.9 15:06:02 INFO - mozleak == 0.1 15:06:02 INFO - mozlog == 3.2 15:06:02 INFO - moznetwork == 0.27 15:06:02 INFO - mozprocess == 0.22 15:06:02 INFO - mozprofile == 0.28 15:06:02 INFO - mozrunner == 6.11 15:06:02 INFO - mozscreenshot == 0.1 15:06:02 INFO - mozsystemmonitor == 0.3 15:06:02 INFO - moztest == 0.7 15:06:02 INFO - mozversion == 1.4 15:06:02 INFO - psutil == 3.1.1 15:06:02 INFO - requests == 1.2.3 15:06:02 INFO - wsgiref == 0.1.2 15:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:02 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')]} 15:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:02 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')]} 15:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:02 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:06:02 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 15:06:02 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 15:06:02 INFO - Using env: {'DISPLAY': ':0', 15:06:02 INFO - 'HOME': '/home/cltbld', 15:06:02 INFO - 'LANG': 'en_US.UTF-8', 15:06:02 INFO - 'LANGUAGE': 'en_US:en', 15:06:02 INFO - 'LOGNAME': 'cltbld', 15:06:02 INFO - 'MAIL': '/var/mail/cltbld', 15:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:02 INFO - 'MOZ_NO_REMOTE': '1', 15:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:02 INFO - 'NO_EM_RESTART': '1', 15:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:02 INFO - 'PWD': '/builds/slave/test', 15:06:02 INFO - 'SHELL': '/bin/bash', 15:06:02 INFO - 'SHLVL': '1', 15:06:02 INFO - 'TERM': 'linux', 15:06:02 INFO - 'TMOUT': '86400', 15:06:02 INFO - 'USER': 'cltbld', 15:06:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:02 INFO - '_': '/tools/buildbot/bin/python'} 15:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 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)) 15:06:02 INFO - Cleaning up... 15:06:02 INFO - Return code: 0 15:06:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:02 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')]} 15:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:02 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')]} 15:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:02 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 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:06:02 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 15:06:02 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 15:06:02 INFO - Using env: {'DISPLAY': ':0', 15:06:02 INFO - 'HOME': '/home/cltbld', 15:06:02 INFO - 'LANG': 'en_US.UTF-8', 15:06:02 INFO - 'LANGUAGE': 'en_US:en', 15:06:02 INFO - 'LOGNAME': 'cltbld', 15:06:02 INFO - 'MAIL': '/var/mail/cltbld', 15:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:02 INFO - 'MOZ_NO_REMOTE': '1', 15:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:02 INFO - 'NO_EM_RESTART': '1', 15:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:02 INFO - 'PWD': '/builds/slave/test', 15:06:02 INFO - 'SHELL': '/bin/bash', 15:06:02 INFO - 'SHLVL': '1', 15:06:02 INFO - 'TERM': 'linux', 15:06:02 INFO - 'TMOUT': '86400', 15:06:02 INFO - 'USER': 'cltbld', 15:06:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:02 INFO - '_': '/tools/buildbot/bin/python'} 15:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:03 INFO - Downloading/unpacking jsonschema 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:06:04 INFO - Downloading/unpacking functools32 (from jsonschema) 15:06:04 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 15:06:04 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 15:06:04 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 15:06:04 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 15:06:04 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 15:06:04 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 15:06:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:06:05 INFO - warning: no files found matching '*.txt' 15:06:05 INFO - no previously-included directories found matching 'build' 15:06:05 INFO - no previously-included directories found matching 'dist' 15:06:05 INFO - no previously-included directories found matching '.git*' 15:06:05 INFO - Installing collected packages: jsonschema, functools32 15:06:05 INFO - Running setup.py install for functools32 15:06:05 INFO - warning: no files found matching '*.txt' 15:06:05 INFO - no previously-included directories found matching 'build' 15:06:05 INFO - no previously-included directories found matching 'dist' 15:06:05 INFO - no previously-included directories found matching '.git*' 15:06:05 INFO - Successfully installed jsonschema functools32 15:06:05 INFO - Cleaning up... 15:06:05 INFO - Return code: 0 15:06:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46f8fd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', '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 15:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:06:05 INFO - Using env: {'DISPLAY': ':0', 15:06:05 INFO - 'HOME': '/home/cltbld', 15:06:05 INFO - 'LANG': 'en_US.UTF-8', 15:06:05 INFO - 'LANGUAGE': 'en_US:en', 15:06:05 INFO - 'LOGNAME': 'cltbld', 15:06:05 INFO - 'MAIL': '/var/mail/cltbld', 15:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:05 INFO - 'MOZ_NO_REMOTE': '1', 15:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:05 INFO - 'NO_EM_RESTART': '1', 15:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:05 INFO - 'PWD': '/builds/slave/test', 15:06:05 INFO - 'SHELL': '/bin/bash', 15:06:05 INFO - 'SHLVL': '1', 15:06:05 INFO - 'TERM': 'linux', 15:06:05 INFO - 'TMOUT': '86400', 15:06:05 INFO - 'USER': 'cltbld', 15:06:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:05 INFO - '_': '/tools/buildbot/bin/python'} 15:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:05 INFO - Downloading/unpacking flake8 15:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:06:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:06:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:06:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:08 INFO - no previously-included directories found matching 'docs/_build' 15:06:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:06:08 INFO - Running setup.py install for pep8 15:06:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:08 INFO - no previously-included directories found matching 'docs/_build' 15:06:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:06:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:06:08 INFO - Cleaning up... 15:06:08 INFO - Return code: 0 15:06:08 INFO - Running post-action listener: _resource_record_post_action 15:06:08 INFO - Running post-action listener: _start_resource_monitoring 15:06:08 INFO - Starting resource monitoring. 15:06:08 INFO - ##### 15:06:08 INFO - ##### Finished create-virtualenv step (success) 15:06:08 INFO - ##### 15:06:08 INFO - ##### 15:06:08 INFO - ##### Running install step. 15:06:08 INFO - ##### 15:06:08 INFO - Running pre-action listener: _resource_record_pre_action 15:06:08 INFO - Running main action method: install 15:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:08 INFO - Reading from file tmpfile_stdout 15:06:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:08 INFO - Reading from file tmpfile_stdout 15:06:08 INFO - Output received: 15:06:08 INFO - Usage: mozinstall [options] installer 15:06:08 INFO - Options: 15:06:08 INFO - -h, --help show this help message and exit 15:06:08 INFO - -d DEST, --destination=DEST 15:06:08 INFO - Directory to install application into. [default: 15:06:08 INFO - "/builds/slave/test"] 15:06:08 INFO - --app=APP Application being installed. [default: firefox] 15:06:08 INFO - mkdir: /builds/slave/test/build/application 15:06:08 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'] 15:06:08 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 15:06:27 INFO - Reading from file tmpfile_stdout 15:06:27 INFO - Output received: 15:06:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:27 INFO - Running post-action listener: _resource_record_post_action 15:06:27 INFO - ##### 15:06:27 INFO - ##### Finished install step (success) 15:06:27 INFO - ##### 15:06:27 INFO - ##### 15:06:27 INFO - ##### Running run-tests step. 15:06:27 INFO - ##### 15:06:27 INFO - Running pre-action listener: _resource_record_pre_action 15:06:27 INFO - Running main action method: run_tests 15:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:27 INFO - Python 2.7.3 15:06:27 INFO - Return code: 0 15:06:27 INFO - grabbing minidump binary from tooltool 15:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:27 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 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:27 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 15:06:27 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 15:06:27 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 15:06:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:27 INFO - Return code: 0 15:06:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:06:28 INFO - Return code: 0 15:06:28 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/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 15:06:28 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/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 15:06:28 INFO - Using env: {'DISPLAY': ':0', 15:06:28 INFO - 'HOME': '/home/cltbld', 15:06:28 INFO - 'LANG': 'en_US.UTF-8', 15:06:28 INFO - 'LANGUAGE': 'en_US:en', 15:06:28 INFO - 'LOGNAME': 'cltbld', 15:06:28 INFO - 'MAIL': '/var/mail/cltbld', 15:06:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:28 INFO - 'MOZ_NO_REMOTE': '1', 15:06:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:28 INFO - 'NO_EM_RESTART': '1', 15:06:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:28 INFO - 'PWD': '/builds/slave/test', 15:06:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:28 INFO - 'SHELL': '/bin/bash', 15:06:28 INFO - 'SHLVL': '1', 15:06:28 INFO - 'TERM': 'linux', 15:06:28 INFO - 'TMOUT': '86400', 15:06:28 INFO - 'USER': 'cltbld', 15:06:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1464905132.154532-832153689', 15:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:28 INFO - '_': '/tools/buildbot/bin/python'} 15:06:28 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/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 15:06:28 INFO - mozversion application_buildid: 20160602132435 15:06:28 INFO - mozversion application_changeset: 28e5f7d006ddb08850ee04a6b22178376c8797c4 15:06:28 INFO - mozversion application_display_name: Nightly 15:06:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:28 INFO - mozversion application_name: Firefox 15:06:28 INFO - mozversion application_remotingname: firefox 15:06:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:28 INFO - mozversion application_vendor: Mozilla 15:06:28 INFO - mozversion application_version: 49.0a1 15:06:28 INFO - mozversion platform_buildid: 20160602132435 15:06:28 INFO - mozversion platform_changeset: 28e5f7d006ddb08850ee04a6b22178376c8797c4 15:06:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:28 INFO - mozversion platform_version: 49.0a1 15:06:28 INFO - using testdate: 1464905188 15:06:28 INFO - actual date: 1464905188 15:06:28 INFO - starting webserver on 'localhost:38912' 15:06:28 INFO - SUITE-START | Running 2 tests 15:06:28 INFO - TEST-START | dromaeo_css 15:06:28 INFO - operating with platform_type : linux_ 15:06:28 INFO - Initialising browser for dromaeo_css test... 15:06:28 INFO - TEST-INFO | started process 26951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp634jju/profile http://localhost:38912/getInfo.html) 15:06:33 INFO - PROCESS | 26951 | __metrics Screen width/height:1600/1200 15:06:33 INFO - PROCESS | 26951 | colorDepth:24 15:06:33 INFO - PROCESS | 26951 | Browser inner width/height: 1024/697 15:06:33 INFO - PROCESS | 26951 | __metrics 15:06:34 ERROR - PROCESS | 26951 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:06:35 INFO - TEST-INFO | 26951: exit 0 15:06:35 INFO - Browser initialized. 15:06:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:35 INFO - TEST-INFO | started process 27033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp634jju/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:47 INFO - PROCESS | 27033 | RSS: Main: 157597696 15:06:47 INFO - PROCESS | 27033 | 15:07:39 INFO - PROCESS | 27033 | 1464905259314 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:09:51 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38912/tests/dromaeo/cssquery-ext.html) 15:09:52 INFO - PROCESS | 27033 | RSS: Main: 263118848 15:09:52 INFO - PROCESS | 27033 | 15:12:54 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-ext.html (next: http://localhost:38912/tests/dromaeo/cssquery-jquery.html) 15:12:55 INFO - PROCESS | 27033 | RSS: Main: 234799104 15:12:55 INFO - PROCESS | 27033 | 15:15:57 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38912/tests/dromaeo/cssquery-mootools.html) 15:15:58 INFO - PROCESS | 27033 | RSS: Main: 241610752 15:15:58 INFO - PROCESS | 27033 | 15:19:00 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38912/tests/dromaeo/cssquery-prototype.html) 15:19:01 INFO - PROCESS | 27033 | RSS: Main: 235835392 15:19:01 INFO - PROCESS | 27033 | 15:22:04 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38912/tests/dromaeo/cssquery-yui.html) 15:22:04 INFO - PROCESS | 27033 | RSS: Main: 227233792 15:22:04 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | Cycle 1(1): loaded http://localhost:38912/tests/dromaeo/cssquery-yui.html (next: http://localhost:38912/tests/dromaeo/cssquery-dojo.html) 15:25:07 INFO - PROCESS | 27033 | RSS: Main: 278872064 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | __start_tp_report 15:25:07 INFO - PROCESS | 27033 | _x_x_mozilla_page_load 15:25:07 INFO - PROCESS | 27033 | _x_x_mozilla_page_load_details 15:25:07 INFO - PROCESS | 27033 | |i|pagename|runs| 15:25:07 INFO - PROCESS | 27033 | |0;dojo.html;2699.6625421822273;2728.0997270900607;2742.9177124686266;2759.365345970428;2783.902563410281;4577.404937358147;4633.675642705012;4797.088553174899;4893.266010098487;4926.876828079296;4687.953120468795;4709.270063140219;4717.056588682269;4794.760261986904;4796.520347965202;4377.627901628357;4408.691391602589;4409.955900441003;4473.597376236138;4479.08178823342;4460.241758900995;4536.410266665329;4594.793234304448;4625.838095666652;4641.2109941310055;4265.9786701066605;4445.310976798602;4483.215437298476;4500.392447019643;4502.8874278142985;4307.030918043447;4352.825886964518;4373.628241599468;4385.627221686161;4396.274614688573;4360.825566977317;4409.360642706822;4419.049904270597;4429.977850110761;4464.308032255006;4577.427821522309;4687.859364219044;4719.10337035962;4752.9762351188365;4770.332153498478;5058.114829904789;5135.152699804565;5159.432462429129;5225.451327610622;5231.843044708665;5206.973965130188;5243.370795504526;5247.291615631879;5270.130428479296;5278.366596008465;4671.5328467153695;4795.040991801654;4902.950970490321;4912.189488734319;4917.188663870421;5312;5340.946590534123;5411.702356370359;5417.620766546383;5420.457954204627;5133.050385678662;5173.767180476888;5188.092083885305;5189.247559103985;5189.532942035235;4987.80048798044;5064.392272927273;5131.820386286462;5224.9738751306;5269.394019687708;5068.974655126774;5087.465816089331;5094.15946368845;5125.436202017775;5133.101707201299;5113.642045056885;5115.053715062651;5117.309163262987;5119.180931051014;5147.382314122255;4201.7268877522865;4249.97875010623;4250.256205164084;4284.078923031563;4374.737515749065;3771.41543060826;3808.5620153682125;3821.044738815296;3846.942295865564;3910.7458015228917;4473.6868419211;4474.977625111854;4482.305242687388;4513;4525.185466615975;4967.90064198714;5181.4559471255725;5199.63602547818;5209.453007434165;5247.344081989751;4349.325854492558;4428.689991700615;4431.911361772746;4445.088756804847;4511.684182107287;4683.274092515666;4693.131770622445;4695.5304469552775;4701.835435759732;4739.265413860857;4823.27650852375;4825.9758701206265;4827.662063655581;4835.661503694708;4846.830360937421;4874.5856602189215;5067.797288108434;5133.56364708989;5138.614603904797;5142.125838607521;4807.351007613927;4833.975830120827;4862.781174847211;4864.051509955525;4912.189488734319;4905.681130726492;5129.051125541787;5137.51193636604;5140.768665409991;5182.818601348935;5028.296038554532;5108.003939231814;5112.79548818058;5114.360704911886;5148.897022059613;4988.201887697951;4991.450940396481;4994.5754610858485;4997.150484417585;5043.672161309503;4871.902561948812;4915.311856340044;4926.630502712239;4942.950570494249;4986.750662466935;4929.728864912464;4999.500049994971;5030.446650868328;5031.4213865405945;5047.848564543069;5094.057599344133;5097.337346144977;5100.515451032146;5138.486151384981;5145.253938179018;4724.385829842098;4869.683470574401;4946.480619534897;4976;5039.571636410946 15:25:07 INFO - PROCESS | 27033 | |1;ext.html;550.1325680466323;587.421389930918;595.407569468379;597.074534471569;602.126915971841;27796.722032779668;40106.79412632304;41334.58665413345;41426.99999999996;45190.77404612972;42053.158936821324;42728.78635606817;42824.14351712972;42837.357439638356;42890.78554607223;7683.078030636318;7870.606469676522;7872.212778722139;7874.212578742108;7881.802954926144;7633.465657403984;7721.922780772176;7765.301122898938;7769.261920117579;7771.727989520368;7763.767086987399;7812.921870781276;7813.062432508107;7813.921860781376;7818.218178182193;7739.458237923348;7772.7668169954995;7785.18255583167;7786.377089832799;7789.104253010892;7719.536827790351;7809.960950195213;7811.882821757678;7813.453058285922;7815.726449574295;36205.27589448223;36706;36749.63250367489;36769.08077298089;36773.63226367729;2917.5769513420646;3037.9240518987203;3122.3443076953868;3264.42872497312;3412.368711788327;29948.85025574858;30151.698483015327;30171.245718856986;30504;30637.540436893465;3549.8225088745717;3550.8757193498104;3556.751027428081;3587.0673624857463;3655.3785856404475;254743;254964.99999999814;255034;255830;255947;52218.47781522212;52826.73586632042;52877.471225287256;52879.73560132175;52982.73508632509;33814.32371352559;34715;34769;36411.4538281926;36557;15081.396744130112;15146;15212.543623691306;15219.543413697607;15221.162836043903;11164.776704466027;11195.216334856645;11203.831942520868;11207.943960280147;11212.327260364242;18913.43259702211;18960.336388226347;18966;18983.62032759337;18984.14571344293;6915.204751453547;6984.996451525893;7010.404115650227;7110.1112360954885;7277.8544429111125;837.2590257621927;895.5696515689797;947.3226642950324;1020.3724709303725;1054.625607909181;27705.168844934684;28034.71965280321;28453.85773071163;28809.559522023814;28939.42121157565;801.3669201330999;979.2753362511833;992.2954702161546;1008.3949630221808;1073.4525392049954;14557.417703291962;15063.563446151933;15194.544163675107;15206;15466.072035677895;403598;404716;405546;407972;408059;49851.75074124679;50320;50329.24506132411;50348.49651503438;50569.74715126401;1109.7447587055024;1169.4036041618835;1184.8341232227494;1197.2517176764522;1204.9277043377426;28631.42737145204;29630.259243519085;29671.55492667655;29689.406211875208;29966.25084372908;43342.566574333854;43736.56263437325;43893.78053109714;43917.560824391345;43959.78020109879;308642;312539;313460;313783;374379;24628.753712463364;25229;25281;26471.60292595574;27098.593521096805;42799.57200427956;43468;43989.34015989699;44092;44194;36203.27593448169;37236.25527489381;37377.43933841049;37497.25005499929;37639.43540846944;37010.8149459251;37299;37396.06509837167;37652.623473766005;38089.238215236095;36244.818775907006;36386.8180659095;36389.45415818818;37280;37395.43906841345;31130;32954.83522582372;33267.33465330728;33282.5007624881;33307.50038749469;25250.621240681772;25912.22263332103;25913.6112958302;26080.625269320106;26342 15:25:07 INFO - PROCESS | 27033 | |2;jquery.html;365.71656965851463;367.746255083992;369.2762186115214;379.84046700385835;389.384772060145;15628.453004144858;16726.498205053867;16934.83065169348;17292.308307667678;17455.563610909718;15921.442749503769;16338.509844704648;16866.494005179833;17038.48884533463;17063.232154553043;4989.550940415371;5152.562032227265;5155.252488389181;5184.792608295664;5198.45416231296;3676.117731744389;3838;5109.897802043957;5748.45389687979;6098.756049758004;6116.938830611703;6121.816345509642;6126.509879209675;6146.446819786218;6148.169997050408;5856.76572937082;6012.068129439944;6046.606970546901;6103.42017508336;6108.877822443571;3337.1823903143886;5003.17447621142;5206.661566998133;5325;5328.254044433782;19486.51283717904;20115.899420502803;20126.899365503225;20201.393958181277;20270.69593956092;1921.5100149461937;2042.4995876010473;2139.5720855828895;2483.8509689418693;2544.9745502545106;12968.740625187444;13023;13059.085863989525;13148.86851131486;13519.121257118255;1723.5432610358266;1725.1374312843577;1731.89608623483;1801.1534578747967;1825.178669598686;62232.377676223565;63340.36659633391;65126.348736512504;65533.67233163851;65931.67034164847;9410.482423466638;9462.195713364303;9476.526173691287;9647;9794.069563391466;13068.477260909647;13191.538296159588;13192.472301107848;13195.934020329836;13218;7377.594232317274;7469.253074692596;7542.811429714301;7620.008894174324;7639.236076392316;7262;7320.780376588711;7363.337299642951;7452.217517160729;7487.887681684779;5658.387359602576;5735.340435849931;5767.22142510764;5838.562107841929;5839.270091238595;1583.8812089093365;1722.1647500962024;1722.6899158151402;1739.0348356662173;1763.8324359185856;638.3594163001043;892.5849479991705;905.3571963905569;925.9674565797069;963.5326866469757;16031;16870.15649217534;16981.660366792596;17008.48974530766;17557.736633950502;422.3390394033389;427.36962979604834;430.5651292194906;436.57215928390355;446.9307257375112;5346.759395827197;5679.261695979496;5718.914216286759;5822.737976791054;6067.666278354644;370062;373755;374767;377797;377851;73185;74877.6256118716;76489;76932.46135077268;77185.61407193041;431.0387835127683;438.6162108155364;439.4484921423657;442.690116918165;442.86049894283195;9606.759831004281;9913.256505762241;10115.291929564859;10207.693769186937;10210.438425886647;34908.301833963684;35149.47275790814;35166.648333516336;35315.470267945486;36270.45594316035;46806.06387872292;47869;49346;49401;49644.00711985812;7293.781186564412;7300.96349518249;7313.813269204954;7461.030066091374;7473.252674732484;6232.189815323979;7622.428317876293;10652.414117223318;11044.701656356208;11366.659000230007;5986.305056364686;8977.23693486061;9844.9015509844;10053.849192261976;10114.089731923868;9540.618375265189;9849.064338887794;9970.750731231778;10050.949745251228;10079.596816127567;9990.150837178631;10149.289549731744;10160.136388407069;10167.898321016992;10268.64059757905;7654.770356889302;7709.845803084019;7857.842843143219;7941.292622086279;8005.3995950305125;7886.0536735592095;10025.899741002497;10081.546330415002;10184.694459166238;10279.743006424898 15:25:07 INFO - PROCESS | 27033 | |3;mootools.html;1250.206119114362;1372.684282614999;1402.901796874219;1516.257034053314;1751.7635119258905;6484.2867284598715;7305.379042781364;7551.207123252062;7551.433642476823;7589.924100758998;7339.339459448649;7360.116785985676;7418;7418.406527477802;7428.145763237229;1793.6412717456496;1994.2920263306535;2088.4883203615136;2111.524906895944;2111.936641900738;2119.290037837319;2167.2631305356176;2168.7831216878344;2169.533550286688;2171.5439757650834;2077.044559502631;2091.341227513336;2100.5378816660386;2120.7773183815707;2132.402927180392;1756.8506676932477;1927.9036048197675;1983.831374333169;2039.3881835449306;2074.4191626344646;2096.2139197800825;2114.873107613548;2118.120979793384;2120.416885356524;2120.4910821402905;7180.28197180283;7197.820054498679;7226.855462890765;7242.13094428672;7247.818804529877;4221.641160501361;4364.214441400547;4371.34429835524;4372.366006928977;4374.803133858984;2808.1154436352485;2871.6697579778383;2910.4033673096965;2911.883524659011;2938.6179796626516;884.4030279561271;906.2478143141177;913.8766266553996;944.3719926249105;959.94720290384;9701.854472182922;9709.786276715482;9735.26985476085;9758.268129890215;9769.267304952085;4022.939655905164;4027.677785777131;4175.665946724254;4183.372494125905;4185.204811085884;8477.237048665527;8535.189157030072;8557.743267701979;8594.269487093667;8598.87101693475;4473.261911784519;4474.709143905636;4477.574630410106;4481.708688935209;4482.350059241392;3585.372559802024;4021.959780402217;4031.657309128757;4110.116324990141;4131.5248746393945;3546.8758593449106;3562.109472631842;3645.7265705071695;3665.8533658653887;3676.669099780979;1146.8623765148236;1148.494662348564;1155.2086820527966;1162.3026184289529;1162.8720840707515;819.4018366592421;846.5090247656468;851.748734123435;856.5674334461182;875.0593112404191;4976.778342330933;4981.178105612606;5003.574696150868;5068.797248110034;5090.949090509122;408.9795510224477;423.6187431311844;428.27621319969154;431.47144747683836;445.2541992163114;3648.416253399443;3655.94516082259;3664.193877346979;3706.9258614827554;3720.720945929066;8581.356398270154;9005;9067.04795996411;9101.135392137736;9105.089491050974;8968.820623587491;9009.369344145847;9013.459192448343;9017.954910225408;9025.097490251053;6841.076454678555;6899.586024838526;6978.79063628092;6980;6985.965070174719;5173.586113110867;5187.403448603459;5219.608529360389;5330.413654497925;5342.3856256531;8220.219079187467;8324.791880203044;8407.2433480987;8413.411061225655;8421.410501265098;8071.152528984372;8330.208630180123;8346.332293416634;8431.072582015851;8447.831043378976;5639.351474580476;6276.529260305587;6390.073439351361;6451.645159516272;6494.318096599789;7283.126024877049;7284.053073100463;7350.632468376667;7353.080864891888;7359.337659610661;6363.90454143179;6535.5425120241125;6630.867382652416;6674.399304062657;6736.326367363225;6366.427021568081;6425.518086143651;6441.194850643669;6556.3443655634055;6575.80272591823;5913.231279933581;6057.7879774207695;6191.504679625709;6203.472704820141;6208.4722798562625;4323.632491238154;4405.40527028847;4406.73559586413;4453.376527286117;4534.093181363806;4489.865304040884;4537.410136682211;4578.65660075489;4612.354270402079;4639.327297541905 15:25:07 INFO - PROCESS | 27033 | |4;prototype.html;300.66325715198974;304.8993832035428;305.92963618367776;310.19194997032713;311.63538659768057;4865.708057516547;4963.205887058071;4988.451270360258;4994;5009.69941803492;4819.614430845532;4868.805247790084;4884.192848645997;4886;4898.338724272231;3645.65366290202;3699.4820725098375;3754.3242216401036;3823.101571130782;3848.633735024054;3816.732828701992;3828.636279553438;3837.712171587128;3850.7497012694225;3881.7282790204695;3639.763415378005;3809.580946095927;3815.866444674437;3817;3819.178876541543;3715.9628403716024;3830.7701537907815;3848.692104631623;3855.1302618230134;3857.2092720992127;3346.7991920484847;3393.2025973896116;3404.4552871540436;3408.5739282589675;3415.624281329052;4662.344867571997;4676.181668208084;4677.4564393750325;4697.224957881946;4713.622910167179;4234.661227101825;4318.762468064255;4337.696361254713;4344.6089851913475;4369.497507786582;5092.974535127338;5102.668326558799;5108.693478391308;5128.922786271566;5129.897402051938;3702.648248416396;3704.2221133561984;3714.439935227211;3718.4050551911564;3736.532933383327;5187.429382767892;5310.9734451327495;5333.173358129496;5348.893022139574;5358.732063396854;3790.374588192917;3796.5823759387;3800.9049773755323;3827.2154208387215;3832.003679043413;3855.3445914194654;3862.3820188769664;3873.767573945572;3880.1269714314053;3889.1638297766117;4253.851115211015;4386.210482113251;4397.208502469586;4413.867583972486;4430.113977204572;5036.496350364934;5051.949480505222;5057.595392368602;5085.466026067284;5102.9489705103215;1286.459686931491;1309.8821106100497;1315.684235783405;1319.590926812672;1320.1682939747898;863.935204859638;866.0170706248454;894.9776255593532;919.4391421233042;919.5723988345318;4469.843555475542;4491.820327186876;4492.438445194351;4501.051811063759;4537.115262523842;5228.477152284741;5236.9738151309;5250.868728281824;5266.7629956652045;5273.31446911899;4342.392065110887;4514.480834704051;4521.706089104197;4546.204414227497;4618.35343051973;2829.3872492678975;2872.669642991041;2889.3787835615444;2892.8842846286334;2894.7105289471306;5053.747312634354;5062.6080526047635;5064.82273120439;5089.592832573385;5090.490950904954;5378.650387724863;5489;5491.697956612425;5503.2020357048805;5582.888342233133;5006.121480148929;5007.574356179693;5017.54842064216;5036.798528058836;5056.544910958031;5312.256284120149;5350.7324633767375;5357.651752636066;5402.540784033401;5405.999890020359;5021;5215.869603259797;5235.397929238186;5248.422673505987;5250.606204534599;4960.255961605788;4981;4991.951690144965;4996.150654388835;5006.199008158677;3699.075231192202;3710.5176327077306;3720.2001569662652;3737.2151848112203;3745;5035.546800787946;5291.4443983382735;5353.170258609922;5353.705546194841;5364.865878353073;5138.588912886886;5148.742562871917;5152.355955505562;5162.535371816554;5201.661891977009;5183.81856635016;5198.766055527586;5201.947980520146;5207.661502002357;5226.372835259793;4807.735574543294;4834.734089625104;5075.644704870623;5089.7709603067215;5125.282460455614;5072.898542029213;5075.314832497713;5092.014114495276;5092.821751238837;5126.128558145198;4968.801247950041;5101.92347114801;5105.259737337991;5119.180931051014;5121.692698438105 15:25:07 INFO - PROCESS | 27033 | |5;yui.html;609.9664518451483;614.6066517428845;628.8647940692753;727.9272072792718;749.3330935467433;12656.303903285316;13537.187768733871;13557.32213389329;13573.253471059112;13578.049536532446;11383.487743051563;12579.937100314508;12601.495940162382;12641.55754548591;12645.114841961044;803.7910143362739;809.7570728781371;811.5860910935436;812.6099472253322;813.2477458351032;817.358373676664;819.9877001844977;820.4748960665179;821.7124006597672;821.9054808697017;856.9143085691412;858.4248553469159;859.6948083430386;859.70769938221;862.5902696219308;854.7179430787825;856.7087190355278;856.7943693513574;857.1171693156091;857.1942374168262;622.0886401421893;628.1708145248274;629.0469938043867;629.1192330737005;629.2731894661673;11685.182037257395;11753;11781.234219775688;11783.646490605295;11800.527978880835;10629.893701062967;10688.679339619825;10802.837957430565;11094.778104437946;11243.662690119229;8265.504069755774;8316.168383161636;8423.284020858235;8424;10011.79976400468;4160.646345060643;4183.895402614929;4221.324588065895;4332.198543269474;4361.302191649321;40517.79741101305;41497.79251103755;47681.761591191826;50229.49770502321;56062;10043.347182433119;10557.841632375521;10596.629117980834;10745.355278683148;10839;18580.25678972853;18641.7203741944;18644.81355186458;18647.81352186488;18654.253829846926;6933.722651094001;7053.470989675795;7107.538010029331;7202.891956620655;7238.565686058853;3735.589085200626;3880.165764360676;3885.494885664902;3908.785016824102;3911.647951684362;3075.1082186165763;3186.187522181875;3192.7605429592872;3195.792273502215;3196.280836811699;569.5301376364433;582.8368056944063;588.5262363797099;596.8686888884439;606.6390497653977;551.9430290992784;556.5491951519282;569.8091139468324;572.0760971031754;598.0879159282042;8185.181481851886;8250.752477425687;8328.583570821434;8345.248927596545;8548.658053677907;522.5584381197882;539.5602583894114;541.7665352692967;541.983740487786;569.0610492687099;3880.185161116141;3959.3269144245546;4001.579834117434;4047.757134571876;4050.716449848482;51315.23027154596;51726.48273517292;86529.56735216283;88661.55669221612;93266;49867;63129.68435157795;64403.67798160979;74555;76733;67399;68208;68270.65864670645;70423.29576704168;71660.28339716536;7193.496455248292;7246.9129630555835;7436.702531898663;7621.923780762121;7743.6515356810205;33218.16954576155;39088.21823563569;41208.1758364837;42289.78855105828;44292;59260.70369648124;65195.34804652083;66366.66816665886;68875.3112468889;69201;10572;10707.732306692395;10865.945670271598;11096.556137754722;11285.266457680225;12228.205166664138;12348.629541113782;12478.438470268678;12720.427580758704;13207.405666745211;11909.821352679543;11953.521859125538;12247.142700010914;12402.937985310016;12789.360531973178;11863.288202707865;12440.564580239648;12638.115331926678;12699.936500317439;12706.809397858855;11016.1187105033;11495.482703278205;11504.597339093092;11670.066394688574;12258.938705306417;8809.42738721981;9146.634134634805;9161.541922903694;9220.077992200726;9470.857937131086;9303.906960930575;9661.227101831695;9664.75838104053;9692.079252471003;9897.257705672248 15:25:07 INFO - PROCESS | 27033 | __end_tp_report 15:25:07 INFO - PROCESS | 27033 | __start_cc_report 15:25:07 INFO - PROCESS | 27033 | _x_x_mozilla_cycle_collect,947 15:25:07 INFO - PROCESS | 27033 | __end_cc_report 15:25:07 INFO - PROCESS | 27033 | __startTimestamp1464906307945__endTimestamp 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | ------- Summary: start ------- 15:25:07 INFO - PROCESS | 27033 | Number of tests: 6 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#0] dojo.html Cycles:165 Average:4762.42 Median:4874.59 stddev:498.78 (10.2%) stddev-sans-first:473.34 15:25:07 INFO - PROCESS | 27033 | Values: 2699.7 2728.1 2742.9 2759.4 2783.9 4577.4 4633.7 4797.1 4893.3 4926.9 4688.0 4709.3 4717.1 4794.8 4796.5 4377.6 4408.7 4410.0 4473.6 4479.1 4460.2 4536.4 4594.8 4625.8 4641.2 4266.0 4445.3 4483.2 4500.4 4502.9 4307.0 4352.8 4373.6 4385.6 4396.3 4360.8 4409.4 4419.0 4430.0 4464.3 4577.4 4687.9 4719.1 4753.0 4770.3 5058.1 5135.2 5159.4 5225.5 5231.8 5207.0 5243.4 5247.3 5270.1 5278.4 4671.5 4795.0 4903.0 4912.2 4917.2 5312.0 5340.9 5411.7 5417.6 5420.5 5133.1 5173.8 5188.1 5189.2 5189.5 4987.8 5064.4 5131.8 5225.0 5269.4 5069.0 5087.5 5094.2 5125.4 5133.1 5113.6 5115.1 5117.3 5119.2 5147.4 4201.7 4250.0 4250.3 4284.1 4374.7 3771.4 3808.6 3821.0 3846.9 3910.7 4473.7 4475.0 4482.3 4513.0 4525.2 4967.9 5181.5 5199.6 5209.5 5247.3 4349.3 4428.7 4431.9 4445.1 4511.7 4683.3 4693.1 4695.5 4701.8 4739.3 4823.3 4826.0 4827.7 4835.7 4846.8 4874.6 5067.8 5133.6 5138.6 5142.1 4807.4 4834.0 4862.8 4864.1 4912.2 4905.7 5129.1 5137.5 5140.8 5182.8 5028.3 5108.0 5112.8 5114.4 5148.9 4988.2 4991.5 4994.6 4997.2 5043.7 4871.9 4915.3 4926.6 4943.0 4986.8 4929.7 4999.5 5030.4 5031.4 5047.8 5094.1 5097.3 5100.5 5138.5 5145.3 4724.4 4869.7 4946.5 4976.0 5039.6 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#1] ext.html Cycles:180 Average:48082.75 Median:36759.36 stddev:88171.50 (239.9%) stddev-sans-first:88346.61 15:25:07 INFO - PROCESS | 27033 | Values: 550.1 587.4 595.4 597.1 602.1 27796.7 40106.8 41334.6 41427.0 45190.8 42053.2 42728.8 42824.1 42837.4 42890.8 7683.1 7870.6 7872.2 7874.2 7881.8 7633.5 7721.9 7765.3 7769.3 7771.7 7763.8 7812.9 7813.1 7813.9 7818.2 7739.5 7772.8 7785.2 7786.4 7789.1 7719.5 7810.0 7811.9 7813.5 7815.7 36205.3 36706.0 36749.6 36769.1 36773.6 2917.6 3037.9 3122.3 3264.4 3412.4 29948.9 30151.7 30171.2 30504.0 30637.5 3549.8 3550.9 3556.8 3587.1 3655.4 254743.0 254965.0 255034.0 255830.0 255947.0 52218.5 52826.7 52877.5 52879.7 52982.7 33814.3 34715.0 34769.0 36411.5 36557.0 15081.4 15146.0 15212.5 15219.5 15221.2 11164.8 11195.2 11203.8 11207.9 11212.3 18913.4 18960.3 18966.0 18983.6 18984.1 6915.2 6985.0 7010.4 7110.1 7277.9 837.3 895.6 947.3 1020.4 1054.6 27705.2 28034.7 28453.9 28809.6 28939.4 801.4 979.3 992.3 1008.4 1073.5 14557.4 15063.6 15194.5 15206.0 15466.1 403598.0 404716.0 405546.0 407972.0 408059.0 49851.8 50320.0 50329.2 50348.5 50569.7 1109.7 1169.4 1184.8 1197.3 1204.9 28631.4 29630.3 29671.6 29689.4 29966.3 43342.6 43736.6 43893.8 43917.6 43959.8 308642.0 312539.0 313460.0 313783.0 374379.0 24628.8 25229.0 25281.0 26471.6 27098.6 42799.6 43468.0 43989.3 44092.0 44194.0 36203.3 37236.3 37377.4 37497.3 37639.4 37010.8 37299.0 37396.1 37652.6 38089.2 36244.8 36386.8 36389.5 37280.0 37395.4 31130.0 32954.8 33267.3 33282.5 33307.5 25250.6 25912.2 25913.6 26080.6 26342.0 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#2] jquery.html Cycles:180 Average:23328.09 Median:23626.50 stddev:61893.97 (262.0%) stddev-sans-first:62043.58 15:25:07 INFO - PROCESS | 27033 | Values: 365.7 367.7 369.3 379.8 389.4 15628.5 16726.5 16934.8 17292.3 17455.6 15921.4 16338.5 16866.5 17038.5 17063.2 4989.6 5152.6 5155.3 5184.8 5198.5 3676.1 3838.0 5109.9 5748.5 6098.8 6116.9 6121.8 6126.5 6146.4 6148.2 5856.8 6012.1 6046.6 6103.4 6108.9 3337.2 5003.2 5206.7 5325.0 5328.3 19486.5 20115.9 20126.9 20201.4 20270.7 1921.5 2042.5 2139.6 2483.9 2545.0 12968.7 13023.0 13059.1 13148.9 13519.1 1723.5 1725.1 1731.9 1801.2 1825.2 62232.4 63340.4 65126.3 65533.7 65931.7 9410.5 9462.2 9476.5 9647.0 9794.1 13068.5 13191.5 13192.5 13195.9 13218.0 7377.6 7469.3 7542.8 7620.0 7639.2 7262.0 7320.8 7363.3 7452.2 7487.9 5658.4 5735.3 5767.2 5838.6 5839.3 1583.9 1722.2 1722.7 1739.0 1763.8 638.4 892.6 905.4 926.0 963.5 16031.0 16870.2 16981.7 17008.5 17557.7 422.3 427.4 430.6 436.6 446.9 5346.8 5679.3 5718.9 5822.7 6067.7 370062.0 373755.0 374767.0 377797.0 377851.0 73185.0 74877.6 76489.0 76932.5 77185.6 431.0 438.6 439.4 442.7 442.9 9606.8 9913.3 10115.3 10207.7 10210.4 34908.3 35149.5 35166.6 35315.5 36270.5 46806.1 47869.0 49346.0 49401.0 49644.0 7293.8 7301.0 7313.8 7461.0 7473.3 6232.2 7622.4 10652.4 11044.7 11366.7 5986.3 8977.2 9844.9 10053.8 10114.1 9540.6 9849.1 9970.8 10050.9 10079.6 9990.2 10149.3 10160.1 10167.9 10268.6 7654.8 7709.8 7857.8 7941.3 8005.4 7886.1 10025.9 10081.5 10184.7 10279.7 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#3] mootools.html Cycles:180 Average:4891.28 Median:5180.49 stddev:2685.08 (51.8%) stddev-sans-first:2678.67 15:25:07 INFO - PROCESS | 27033 | Values: 1250.2 1372.7 1402.9 1516.3 1751.8 6484.3 7305.4 7551.2 7551.4 7589.9 7339.3 7360.1 7418.0 7418.4 7428.1 1793.6 1994.3 2088.5 2111.5 2111.9 2119.3 2167.3 2168.8 2169.5 2171.5 2077.0 2091.3 2100.5 2120.8 2132.4 1756.9 1927.9 1983.8 2039.4 2074.4 2096.2 2114.9 2118.1 2120.4 2120.5 7180.3 7197.8 7226.9 7242.1 7247.8 4221.6 4364.2 4371.3 4372.4 4374.8 2808.1 2871.7 2910.4 2911.9 2938.6 884.4 906.2 913.9 944.4 959.9 9701.9 9709.8 9735.3 9758.3 9769.3 4022.9 4027.7 4175.7 4183.4 4185.2 8477.2 8535.2 8557.7 8594.3 8598.9 4473.3 4474.7 4477.6 4481.7 4482.4 3585.4 4022.0 4031.7 4110.1 4131.5 3546.9 3562.1 3645.7 3665.9 3676.7 1146.9 1148.5 1155.2 1162.3 1162.9 819.4 846.5 851.7 856.6 875.1 4976.8 4981.2 5003.6 5068.8 5090.9 409.0 423.6 428.3 431.5 445.3 3648.4 3655.9 3664.2 3706.9 3720.7 8581.4 9005.0 9067.0 9101.1 9105.1 8968.8 9009.4 9013.5 9018.0 9025.1 6841.1 6899.6 6978.8 6980.0 6986.0 5173.6 5187.4 5219.6 5330.4 5342.4 8220.2 8324.8 8407.2 8413.4 8421.4 8071.2 8330.2 8346.3 8431.1 8447.8 5639.4 6276.5 6390.1 6451.6 6494.3 7283.1 7284.1 7350.6 7353.1 7359.3 6363.9 6535.5 6630.9 6674.4 6736.3 6366.4 6425.5 6441.2 6556.3 6575.8 5913.2 6057.8 6191.5 6203.5 6208.5 4323.6 4405.4 4406.7 4453.4 4534.1 4489.9 4537.4 4578.7 4612.4 4639.3 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#4] prototype.html Cycles:180 Average:4277.81 Median:4885.10 stddev:1238.03 (25.3%) stddev-sans-first:1204.98 15:25:07 INFO - PROCESS | 27033 | Values: 300.7 304.9 305.9 310.2 311.6 4865.7 4963.2 4988.5 4994.0 5009.7 4819.6 4868.8 4884.2 4886.0 4898.3 3645.7 3699.5 3754.3 3823.1 3848.6 3816.7 3828.6 3837.7 3850.7 3881.7 3639.8 3809.6 3815.9 3817.0 3819.2 3716.0 3830.8 3848.7 3855.1 3857.2 3346.8 3393.2 3404.5 3408.6 3415.6 4662.3 4676.2 4677.5 4697.2 4713.6 4234.7 4318.8 4337.7 4344.6 4369.5 5093.0 5102.7 5108.7 5128.9 5129.9 3702.6 3704.2 3714.4 3718.4 3736.5 5187.4 5311.0 5333.2 5348.9 5358.7 3790.4 3796.6 3800.9 3827.2 3832.0 3855.3 3862.4 3873.8 3880.1 3889.2 4253.9 4386.2 4397.2 4413.9 4430.1 5036.5 5051.9 5057.6 5085.5 5102.9 1286.5 1309.9 1315.7 1319.6 1320.2 863.9 866.0 895.0 919.4 919.6 4469.8 4491.8 4492.4 4501.1 4537.1 5228.5 5237.0 5250.9 5266.8 5273.3 4342.4 4514.5 4521.7 4546.2 4618.4 2829.4 2872.7 2889.4 2892.9 2894.7 5053.7 5062.6 5064.8 5089.6 5090.5 5378.7 5489.0 5491.7 5503.2 5582.9 5006.1 5007.6 5017.5 5036.8 5056.5 5312.3 5350.7 5357.7 5402.5 5406.0 5021.0 5215.9 5235.4 5248.4 5250.6 4960.3 4981.0 4992.0 4996.2 5006.2 3699.1 3710.5 3720.2 3737.2 3745.0 5035.5 5291.4 5353.2 5353.7 5364.9 5138.6 5148.7 5152.4 5162.5 5201.7 5183.8 5198.8 5201.9 5207.7 5226.4 4807.7 4834.7 5075.6 5089.8 5125.3 5072.9 5075.3 5092.0 5092.8 5126.1 4968.8 5101.9 5105.3 5119.2 5121.7 15:25:07 INFO - PROCESS | 27033 | 15:25:07 INFO - PROCESS | 27033 | [#5] yui.html Cycles:180 Average:15878.83 Median:541.88 stddev:21450.53 (3958.6%) stddev-sans-first:21480.06 15:25:07 INFO - PROCESS | 27033 | Values: 610.0 614.6 628.9 727.9 749.3 12656.3 13537.2 13557.3 13573.3 13578.0 11383.5 12579.9 12601.5 12641.6 12645.1 803.8 809.8 811.6 812.6 813.2 817.4 820.0 820.5 821.7 821.9 856.9 858.4 859.7 859.7 862.6 854.7 856.7 856.8 857.1 857.2 622.1 628.2 629.0 629.1 629.3 11685.2 11753.0 11781.2 11783.6 11800.5 10629.9 10688.7 10802.8 11094.8 11243.7 8265.5 8316.2 8423.3 8424.0 10011.8 4160.6 4183.9 4221.3 4332.2 4361.3 40517.8 41497.8 47681.8 50229.5 56062.0 10043.3 10557.8 10596.6 10745.4 10839.0 18580.3 18641.7 18644.8 18647.8 18654.3 6933.7 7053.5 7107.5 7202.9 7238.6 3735.6 3880.2 3885.5 3908.8 3911.6 3075.1 3186.2 3192.8 3195.8 3196.3 569.5 582.8 588.5 596.9 606.6 551.9 556.5 569.8 572.1 598.1 8185.2 8250.8 8328.6 8345.2 8548.7 522.6 539.6 541.8 542.0 569.1 3880.2 3959.3 4001.6 4047.8 4050.7 51315.2 51726.5 86529.6 88661.6 93266.0 49867.0 63129.7 64403.7 74555.0 76733.0 67399.0 68208.0 68270.7 70423.3 71660.3 7193.5 7246.9 7436.7 7621.9 7743.7 33218.2 39088.2 41208.2 42289.8 44292.0 59260.7 65195.3 66366.7 68875.3 69201.0 10572.0 10707.7 10865.9 11096.6 11285.3 12228.2 12348.6 12478.4 12720.4 13207.4 11909.8 11953.5 12247.1 12402.9 12789.4 11863.3 12440.6 12638.1 12699.9 12706.8 11016.1 11495.5 11504.6 11670.1 12258.9 8809.4 9146.6 9161.5 9220.1 9470.9 9303.9 9661.2 9664.8 9692.1 9897.3 15:25:07 INFO - PROCESS | 27033 | -------- Summary: end -------- 15:25:07 INFO - PROCESS | 27033 | 15:25:08 INFO - TEST-INFO | 27033: exit 0 15:25:08 INFO - TEST-OK | dromaeo_css | took 1120505ms 15:25:08 INFO - TEST-START | kraken 15:25:08 INFO - operating with platform_type : linux_ 15:25:08 INFO - Initialising browser for kraken test... 15:25:08 INFO - TEST-INFO | started process 27222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPUIit/profile http://localhost:38912/getInfo.html) 15:25:13 INFO - PROCESS | 27222 | __metrics Screen width/height:1600/1200 15:25:13 INFO - PROCESS | 27222 | colorDepth:24 15:25:13 INFO - PROCESS | 27222 | Browser inner width/height: 1024/697 15:25:13 INFO - PROCESS | 27222 | __metrics 15:25:14 ERROR - PROCESS | 27222 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:25:15 INFO - TEST-INFO | 27222: exit 0 15:25:15 INFO - Browser initialized. 15:25:15 INFO - Running cycle 1/1 for kraken test... 15:25:15 INFO - TEST-INFO | started process 27304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPUIit/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:27 INFO - PROCESS | 27304 | RSS: Main: 157708288 15:25:27 INFO - PROCESS | 27304 | 15:25:30 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38912/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:31 INFO - PROCESS | 27304 | RSS: Main: 216346624 15:25:31 INFO - PROCESS | 27304 | 15:25:34 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38912/tests/kraken/driver.html?testName=audio-dft) 15:25:34 INFO - PROCESS | 27304 | RSS: Main: 202559488 15:25:34 INFO - PROCESS | 27304 | 15:25:38 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38912/tests/kraken/driver.html?testName=audio-fft) 15:25:38 INFO - PROCESS | 27304 | RSS: Main: 270979072 15:25:38 INFO - PROCESS | 27304 | 15:25:40 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38912/tests/kraken/driver.html?testName=audio-oscillator) 15:25:41 INFO - PROCESS | 27304 | RSS: Main: 180776960 15:25:41 INFO - PROCESS | 27304 | 15:25:43 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:44 INFO - PROCESS | 27304 | RSS: Main: 184360960 15:25:44 INFO - PROCESS | 27304 | 15:25:47 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38912/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:48 INFO - PROCESS | 27304 | RSS: Main: 220381184 15:25:48 INFO - PROCESS | 27304 | 15:25:51 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38912/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:52 INFO - PROCESS | 27304 | RSS: Main: 217235456 15:25:52 INFO - PROCESS | 27304 | 15:25:55 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38912/tests/kraken/driver.html?testName=json-parse-financial) 15:25:55 INFO - PROCESS | 27304 | RSS: Main: 219492352 15:25:55 INFO - PROCESS | 27304 | 15:25:57 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:58 INFO - PROCESS | 27304 | RSS: Main: 208412672 15:25:58 INFO - PROCESS | 27304 | 15:25:59 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:00 INFO - PROCESS | 27304 | RSS: Main: 210694144 15:26:00 INFO - PROCESS | 27304 | 15:26:02 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:03 INFO - PROCESS | 27304 | RSS: Main: 216309760 15:26:03 INFO - PROCESS | 27304 | 15:26:06 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:06 INFO - PROCESS | 27304 | RSS: Main: 222953472 15:26:06 INFO - PROCESS | 27304 | 15:26:09 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:10 INFO - PROCESS | 27304 | RSS: Main: 220450816 15:26:10 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | Cycle 1(1): loaded http://localhost:38912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38912/tests/kraken/driver.html?testName=ai-astar) 15:26:12 INFO - PROCESS | 27304 | RSS: Main: 263323648 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | __start_tp_report 15:26:12 INFO - PROCESS | 27304 | _x_x_mozilla_page_load 15:26:12 INFO - PROCESS | 27304 | _x_x_mozilla_page_load_details 15:26:12 INFO - PROCESS | 27304 | |i|pagename|runs| 15:26:12 INFO - PROCESS | 27304 | |0;ai-astar;114;108;115;115;114;114;117;114;114;114 15:26:12 INFO - PROCESS | 27304 | |1;audio-beat-detection;165;134;134;178;130;133;160;130;197;129 15:26:12 INFO - PROCESS | 27304 | |2;audio-dft;162;162;161;161;162;162;164;162;163;161 15:26:12 INFO - PROCESS | 27304 | |3;audio-fft;76;76;77;107;75;75;74;75;105;76 15:26:12 INFO - PROCESS | 27304 | |4;audio-oscillator;84;85;111;86;84;84;119;85;84;124 15:26:12 INFO - PROCESS | 27304 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 15:26:12 INFO - PROCESS | 27304 | |6;imaging-darkroom;148;146;145;146;148;148;146;146;147;146 15:26:12 INFO - PROCESS | 27304 | |7;imaging-desaturate;96;94;95;96;96;95;95;95;95;95 15:26:12 INFO - PROCESS | 27304 | |8;json-parse-financial;65;64;64;65;66;65;65;64;63;65 15:26:12 INFO - PROCESS | 27304 | |9;json-stringify-tinderbox;65;65;65;65;65;65;75;65;72;64 15:26:12 INFO - PROCESS | 27304 | |10;stanford-crypto-aes;85;84;84;86;86;93;100;85;118;86 15:26:12 INFO - PROCESS | 27304 | |11;stanford-crypto-ccm;137;132;138;131;135;134;134;133;136;140 15:26:12 INFO - PROCESS | 27304 | |12;stanford-crypto-pbkdf2;176;170;175;180;174;175;172;173;170;170 15:26:12 INFO - PROCESS | 27304 | |13;stanford-crypto-sha256-iterative;68;68;67;68;67;68;68;71;67;65 15:26:12 INFO - PROCESS | 27304 | __end_tp_report 15:26:12 INFO - PROCESS | 27304 | __start_cc_report 15:26:12 INFO - PROCESS | 27304 | _x_x_mozilla_cycle_collect,1935 15:26:12 INFO - PROCESS | 27304 | __end_cc_report 15:26:12 INFO - PROCESS | 27304 | __startTimestamp1464906372497__endTimestamp 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | ------- Summary: start ------- 15:26:12 INFO - PROCESS | 27304 | Number of tests: 14 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:2.28 (2.0%) stddev-sans-first:2.42 15:26:12 INFO - PROCESS | 27304 | Values: 114.0 108.0 115.0 115.0 114.0 114.0 117.0 114.0 114.0 114.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:147.00 stddev:24.38 (16.6%) stddev-sans-first:25.16 15:26:12 INFO - PROCESS | 27304 | Values: 165.0 134.0 134.0 178.0 130.0 133.0 160.0 130.0 197.0 129.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 15:26:12 INFO - PROCESS | 27304 | Values: 162.0 162.0 161.0 161.0 162.0 162.0 164.0 162.0 163.0 161.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:12.89 (17.1%) stddev-sans-first:13.52 15:26:12 INFO - PROCESS | 27304 | Values: 76.0 76.0 77.0 107.0 75.0 75.0 74.0 75.0 105.0 76.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:16.45 (19.6%) stddev-sans-first:17.00 15:26:12 INFO - PROCESS | 27304 | Values: 84.0 85.0 111.0 86.0 84.0 84.0 119.0 85.0 84.0 124.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:26:12 INFO - PROCESS | 27304 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 15:26:12 INFO - PROCESS | 27304 | Values: 148.0 146.0 145.0 146.0 148.0 148.0 146.0 146.0 147.0 146.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:26:12 INFO - PROCESS | 27304 | Values: 96.0 94.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:26:12 INFO - PROCESS | 27304 | Values: 65.0 64.0 64.0 65.0 66.0 65.0 65.0 64.0 63.0 65.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:65.00 stddev:3.72 (5.7%) stddev-sans-first:3.90 15:26:12 INFO - PROCESS | 27304 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 75.0 65.0 72.0 64.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:85.50 stddev:10.84 (12.7%) stddev-sans-first:11.30 15:26:12 INFO - PROCESS | 27304 | Values: 85.0 84.0 84.0 86.0 86.0 93.0 100.0 85.0 118.0 86.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:135.50 stddev:2.79 (2.1%) stddev-sans-first:2.86 15:26:12 INFO - PROCESS | 27304 | Values: 137.0 132.0 138.0 131.0 135.0 134.0 134.0 133.0 136.0 140.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:3.21 (1.8%) stddev-sans-first:3.27 15:26:12 INFO - PROCESS | 27304 | Values: 176.0 170.0 175.0 180.0 174.0 175.0 172.0 173.0 170.0 170.0 15:26:12 INFO - PROCESS | 27304 | 15:26:12 INFO - PROCESS | 27304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 15:26:12 INFO - PROCESS | 27304 | Values: 68.0 68.0 67.0 68.0 67.0 68.0 68.0 71.0 67.0 65.0 15:26:12 INFO - PROCESS | 27304 | -------- Summary: end -------- 15:26:12 INFO - PROCESS | 27304 | 15:26:13 INFO - TEST-INFO | 27304: exit 0 15:26:13 INFO - TEST-OK | kraken | took 65002ms 15:26:13 INFO - SUITE-END | took 1185s 15:26:14 INFO - Completed test suite (00:19:45) 15:26:14 INFO - javascript benchmark 15:26:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2699.6625421822273, 2728.0997270900607, 2742.9177124686266, 2759.365345970428, 2783.902563410281, 4577.404937358147, 4633.675642705012, 4797.088553174899, 4893.266010098487, 4926.876828079296, 4687.953120468795, 4709.270063140219, 4717.056588682269, 4794.760261986904, 4796.520347965202, 4377.627901628357, 4408.691391602589, 4409.955900441003, 4473.597376236138, 4479.08178823342, 4460.241758900995, 4536.410266665329, 4594.793234304448, 4625.838095666652, 4641.2109941310055, 4265.9786701066605, 4445.310976798602, 4483.215437298476, 4500.392447019643, 4502.8874278142985, 4307.030918043447, 4352.825886964518, 4373.628241599468, 4385.627221686161, 4396.274614688573, 4360.825566977317, 4409.360642706822, 4419.049904270597, 4429.977850110761, 4464.308032255006, 4577.427821522309, 4687.859364219044, 4719.10337035962, 4752.9762351188365, 4770.332153498478, 5058.114829904789, 5135.152699804565, 5159.432462429129, 5225.451327610622, 5231.843044708665, 5206.973965130188, 5243.370795504526, 5247.291615631879, 5270.130428479296, 5278.366596008465, 4671.5328467153695, 4795.040991801654, 4902.950970490321, 4912.189488734319, 4917.188663870421, 5312.0, 5340.946590534123, 5411.702356370359, 5417.620766546383, 5420.457954204627, 5133.050385678662, 5173.767180476888, 5188.092083885305, 5189.247559103985, 5189.532942035235, 4987.80048798044, 5064.392272927273, 5131.820386286462, 5224.9738751306, 5269.394019687708, 5068.974655126774, 5087.465816089331, 5094.15946368845, 5125.436202017775, 5133.101707201299, 5113.642045056885, 5115.053715062651, 5117.309163262987, 5119.180931051014, 5147.382314122255, 4201.7268877522865, 4249.97875010623, 4250.256205164084, 4284.078923031563, 4374.737515749065, 3771.41543060826, 3808.5620153682125, 3821.044738815296, 3846.942295865564, 3910.7458015228917, 4473.6868419211, 4474.977625111854, 4482.305242687388, 4513.0, 4525.185466615975, 4967.90064198714, 5181.4559471255725, 5199.63602547818, 5209.453007434165, 5247.344081989751, 4349.325854492558, 4428.689991700615, 4431.911361772746, 4445.088756804847, 4511.684182107287, 4683.274092515666, 4693.131770622445, 4695.5304469552775, 4701.835435759732, 4739.265413860857, 4823.27650852375, 4825.9758701206265, 4827.662063655581, 4835.661503694708, 4846.830360937421, 4874.5856602189215, 5067.797288108434, 5133.56364708989, 5138.614603904797, 5142.125838607521, 4807.351007613927, 4833.975830120827, 4862.781174847211, 4864.051509955525, 4912.189488734319, 4905.681130726492, 5129.051125541787, 5137.51193636604, 5140.768665409991, 5182.818601348935, 5028.296038554532, 5108.003939231814, 5112.79548818058, 5114.360704911886, 5148.897022059613, 4988.201887697951, 4991.450940396481, 4994.5754610858485, 4997.150484417585, 5043.672161309503, 4871.902561948812, 4915.311856340044, 4926.630502712239, 4942.950570494249, 4986.750662466935, 4929.728864912464, 4999.500049994971, 5030.446650868328, 5031.4213865405945, 5047.848564543069, 5094.057599344133, 5097.337346144977, 5100.515451032146, 5138.486151384981, 5145.253938179018, 4724.385829842098, 4869.683470574401, 4946.480619534897, 4976.0, 5039.571636410946], "value": 4731.298145797605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.1325680466323, 587.421389930918, 595.407569468379, 597.074534471569, 602.126915971841, 27796.722032779668, 40106.79412632304, 41334.58665413345, 41426.99999999996, 45190.77404612972, 42053.158936821324, 42728.78635606817, 42824.14351712972, 42837.357439638356, 42890.78554607223, 7683.078030636318, 7870.606469676522, 7872.212778722139, 7874.212578742108, 7881.802954926144, 7633.465657403984, 7721.922780772176, 7765.301122898938, 7769.261920117579, 7771.727989520368, 7763.767086987399, 7812.921870781276, 7813.062432508107, 7813.921860781376, 7818.218178182193, 7739.458237923348, 7772.7668169954995, 7785.18255583167, 7786.377089832799, 7789.104253010892, 7719.536827790351, 7809.960950195213, 7811.882821757678, 7813.453058285922, 7815.726449574295, 36205.27589448223, 36706.0, 36749.63250367489, 36769.08077298089, 36773.63226367729, 2917.5769513420646, 3037.9240518987203, 3122.3443076953868, 3264.42872497312, 3412.368711788327, 29948.85025574858, 30151.698483015327, 30171.245718856986, 30504.0, 30637.540436893465, 3549.8225088745717, 3550.8757193498104, 3556.751027428081, 3587.0673624857463, 3655.3785856404475, 254743.0, 254964.99999999814, 255034.0, 255830.0, 255947.0, 52218.47781522212, 52826.73586632042, 52877.471225287256, 52879.73560132175, 52982.73508632509, 33814.32371352559, 34715.0, 34769.0, 36411.4538281926, 36557.0, 15081.396744130112, 15146.0, 15212.543623691306, 15219.543413697607, 15221.162836043903, 11164.776704466027, 11195.216334856645, 11203.831942520868, 11207.943960280147, 11212.327260364242, 18913.43259702211, 18960.336388226347, 18966.0, 18983.62032759337, 18984.14571344293, 6915.204751453547, 6984.996451525893, 7010.404115650227, 7110.1112360954885, 7277.8544429111125, 837.2590257621927, 895.5696515689797, 947.3226642950324, 1020.3724709303725, 1054.625607909181, 27705.168844934684, 28034.71965280321, 28453.85773071163, 28809.559522023814, 28939.42121157565, 801.3669201330999, 979.2753362511833, 992.2954702161546, 1008.3949630221808, 1073.4525392049954, 14557.417703291962, 15063.563446151933, 15194.544163675107, 15206.0, 15466.072035677895, 403598.0, 404716.0, 405546.0, 407972.0, 408059.0, 49851.75074124679, 50320.0, 50329.24506132411, 50348.49651503438, 50569.74715126401, 1109.7447587055024, 1169.4036041618835, 1184.8341232227494, 1197.2517176764522, 1204.9277043377426, 28631.42737145204, 29630.259243519085, 29671.55492667655, 29689.406211875208, 29966.25084372908, 43342.566574333854, 43736.56263437325, 43893.78053109714, 43917.560824391345, 43959.78020109879, 308642.0, 312539.0, 313460.0, 313783.0, 374379.0, 24628.753712463364, 25229.0, 25281.0, 26471.60292595574, 27098.593521096805, 42799.57200427956, 43468.0, 43989.34015989699, 44092.0, 44194.0, 36203.27593448169, 37236.25527489381, 37377.43933841049, 37497.25005499929, 37639.43540846944, 37010.8149459251, 37299.0, 37396.06509837167, 37652.623473766005, 38089.238215236095, 36244.818775907006, 36386.8180659095, 36389.45415818818, 37280.0, 37395.43906841345, 31130.0, 32954.83522582372, 33267.33465330728, 33282.5007624881, 33307.50038749469, 25250.621240681772, 25912.22263332103, 25913.6112958302, 26080.625269320106, 26342.0], "value": 17636.09304250775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.71656965851463, 367.746255083992, 369.2762186115214, 379.84046700385835, 389.384772060145, 15628.453004144858, 16726.498205053867, 16934.83065169348, 17292.308307667678, 17455.563610909718, 15921.442749503769, 16338.509844704648, 16866.494005179833, 17038.48884533463, 17063.232154553043, 4989.550940415371, 5152.562032227265, 5155.252488389181, 5184.792608295664, 5198.45416231296, 3676.117731744389, 3838.0, 5109.897802043957, 5748.45389687979, 6098.756049758004, 6116.938830611703, 6121.816345509642, 6126.509879209675, 6146.446819786218, 6148.169997050408, 5856.76572937082, 6012.068129439944, 6046.606970546901, 6103.42017508336, 6108.877822443571, 3337.1823903143886, 5003.17447621142, 5206.661566998133, 5325.0, 5328.254044433782, 19486.51283717904, 20115.899420502803, 20126.899365503225, 20201.393958181277, 20270.69593956092, 1921.5100149461937, 2042.4995876010473, 2139.5720855828895, 2483.8509689418693, 2544.9745502545106, 12968.740625187444, 13023.0, 13059.085863989525, 13148.86851131486, 13519.121257118255, 1723.5432610358266, 1725.1374312843577, 1731.89608623483, 1801.1534578747967, 1825.178669598686, 62232.377676223565, 63340.36659633391, 65126.348736512504, 65533.67233163851, 65931.67034164847, 9410.482423466638, 9462.195713364303, 9476.526173691287, 9647.0, 9794.069563391466, 13068.477260909647, 13191.538296159588, 13192.472301107848, 13195.934020329836, 13218.0, 7377.594232317274, 7469.253074692596, 7542.811429714301, 7620.008894174324, 7639.236076392316, 7262.0, 7320.780376588711, 7363.337299642951, 7452.217517160729, 7487.887681684779, 5658.387359602576, 5735.340435849931, 5767.22142510764, 5838.562107841929, 5839.270091238595, 1583.8812089093365, 1722.1647500962024, 1722.6899158151402, 1739.0348356662173, 1763.8324359185856, 638.3594163001043, 892.5849479991705, 905.3571963905569, 925.9674565797069, 963.5326866469757, 16031.0, 16870.15649217534, 16981.660366792596, 17008.48974530766, 17557.736633950502, 422.3390394033389, 427.36962979604834, 430.5651292194906, 436.57215928390355, 446.9307257375112, 5346.759395827197, 5679.261695979496, 5718.914216286759, 5822.737976791054, 6067.666278354644, 370062.0, 373755.0, 374767.0, 377797.0, 377851.0, 73185.0, 74877.6256118716, 76489.0, 76932.46135077268, 77185.61407193041, 431.0387835127683, 438.6162108155364, 439.4484921423657, 442.690116918165, 442.86049894283195, 9606.759831004281, 9913.256505762241, 10115.291929564859, 10207.693769186937, 10210.438425886647, 34908.301833963684, 35149.47275790814, 35166.648333516336, 35315.470267945486, 36270.45594316035, 46806.06387872292, 47869.0, 49346.0, 49401.0, 49644.00711985812, 7293.781186564412, 7300.96349518249, 7313.813269204954, 7461.030066091374, 7473.252674732484, 6232.189815323979, 7622.428317876293, 10652.414117223318, 11044.701656356208, 11366.659000230007, 5986.305056364686, 8977.23693486061, 9844.9015509844, 10053.849192261976, 10114.089731923868, 9540.618375265189, 9849.064338887794, 9970.750731231778, 10050.949745251228, 10079.596816127567, 9990.150837178631, 10149.289549731744, 10160.136388407069, 10167.898321016992, 10268.64059757905, 7654.770356889302, 7709.845803084019, 7857.842843143219, 7941.292622086279, 8005.3995950305125, 7886.0536735592095, 10025.899741002497, 10081.546330415002, 10184.694459166238, 10279.743006424898], "value": 7695.125114703503, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.206119114362, 1372.684282614999, 1402.901796874219, 1516.257034053314, 1751.7635119258905, 6484.2867284598715, 7305.379042781364, 7551.207123252062, 7551.433642476823, 7589.924100758998, 7339.339459448649, 7360.116785985676, 7418.0, 7418.406527477802, 7428.145763237229, 1793.6412717456496, 1994.2920263306535, 2088.4883203615136, 2111.524906895944, 2111.936641900738, 2119.290037837319, 2167.2631305356176, 2168.7831216878344, 2169.533550286688, 2171.5439757650834, 2077.044559502631, 2091.341227513336, 2100.5378816660386, 2120.7773183815707, 2132.402927180392, 1756.8506676932477, 1927.9036048197675, 1983.831374333169, 2039.3881835449306, 2074.4191626344646, 2096.2139197800825, 2114.873107613548, 2118.120979793384, 2120.416885356524, 2120.4910821402905, 7180.28197180283, 7197.820054498679, 7226.855462890765, 7242.13094428672, 7247.818804529877, 4221.641160501361, 4364.214441400547, 4371.34429835524, 4372.366006928977, 4374.803133858984, 2808.1154436352485, 2871.6697579778383, 2910.4033673096965, 2911.883524659011, 2938.6179796626516, 884.4030279561271, 906.2478143141177, 913.8766266553996, 944.3719926249105, 959.94720290384, 9701.854472182922, 9709.786276715482, 9735.26985476085, 9758.268129890215, 9769.267304952085, 4022.939655905164, 4027.677785777131, 4175.665946724254, 4183.372494125905, 4185.204811085884, 8477.237048665527, 8535.189157030072, 8557.743267701979, 8594.269487093667, 8598.87101693475, 4473.261911784519, 4474.709143905636, 4477.574630410106, 4481.708688935209, 4482.350059241392, 3585.372559802024, 4021.959780402217, 4031.657309128757, 4110.116324990141, 4131.5248746393945, 3546.8758593449106, 3562.109472631842, 3645.7265705071695, 3665.8533658653887, 3676.669099780979, 1146.8623765148236, 1148.494662348564, 1155.2086820527966, 1162.3026184289529, 1162.8720840707515, 819.4018366592421, 846.5090247656468, 851.748734123435, 856.5674334461182, 875.0593112404191, 4976.778342330933, 4981.178105612606, 5003.574696150868, 5068.797248110034, 5090.949090509122, 408.9795510224477, 423.6187431311844, 428.27621319969154, 431.47144747683836, 445.2541992163114, 3648.416253399443, 3655.94516082259, 3664.193877346979, 3706.9258614827554, 3720.720945929066, 8581.356398270154, 9005.0, 9067.04795996411, 9101.135392137736, 9105.089491050974, 8968.820623587491, 9009.369344145847, 9013.459192448343, 9017.954910225408, 9025.097490251053, 6841.076454678555, 6899.586024838526, 6978.79063628092, 6980.0, 6985.965070174719, 5173.586113110867, 5187.403448603459, 5219.608529360389, 5330.413654497925, 5342.3856256531, 8220.219079187467, 8324.791880203044, 8407.2433480987, 8413.411061225655, 8421.410501265098, 8071.152528984372, 8330.208630180123, 8346.332293416634, 8431.072582015851, 8447.831043378976, 5639.351474580476, 6276.529260305587, 6390.073439351361, 6451.645159516272, 6494.318096599789, 7283.126024877049, 7284.053073100463, 7350.632468376667, 7353.080864891888, 7359.337659610661, 6363.90454143179, 6535.5425120241125, 6630.867382652416, 6674.399304062657, 6736.326367363225, 6366.427021568081, 6425.518086143651, 6441.194850643669, 6556.3443655634055, 6575.80272591823, 5913.231279933581, 6057.7879774207695, 6191.504679625709, 6203.472704820141, 6208.4722798562625, 4323.632491238154, 4405.40527028847, 4406.73559586413, 4453.376527286117, 4534.093181363806, 4489.865304040884, 4537.410136682211, 4578.65660075489, 4612.354270402079, 4639.327297541905], "value": 3912.11225702112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.66325715198974, 304.8993832035428, 305.92963618367776, 310.19194997032713, 311.63538659768057, 4865.708057516547, 4963.205887058071, 4988.451270360258, 4994.0, 5009.69941803492, 4819.614430845532, 4868.805247790084, 4884.192848645997, 4886.0, 4898.338724272231, 3645.65366290202, 3699.4820725098375, 3754.3242216401036, 3823.101571130782, 3848.633735024054, 3816.732828701992, 3828.636279553438, 3837.712171587128, 3850.7497012694225, 3881.7282790204695, 3639.763415378005, 3809.580946095927, 3815.866444674437, 3817.0, 3819.178876541543, 3715.9628403716024, 3830.7701537907815, 3848.692104631623, 3855.1302618230134, 3857.2092720992127, 3346.7991920484847, 3393.2025973896116, 3404.4552871540436, 3408.5739282589675, 3415.624281329052, 4662.344867571997, 4676.181668208084, 4677.4564393750325, 4697.224957881946, 4713.622910167179, 4234.661227101825, 4318.762468064255, 4337.696361254713, 4344.6089851913475, 4369.497507786582, 5092.974535127338, 5102.668326558799, 5108.693478391308, 5128.922786271566, 5129.897402051938, 3702.648248416396, 3704.2221133561984, 3714.439935227211, 3718.4050551911564, 3736.532933383327, 5187.429382767892, 5310.9734451327495, 5333.173358129496, 5348.893022139574, 5358.732063396854, 3790.374588192917, 3796.5823759387, 3800.9049773755323, 3827.2154208387215, 3832.003679043413, 3855.3445914194654, 3862.3820188769664, 3873.767573945572, 3880.1269714314053, 3889.1638297766117, 4253.851115211015, 4386.210482113251, 4397.208502469586, 4413.867583972486, 4430.113977204572, 5036.496350364934, 5051.949480505222, 5057.595392368602, 5085.466026067284, 5102.9489705103215, 1286.459686931491, 1309.8821106100497, 1315.684235783405, 1319.590926812672, 1320.1682939747898, 863.935204859638, 866.0170706248454, 894.9776255593532, 919.4391421233042, 919.5723988345318, 4469.843555475542, 4491.820327186876, 4492.438445194351, 4501.051811063759, 4537.115262523842, 5228.477152284741, 5236.9738151309, 5250.868728281824, 5266.7629956652045, 5273.31446911899, 4342.392065110887, 4514.480834704051, 4521.706089104197, 4546.204414227497, 4618.35343051973, 2829.3872492678975, 2872.669642991041, 2889.3787835615444, 2892.8842846286334, 2894.7105289471306, 5053.747312634354, 5062.6080526047635, 5064.82273120439, 5089.592832573385, 5090.490950904954, 5378.650387724863, 5489.0, 5491.697956612425, 5503.2020357048805, 5582.888342233133, 5006.121480148929, 5007.574356179693, 5017.54842064216, 5036.798528058836, 5056.544910958031, 5312.256284120149, 5350.7324633767375, 5357.651752636066, 5402.540784033401, 5405.999890020359, 5021.0, 5215.869603259797, 5235.397929238186, 5248.422673505987, 5250.606204534599, 4960.255961605788, 4981.0, 4991.951690144965, 4996.150654388835, 5006.199008158677, 3699.075231192202, 3710.5176327077306, 3720.2001569662652, 3737.2151848112203, 3745.0, 5035.546800787946, 5291.4443983382735, 5353.170258609922, 5353.705546194841, 5364.865878353073, 5138.588912886886, 5148.742562871917, 5152.355955505562, 5162.535371816554, 5201.661891977009, 5183.81856635016, 5198.766055527586, 5201.947980520146, 5207.661502002357, 5226.372835259793, 4807.735574543294, 4834.734089625104, 5075.644704870623, 5089.7709603067215, 5125.282460455614, 5072.898542029213, 5075.314832497713, 5092.014114495276, 5092.821751238837, 5126.128558145198, 4968.801247950041, 5101.92347114801, 5105.259737337991, 5119.180931051014, 5121.692698438105], "value": 3886.0173726947087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9664518451483, 614.6066517428845, 628.8647940692753, 727.9272072792718, 749.3330935467433, 12656.303903285316, 13537.187768733871, 13557.32213389329, 13573.253471059112, 13578.049536532446, 11383.487743051563, 12579.937100314508, 12601.495940162382, 12641.55754548591, 12645.114841961044, 803.7910143362739, 809.7570728781371, 811.5860910935436, 812.6099472253322, 813.2477458351032, 817.358373676664, 819.9877001844977, 820.4748960665179, 821.7124006597672, 821.9054808697017, 856.9143085691412, 858.4248553469159, 859.6948083430386, 859.70769938221, 862.5902696219308, 854.7179430787825, 856.7087190355278, 856.7943693513574, 857.1171693156091, 857.1942374168262, 622.0886401421893, 628.1708145248274, 629.0469938043867, 629.1192330737005, 629.2731894661673, 11685.182037257395, 11753.0, 11781.234219775688, 11783.646490605295, 11800.527978880835, 10629.893701062967, 10688.679339619825, 10802.837957430565, 11094.778104437946, 11243.662690119229, 8265.504069755774, 8316.168383161636, 8423.284020858235, 8424.0, 10011.79976400468, 4160.646345060643, 4183.895402614929, 4221.324588065895, 4332.198543269474, 4361.302191649321, 40517.79741101305, 41497.79251103755, 47681.761591191826, 50229.49770502321, 56062.0, 10043.347182433119, 10557.841632375521, 10596.629117980834, 10745.355278683148, 10839.0, 18580.25678972853, 18641.7203741944, 18644.81355186458, 18647.81352186488, 18654.253829846926, 6933.722651094001, 7053.470989675795, 7107.538010029331, 7202.891956620655, 7238.565686058853, 3735.589085200626, 3880.165764360676, 3885.494885664902, 3908.785016824102, 3911.647951684362, 3075.1082186165763, 3186.187522181875, 3192.7605429592872, 3195.792273502215, 3196.280836811699, 569.5301376364433, 582.8368056944063, 588.5262363797099, 596.8686888884439, 606.6390497653977, 551.9430290992784, 556.5491951519282, 569.8091139468324, 572.0760971031754, 598.0879159282042, 8185.181481851886, 8250.752477425687, 8328.583570821434, 8345.248927596545, 8548.658053677907, 522.5584381197882, 539.5602583894114, 541.7665352692967, 541.983740487786, 569.0610492687099, 3880.185161116141, 3959.3269144245546, 4001.579834117434, 4047.757134571876, 4050.716449848482, 51315.23027154596, 51726.48273517292, 86529.56735216283, 88661.55669221612, 93266.0, 49867.0, 63129.68435157795, 64403.67798160979, 74555.0, 76733.0, 67399.0, 68208.0, 68270.65864670645, 70423.29576704168, 71660.28339716536, 7193.496455248292, 7246.9129630555835, 7436.702531898663, 7621.923780762121, 7743.6515356810205, 33218.16954576155, 39088.21823563569, 41208.1758364837, 42289.78855105828, 44292.0, 59260.70369648124, 65195.34804652083, 66366.66816665886, 68875.3112468889, 69201.0, 10572.0, 10707.732306692395, 10865.945670271598, 11096.556137754722, 11285.266457680225, 12228.205166664138, 12348.629541113782, 12478.438470268678, 12720.427580758704, 13207.405666745211, 11909.821352679543, 11953.521859125538, 12247.142700010914, 12402.937985310016, 12789.360531973178, 11863.288202707865, 12440.564580239648, 12638.115331926678, 12699.936500317439, 12706.809397858855, 11016.1187105033, 11495.482703278205, 11504.597339093092, 11670.066394688574, 12258.938705306417, 8809.42738721981, 9146.634134634805, 9161.541922903694, 9220.077992200726, 9470.857937131086, 9303.906960930575, 9661.227101831695, 9664.75838104053, 9692.079252471003, 9897.257705672248], "value": 6412.238967883951, "unit": "score"}], "name": "dromaeo_css", "value": 6301.28307024241, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 115.0, 114.0, 114.0, 117.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 134.0, 178.0, 130.0, 133.0, 160.0, 130.0, 197.0, 129.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 164.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 107.0, 75.0, 75.0, 74.0, 75.0, 105.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 86.0, 84.0, 84.0, 119.0, 85.0, 84.0, 124.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 145.0, 146.0, 148.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 63.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 75.0, 65.0, 72.0, 64.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 86.0, 93.0, 100.0, 85.0, 118.0, 86.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 138.0, 131.0, 135.0, 134.0, 134.0, 133.0, 136.0, 140.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 175.0, 180.0, 174.0, 175.0, 172.0, 173.0, 170.0, 170.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 71.0, 67.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1557.8, "alertThreshold": 2.0}]} 15:26:14 INFO - Return code: 0 15:26:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:26:14 ERROR - # TBPL SUCCESS # 15:26:14 INFO - Running post-action listener: _resource_record_post_action 15:26:14 INFO - ##### 15:26:14 INFO - ##### Finished run-tests step (success) 15:26:14 INFO - ##### 15:26:14 INFO - Running post-run listener: _resource_record_post_run 15:26:14 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541978624; Read time: 60; Write time: 1323720 15:26:14 INFO - TinderboxPrint: CPU usage
13.2% 15:26:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 60 15:26:14 INFO - TinderboxPrint: I/O write bytes / time
541,978,624 / 1,323,720 15:26:14 INFO - TinderboxPrint: CPU idle
8,349.3 (86.8%) 15:26:14 INFO - TinderboxPrint: CPU user
1,213.6 (12.6%) 15:26:14 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:14 INFO - install - Wall time: 19s; CPU: 16.0%; Read bytes: 0; Write bytes: 243986432; Read time: 0; Write time: 823392 15:26:14 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294080512; Read time: 60; Write time: 499612 15:26:14 INFO - Running post-run listener: _upload_blobber_files 15:26:14 INFO - Blob upload gear active. 15:26:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:26:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:19 INFO - (blobuploader) - INFO - Done attempting. 15:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:20 INFO - (blobuploader) - INFO - Done attempting. 15:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:21 INFO - (blobuploader) - INFO - Done attempting. 15:26:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:21 INFO - Return code: 0 15:26:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/014d07601e812424791645bc4a65d2e7d9bc8ac3786bdaea537e1b4bb6c8a9a61ec0829886b7f66ea42de9ddfe0d2ed9120756c3552f2bd290cc42efee102a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db49589772fad4f09467383c25c0c8ca6da75433034eadd6a751cb879c163c05b29e509e067cf8f7ffcf56511269306ae01076f5d0a510adc86536b197063208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b344fde0eb4d31945af2027bffddfb470d639c19659aab78cafb5ec77d23af8555affb03df284b347c20dfe00b1d139470ed0101fa7e20ffbc48f20c2d992ef"} 15:26:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:21 INFO - Contents: 15:26:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/014d07601e812424791645bc4a65d2e7d9bc8ac3786bdaea537e1b4bb6c8a9a61ec0829886b7f66ea42de9ddfe0d2ed9120756c3552f2bd290cc42efee102a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db49589772fad4f09467383c25c0c8ca6da75433034eadd6a751cb879c163c05b29e509e067cf8f7ffcf56511269306ae01076f5d0a510adc86536b197063208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b344fde0eb4d31945af2027bffddfb470d639c19659aab78cafb5ec77d23af8555affb03df284b347c20dfe00b1d139470ed0101fa7e20ffbc48f20c2d992ef"} 15:26:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:21 INFO - Copying logs to upload dir... 15:26:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.180929 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-02 15:26:21.083359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 15:26:21.087352) ========= 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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 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/014d07601e812424791645bc4a65d2e7d9bc8ac3786bdaea537e1b4bb6c8a9a61ec0829886b7f66ea42de9ddfe0d2ed9120756c3552f2bd290cc42efee102a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db49589772fad4f09467383c25c0c8ca6da75433034eadd6a751cb879c163c05b29e509e067cf8f7ffcf56511269306ae01076f5d0a510adc86536b197063208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b344fde0eb4d31945af2027bffddfb470d639c19659aab78cafb5ec77d23af8555affb03df284b347c20dfe00b1d139470ed0101fa7e20ffbc48f20c2d992ef"} build_url:https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/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/014d07601e812424791645bc4a65d2e7d9bc8ac3786bdaea537e1b4bb6c8a9a61ec0829886b7f66ea42de9ddfe0d2ed9120756c3552f2bd290cc42efee102a38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db49589772fad4f09467383c25c0c8ca6da75433034eadd6a751cb879c163c05b29e509e067cf8f7ffcf56511269306ae01076f5d0a510adc86536b197063208", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b344fde0eb4d31945af2027bffddfb470d639c19659aab78cafb5ec77d23af8555affb03df284b347c20dfe00b1d139470ed0101fa7e20ffbc48f20c2d992ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 15:26:21.114693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:26:21.115129) ========= 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=745a4373a2a16df560f216e000000264-1464905132.154532-832153689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:26:21.199346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 15:26:21.199671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 15:26:21.200024) ========= ========= Total master_lag: 0.17 =========