builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1464177558.63 results: success (0) buildid: 20160525023005 builduid: 59a4bf95e9594166b31cf10b5c09b01f revision: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.632483) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.632942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.633259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.687271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.687626) ========= 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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 04:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-25 04:59:19 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.229114 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.970744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:18.971471) ========= 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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.023338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.023716) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 --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 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 --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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 04:59:19,130 truncating revision to first 12 chars 2016-05-25 04:59:19,130 Setting DEBUG logging. 2016-05-25 04:59:19,130 attempt 1/10 2016-05-25 04:59:19,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c599aa289d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 04:59:19,403 unpacking tar archive at: fx-team-3c599aa289d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.562051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.562413) ========= script_repo_revision: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.562873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.563185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 04:59:19.573562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-25 04:59:19.573909) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:19 INFO - MultiFileLogger online at 20160525 04:59:19 in /builds/slave/test 04:59:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:59:19 INFO - {'append_to_log': False, 04:59:19 INFO - 'base_work_dir': '/builds/slave/test', 04:59:19 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:59:19 INFO - 'branch': 'Fx-Team', 04:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:19 INFO - 'config_files': ('talos/linux_config.py',), 04:59:19 INFO - 'default_actions': ('clobber', 04:59:19 INFO - 'read-buildbot-config', 04:59:19 INFO - 'download-and-extract', 04:59:19 INFO - 'populate-webroot', 04:59:19 INFO - 'create-virtualenv', 04:59:19 INFO - 'install', 04:59:19 INFO - 'run-tests'), 04:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:19 INFO - 'download_minidump_stackwalk': True, 04:59:19 INFO - 'download_symbols': 'ondemand', 04:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:19 INFO - 'installer_path': 'installer.exe', 04:59:19 INFO - 'log_level': 'info', 04:59:19 INFO - 'log_name': 'talos', 04:59:19 INFO - 'log_to_console': True, 04:59:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:19 INFO - 'opt_config_files': (), 04:59:19 INFO - 'pip_index': False, 04:59:19 INFO - 'sps_profile': False, 04:59:19 INFO - 'sps_profile_interval': 0, 04:59:19 INFO - 'suite': 'dromaeojs', 04:59:19 INFO - 'system_bits': '32', 04:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:19 INFO - 'title': 'talos-linux64-ix-003', 04:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:19 INFO - 'use_talos_json': True, 04:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:19 INFO - 'work_dir': 'build'} 04:59:19 INFO - ##### 04:59:19 INFO - ##### Running clobber step. 04:59:19 INFO - ##### 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: clobber 04:59:19 INFO - rmtree: /builds/slave/test/build 04:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:59:20 INFO - Running post-action listener: _resource_record_post_action 04:59:20 INFO - ##### 04:59:20 INFO - ##### Finished clobber step (success) 04:59:20 INFO - ##### 04:59:20 INFO - ##### 04:59:20 INFO - ##### Running read-buildbot-config step. 04:59:20 INFO - ##### 04:59:20 INFO - Running pre-action listener: _resource_record_pre_action 04:59:20 INFO - Running main action method: read_buildbot_config 04:59:20 INFO - Using buildbot properties: 04:59:20 INFO - { 04:59:20 INFO - "project": "", 04:59:20 INFO - "product": "firefox", 04:59:20 INFO - "script_repo_revision": "production", 04:59:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:59:20 INFO - "repository": "", 04:59:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:59:20 INFO - "buildid": "20160525023005", 04:59:20 INFO - "pgo_build": "True", 04:59:20 INFO - "basedir": "/builds/slave/test", 04:59:20 INFO - "buildnumber": 125, 04:59:20 INFO - "slavename": "talos-linux64-ix-003", 04:59:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:59:20 INFO - "platform": "ubuntu64_hw", 04:59:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:59:20 INFO - "branch": "fx-team", 04:59:20 INFO - "repo_path": "integration/fx-team", 04:59:20 INFO - "revision": "3c599aa289d8df66c7959dd65fd58cb1067c7fa9", 04:59:20 INFO - "stage_platform": "linux64-pgo", 04:59:20 INFO - "builduid": "59a4bf95e9594166b31cf10b5c09b01f", 04:59:20 INFO - "slavebuilddir": "test" 04:59:20 INFO - } 04:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:59:20 INFO - Running post-action listener: _resource_record_post_action 04:59:20 INFO - ##### 04:59:20 INFO - ##### Finished read-buildbot-config step (success) 04:59:20 INFO - ##### 04:59:20 INFO - ##### 04:59:20 INFO - ##### Running download-and-extract step. 04:59:20 INFO - ##### 04:59:20 INFO - Running pre-action listener: _resource_record_pre_action 04:59:20 INFO - Running main action method: download_and_extract 04:59:20 INFO - mkdir: /builds/slave/test/build/tests 04:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:20 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:59:21 INFO - Downloaded 1361 bytes. 04:59:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:59:21 INFO - Using the following test package requirements: 04:59:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:59:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'jsshell-linux-x86_64.zip'], 04:59:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:59:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:59:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:59:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:59:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:21 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:59:23 INFO - Downloaded 24417171 bytes. 04:59:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:59:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:59:24 INFO - Return code: 0 04:59:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:24 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:59:38 INFO - Downloaded 24417171 bytes. 04:59:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:59:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:59:39 INFO - Return code: 0 04:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:39 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:59:41 INFO - Downloaded 10840359 bytes. 04:59: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'] 04:59: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 04:59:41 INFO - Return code: 0 04:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:41 INFO - https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:59:42 INFO - Downloaded 58632985 bytes. 04:59:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:42 INFO - mkdir: /builds/slave/test/properties 04:59:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:59:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:59:42 INFO - Contents: 04:59:42 INFO - build_url:https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:59:43 INFO - Running post-action listener: _resource_record_post_action 04:59:43 INFO - Running post-action listener: set_extra_try_arguments 04:59:43 INFO - ##### 04:59:43 INFO - ##### Finished download-and-extract step (success) 04:59:43 INFO - ##### 04:59:43 INFO - ##### 04:59:43 INFO - ##### Running populate-webroot step. 04:59:43 INFO - ##### 04:59:43 INFO - Running pre-action listener: _resource_record_pre_action 04:59:43 INFO - Running main action method: populate_webroot 04:59:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:43 INFO - '--tppagecycles', 04:59:43 INFO - '7'], 04:59:43 INFO - 'tests': ['tsvgm']}}, 04:59:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:59:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:59:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['damp', 'tps']}, 04:59:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'tests': ['damp', 'tps']}, 04:59:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['dromaeo_dom']}, 04:59:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['a11yr', 04:59:43 INFO - 'ts_paint', 04:59:43 INFO - 'tpaint', 04:59:43 INFO - 'sessionrestore', 04:59:43 INFO - 'sessionrestore_no_auto_restore', 04:59:43 INFO - 'tabpaint']}, 04:59:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['tsvgx', 04:59:43 INFO - 'tsvgr_opacity', 04:59:43 INFO - 'tart', 04:59:43 INFO - 'tscrollx', 04:59:43 INFO - 'cart']}, 04:59:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:59:43 INFO - 'tsvgr_opacity', 04:59:43 INFO - 'tart', 04:59:43 INFO - 'tscrollx', 04:59:43 INFO - 'cart']}, 04:59:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'talos_options': ['--disable-e10s'], 04:59:43 INFO - 'tests': ['tp5o']}, 04:59:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'tests': ['tp5o']}, 04:59:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'talos_options': ['--disable-e10s', 04:59:43 INFO - '--xperf_path', 04:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:43 INFO - 'tests': ['tp5n']}, 04:59:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:43 INFO - 'talos_options': ['--xperf_path', 04:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:43 INFO - 'tests': ['tp5n']}}, 04:59:43 INFO - 'talos.zip': {'path': '', 04:59:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:43 INFO - Running post-action listener: _resource_record_post_action 04:59:43 INFO - ##### 04:59:43 INFO - ##### Finished populate-webroot step (success) 04:59:43 INFO - ##### 04:59:43 INFO - ##### 04:59:43 INFO - ##### Running create-virtualenv step. 04:59:43 INFO - ##### 04:59:43 INFO - Running pre-action listener: _resource_record_pre_action 04:59:43 INFO - Running main action method: create_virtualenv 04:59:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:59:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:59:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:59:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:43 INFO - Using real prefix '/usr' 04:59:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:59:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:47 INFO - Installing pip.................done. 04:59:47 INFO - Return code: 0 04:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:59:47 INFO - Using env: {'DISPLAY': ':0', 04:59:47 INFO - 'HOME': '/home/cltbld', 04:59:47 INFO - 'LANG': 'en_US.UTF-8', 04:59:47 INFO - 'LANGUAGE': 'en_US:en', 04:59:47 INFO - 'LOGNAME': 'cltbld', 04:59:47 INFO - 'MAIL': '/var/mail/cltbld', 04:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:47 INFO - 'MOZ_NO_REMOTE': '1', 04:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:47 INFO - 'NO_EM_RESTART': '1', 04:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:47 INFO - 'PWD': '/builds/slave/test', 04:59:47 INFO - 'SHELL': '/bin/bash', 04:59:47 INFO - 'SHLVL': '1', 04:59:47 INFO - 'TERM': 'linux', 04:59:47 INFO - 'TMOUT': '86400', 04:59:47 INFO - 'USER': 'cltbld', 04:59:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 04:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:47 INFO - '_': '/tools/buildbot/bin/python'} 04:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:59:47 INFO - Cleaning up... 04:59:47 INFO - Return code: 0 04:59:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:59: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 04:59: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 04:59:47 INFO - Using env: {'DISPLAY': ':0', 04:59:47 INFO - 'HOME': '/home/cltbld', 04:59:47 INFO - 'LANG': 'en_US.UTF-8', 04:59:47 INFO - 'LANGUAGE': 'en_US:en', 04:59:47 INFO - 'LOGNAME': 'cltbld', 04:59:47 INFO - 'MAIL': '/var/mail/cltbld', 04:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:47 INFO - 'MOZ_NO_REMOTE': '1', 04:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:47 INFO - 'NO_EM_RESTART': '1', 04:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:47 INFO - 'PWD': '/builds/slave/test', 04:59:47 INFO - 'SHELL': '/bin/bash', 04:59:47 INFO - 'SHLVL': '1', 04:59:47 INFO - 'TERM': 'linux', 04:59:47 INFO - 'TMOUT': '86400', 04:59:47 INFO - 'USER': 'cltbld', 04:59:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 04:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:47 INFO - '_': '/tools/buildbot/bin/python'} 04:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:47 INFO - Downloading/unpacking psutil>=3.1.1 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:50 INFO - Installing collected packages: psutil 04:59:50 INFO - Running setup.py install for psutil 04:59:50 INFO - building 'psutil._psutil_linux' extension 04:59:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:59:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:59:51 INFO - building 'psutil._psutil_posix' extension 04:59:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:59:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:52 INFO - Successfully installed psutil 04:59:52 INFO - Cleaning up... 04:59:52 INFO - Return code: 0 04:59:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:59: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 mozsystemmonitor==0.3 04:59:52 INFO - Using env: {'DISPLAY': ':0', 04:59:52 INFO - 'HOME': '/home/cltbld', 04:59:52 INFO - 'LANG': 'en_US.UTF-8', 04:59:52 INFO - 'LANGUAGE': 'en_US:en', 04:59:52 INFO - 'LOGNAME': 'cltbld', 04:59:52 INFO - 'MAIL': '/var/mail/cltbld', 04:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:52 INFO - 'MOZ_NO_REMOTE': '1', 04:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:52 INFO - 'NO_EM_RESTART': '1', 04:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:52 INFO - 'PWD': '/builds/slave/test', 04:59:52 INFO - 'SHELL': '/bin/bash', 04:59:52 INFO - 'SHLVL': '1', 04:59:52 INFO - 'TERM': 'linux', 04:59:52 INFO - 'TMOUT': '86400', 04:59:52 INFO - 'USER': 'cltbld', 04:59:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 04:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:52 INFO - '_': '/tools/buildbot/bin/python'} 04:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:59:54 INFO - Installing collected packages: mozsystemmonitor 04:59:54 INFO - Running setup.py install for mozsystemmonitor 04:59:54 INFO - Successfully installed mozsystemmonitor 04:59:54 INFO - Cleaning up... 04:59:54 INFO - Return code: 0 04:59:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:59:54 INFO - Using env: {'DISPLAY': ':0', 04:59:54 INFO - 'HOME': '/home/cltbld', 04:59:54 INFO - 'LANG': 'en_US.UTF-8', 04:59:54 INFO - 'LANGUAGE': 'en_US:en', 04:59:54 INFO - 'LOGNAME': 'cltbld', 04:59:54 INFO - 'MAIL': '/var/mail/cltbld', 04:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:54 INFO - 'MOZ_NO_REMOTE': '1', 04:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:54 INFO - 'NO_EM_RESTART': '1', 04:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:54 INFO - 'PWD': '/builds/slave/test', 04:59:54 INFO - 'SHELL': '/bin/bash', 04:59:54 INFO - 'SHLVL': '1', 04:59:54 INFO - 'TERM': 'linux', 04:59:54 INFO - 'TMOUT': '86400', 04:59:54 INFO - 'USER': 'cltbld', 04:59:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 04:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:54 INFO - '_': '/tools/buildbot/bin/python'} 04:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:57 INFO - Downloading docopt-0.6.1.tar.gz 04:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:57 INFO - Running setup.py install for blobuploader 04:59:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:57 INFO - Running setup.py install for requests 04:59:57 INFO - Running setup.py install for docopt 04:59:57 INFO - Successfully installed blobuploader requests docopt 04:59:57 INFO - Cleaning up... 04:59:57 INFO - Return code: 0 04:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:57 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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:57 INFO - Using env: {'DISPLAY': ':0', 04:59:57 INFO - 'HOME': '/home/cltbld', 04:59:57 INFO - 'LANG': 'en_US.UTF-8', 04:59:57 INFO - 'LANGUAGE': 'en_US:en', 04:59:57 INFO - 'LOGNAME': 'cltbld', 04:59:57 INFO - 'MAIL': '/var/mail/cltbld', 04:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:57 INFO - 'MOZ_NO_REMOTE': '1', 04:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:59:57 INFO - 'NO_EM_RESTART': '1', 04:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:57 INFO - 'PWD': '/builds/slave/test', 04:59:57 INFO - 'SHELL': '/bin/bash', 04:59:57 INFO - 'SHLVL': '1', 04:59:57 INFO - 'TERM': 'linux', 04:59:57 INFO - 'TMOUT': '86400', 04:59:57 INFO - 'USER': 'cltbld', 04:59:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 04:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:57 INFO - '_': '/tools/buildbot/bin/python'} 04:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:58 INFO - Running setup.py (path:/tmp/pip-1gitVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:58 INFO - Running setup.py (path:/tmp/pip-V7kptK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:58 INFO - Running setup.py (path:/tmp/pip-QvpZtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:58 INFO - Running setup.py (path:/tmp/pip-Lm5Qcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:58 INFO - Running setup.py (path:/tmp/pip-KysG72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:58 INFO - Running setup.py (path:/tmp/pip-Iv9aIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:58 INFO - Running setup.py (path:/tmp/pip-1OuatT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:58 INFO - Running setup.py (path:/tmp/pip-AFWamA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:58 INFO - Running setup.py (path:/tmp/pip-IQHxzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:58 INFO - Running setup.py (path:/tmp/pip-FFI5xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:58 INFO - Running setup.py (path:/tmp/pip-oDR7PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:58 INFO - Running setup.py (path:/tmp/pip-0WDue_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:59 INFO - Running setup.py (path:/tmp/pip-x3pywH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:59 INFO - Running setup.py (path:/tmp/pip-wV352t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:59 INFO - Running setup.py (path:/tmp/pip-2rVzX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:59 INFO - Running setup.py (path:/tmp/pip-jNaDQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:59 INFO - Running setup.py (path:/tmp/pip-NK80Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:59 INFO - Running setup.py install for manifestparser 04:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozcrash 04:59:59 INFO - Running setup.py install for mozdebug 04:59:59 INFO - Running setup.py install for mozdevice 04:59:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:59 INFO - Running setup.py install for mozfile 04:59:59 INFO - Running setup.py install for mozhttpd 04:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozinfo 05:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozInstall 05:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozleak 05:00:00 INFO - Running setup.py install for mozlog 05:00:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for moznetwork 05:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozprocess 05:00:00 INFO - Running setup.py install for mozprofile 05:00:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozrunner 05:00:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:00:00 INFO - Running setup.py install for mozscreenshot 05:00:00 INFO - Running setup.py install for moztest 05:00:01 INFO - Running setup.py install for mozversion 05:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:01 INFO - Cleaning up... 05:00:01 INFO - Return code: 0 05:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:01 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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:01 INFO - Using env: {'DISPLAY': ':0', 05:00:01 INFO - 'HOME': '/home/cltbld', 05:00:01 INFO - 'LANG': 'en_US.UTF-8', 05:00:01 INFO - 'LANGUAGE': 'en_US:en', 05:00:01 INFO - 'LOGNAME': 'cltbld', 05:00:01 INFO - 'MAIL': '/var/mail/cltbld', 05:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:01 INFO - 'MOZ_NO_REMOTE': '1', 05:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:01 INFO - 'NO_EM_RESTART': '1', 05:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:01 INFO - 'PWD': '/builds/slave/test', 05:00:01 INFO - 'SHELL': '/bin/bash', 05:00:01 INFO - 'SHLVL': '1', 05:00:01 INFO - 'TERM': 'linux', 05:00:01 INFO - 'TMOUT': '86400', 05:00:01 INFO - 'USER': 'cltbld', 05:00:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 05:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:01 INFO - '_': '/tools/buildbot/bin/python'} 05:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:01 INFO - Running setup.py (path:/tmp/pip-griAgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:01 INFO - Running setup.py (path:/tmp/pip-yf0DE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:01 INFO - Running setup.py (path:/tmp/pip-OAAYmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:01 INFO - Running setup.py (path:/tmp/pip-ABlK2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:01 INFO - Running setup.py (path:/tmp/pip-UQQ6TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:01 INFO - Running setup.py (path:/tmp/pip-jil5km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:01 INFO - Running setup.py (path:/tmp/pip-m5ZXMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:01 INFO - Running setup.py (path:/tmp/pip-yHCQKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:01 INFO - Running setup.py (path:/tmp/pip-REYwIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:02 INFO - Running setup.py (path:/tmp/pip-ltvu4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:02 INFO - Running setup.py (path:/tmp/pip-w8mpwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:02 INFO - Running setup.py (path:/tmp/pip-Q4VdZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:02 INFO - Running setup.py (path:/tmp/pip-pKUKYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:02 INFO - Running setup.py (path:/tmp/pip-y1pI00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:02 INFO - Running setup.py (path:/tmp/pip-XH0fYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:02 INFO - Running setup.py (path:/tmp/pip-4yw20t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:02 INFO - Running setup.py (path:/tmp/pip-uzEhBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:00:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:04 INFO - Downloading blessings-1.6.tar.gz 05:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:04 INFO - Installing collected packages: blessings 05:00:04 INFO - Running setup.py install for blessings 05:00:04 INFO - Successfully installed blessings 05:00:04 INFO - Cleaning up... 05:00:04 INFO - Return code: 0 05:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:05 INFO - Reading from file tmpfile_stdout 05:00:05 INFO - Current package versions: 05:00:05 INFO - argparse == 1.2.1 05:00:05 INFO - blessings == 1.6 05:00:05 INFO - blobuploader == 1.2.4 05:00:05 INFO - docopt == 0.6.1 05:00:05 INFO - manifestparser == 1.1 05:00:05 INFO - mozInstall == 1.12 05:00:05 INFO - mozcrash == 0.17 05:00:05 INFO - mozdebug == 0.1 05:00:05 INFO - mozdevice == 0.48 05:00:05 INFO - mozfile == 1.2 05:00:05 INFO - mozhttpd == 0.7 05:00:05 INFO - mozinfo == 0.9 05:00:05 INFO - mozleak == 0.1 05:00:05 INFO - mozlog == 3.2 05:00:05 INFO - moznetwork == 0.27 05:00:05 INFO - mozprocess == 0.22 05:00:05 INFO - mozprofile == 0.28 05:00:05 INFO - mozrunner == 6.11 05:00:05 INFO - mozscreenshot == 0.1 05:00:05 INFO - mozsystemmonitor == 0.3 05:00:05 INFO - moztest == 0.7 05:00:05 INFO - mozversion == 1.4 05:00:05 INFO - psutil == 3.1.1 05:00:05 INFO - requests == 1.2.3 05:00:05 INFO - wsgiref == 0.1.2 05:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:05 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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:05 INFO - Using env: {'DISPLAY': ':0', 05:00:05 INFO - 'HOME': '/home/cltbld', 05:00:05 INFO - 'LANG': 'en_US.UTF-8', 05:00:05 INFO - 'LANGUAGE': 'en_US:en', 05:00:05 INFO - 'LOGNAME': 'cltbld', 05:00:05 INFO - 'MAIL': '/var/mail/cltbld', 05:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:05 INFO - 'MOZ_NO_REMOTE': '1', 05:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:05 INFO - 'NO_EM_RESTART': '1', 05:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:05 INFO - 'PWD': '/builds/slave/test', 05:00:05 INFO - 'SHELL': '/bin/bash', 05:00:05 INFO - 'SHLVL': '1', 05:00:05 INFO - 'TERM': 'linux', 05:00:05 INFO - 'TMOUT': '86400', 05:00:05 INFO - 'USER': 'cltbld', 05:00:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 05:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:05 INFO - '_': '/tools/buildbot/bin/python'} 05:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:05 INFO - Cleaning up... 05:00:05 INFO - Return code: 0 05:00:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00: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', 'jsonschema'] in /builds/slave/test/build 05:00: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 jsonschema 05:00:05 INFO - Using env: {'DISPLAY': ':0', 05:00:05 INFO - 'HOME': '/home/cltbld', 05:00:05 INFO - 'LANG': 'en_US.UTF-8', 05:00:05 INFO - 'LANGUAGE': 'en_US:en', 05:00:05 INFO - 'LOGNAME': 'cltbld', 05:00:05 INFO - 'MAIL': '/var/mail/cltbld', 05:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:05 INFO - 'MOZ_NO_REMOTE': '1', 05:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:05 INFO - 'NO_EM_RESTART': '1', 05:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:05 INFO - 'PWD': '/builds/slave/test', 05:00:05 INFO - 'SHELL': '/bin/bash', 05:00:05 INFO - 'SHLVL': '1', 05:00:05 INFO - 'TERM': 'linux', 05:00:05 INFO - 'TMOUT': '86400', 05:00:05 INFO - 'USER': 'cltbld', 05:00:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 05:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:05 INFO - '_': '/tools/buildbot/bin/python'} 05:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:05 INFO - Downloading/unpacking jsonschema 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:07 INFO - warning: no files found matching '*.txt' 05:00:07 INFO - no previously-included directories found matching 'build' 05:00:07 INFO - no previously-included directories found matching 'dist' 05:00:07 INFO - no previously-included directories found matching '.git*' 05:00:07 INFO - Installing collected packages: jsonschema, functools32 05:00:07 INFO - Running setup.py install for functools32 05:00:07 INFO - warning: no files found matching '*.txt' 05:00:07 INFO - no previously-included directories found matching 'build' 05:00:07 INFO - no previously-included directories found matching 'dist' 05:00:07 INFO - no previously-included directories found matching '.git*' 05:00:07 INFO - Successfully installed jsonschema functools32 05:00:07 INFO - Cleaning up... 05:00:07 INFO - Return code: 0 05:00:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:07 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 0x7f52f15d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, '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': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:00:07 INFO - Using env: {'DISPLAY': ':0', 05:00:07 INFO - 'HOME': '/home/cltbld', 05:00:07 INFO - 'LANG': 'en_US.UTF-8', 05:00:07 INFO - 'LANGUAGE': 'en_US:en', 05:00:07 INFO - 'LOGNAME': 'cltbld', 05:00:07 INFO - 'MAIL': '/var/mail/cltbld', 05:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:07 INFO - 'MOZ_NO_REMOTE': '1', 05:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:07 INFO - 'NO_EM_RESTART': '1', 05:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:07 INFO - 'PWD': '/builds/slave/test', 05:00:07 INFO - 'SHELL': '/bin/bash', 05:00:07 INFO - 'SHLVL': '1', 05:00:07 INFO - 'TERM': 'linux', 05:00:07 INFO - 'TMOUT': '86400', 05:00:07 INFO - 'USER': 'cltbld', 05:00:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 05:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:07 INFO - '_': '/tools/buildbot/bin/python'} 05:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:08 INFO - Downloading/unpacking flake8 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:10 INFO - no previously-included directories found matching 'docs/_build' 05:00:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:10 INFO - Running setup.py install for pep8 05:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:10 INFO - no previously-included directories found matching 'docs/_build' 05:00:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:10 INFO - Cleaning up... 05:00:10 INFO - Return code: 0 05:00:10 INFO - Running post-action listener: _resource_record_post_action 05:00:10 INFO - Running post-action listener: _start_resource_monitoring 05:00:10 INFO - Starting resource monitoring. 05:00:10 INFO - ##### 05:00:10 INFO - ##### Finished create-virtualenv step (success) 05:00:10 INFO - ##### 05:00:10 INFO - ##### 05:00:10 INFO - ##### Running install step. 05:00:10 INFO - ##### 05:00:10 INFO - Running pre-action listener: _resource_record_pre_action 05:00:10 INFO - Running main action method: install 05:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:11 INFO - Reading from file tmpfile_stdout 05:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:11 INFO - Reading from file tmpfile_stdout 05:00:11 INFO - Output received: 05:00:11 INFO - Usage: mozinstall [options] installer 05:00:11 INFO - Options: 05:00:11 INFO - -h, --help show this help message and exit 05:00:11 INFO - -d DEST, --destination=DEST 05:00:11 INFO - Directory to install application into. [default: 05:00:11 INFO - "/builds/slave/test"] 05:00:11 INFO - --app=APP Application being installed. [default: firefox] 05:00:11 INFO - mkdir: /builds/slave/test/build/application 05:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:00:27 INFO - Reading from file tmpfile_stdout 05:00:27 INFO - Output received: 05:00:27 INFO - /builds/slave/test/build/application/firefox/firefox 05:00:27 INFO - Running post-action listener: _resource_record_post_action 05:00:27 INFO - ##### 05:00:27 INFO - ##### Finished install step (success) 05:00:27 INFO - ##### 05:00:27 INFO - ##### 05:00:27 INFO - ##### Running run-tests step. 05:00:27 INFO - ##### 05:00:27 INFO - Running pre-action listener: _resource_record_pre_action 05:00:27 INFO - Running main action method: run_tests 05:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:27 INFO - Python 2.7.3 05:00:27 INFO - Return code: 0 05:00:27 INFO - grabbing minidump binary from tooltool 05:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00: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 0x16fd9c0>, '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 0x16fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16fed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00: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 05:00: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 05:00: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 05:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:27 INFO - Return code: 0 05:00:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:00:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:00:28 INFO - Return code: 0 05:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:00:28 INFO - Using env: {'DISPLAY': ':0', 05:00:28 INFO - 'HOME': '/home/cltbld', 05:00:28 INFO - 'LANG': 'en_US.UTF-8', 05:00:28 INFO - 'LANGUAGE': 'en_US:en', 05:00:28 INFO - 'LOGNAME': 'cltbld', 05:00:28 INFO - 'MAIL': '/var/mail/cltbld', 05:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:28 INFO - 'MOZ_NO_REMOTE': '1', 05:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:28 INFO - 'NO_EM_RESTART': '1', 05:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:28 INFO - 'PWD': '/builds/slave/test', 05:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:28 INFO - 'SHELL': '/bin/bash', 05:00:28 INFO - 'SHLVL': '1', 05:00:28 INFO - 'TERM': 'linux', 05:00:28 INFO - 'TMOUT': '86400', 05:00:28 INFO - 'USER': 'cltbld', 05:00:28 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464176832.986633-1665956217', 05:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:28 INFO - '_': '/tools/buildbot/bin/python'} 05:00:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:00:29 INFO - mozversion application_buildid: 20160525023005 05:00:29 INFO - mozversion application_changeset: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 05:00:29 INFO - mozversion application_display_name: Nightly 05:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:29 INFO - mozversion application_name: Firefox 05:00:29 INFO - mozversion application_remotingname: firefox 05:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:29 INFO - mozversion application_vendor: Mozilla 05:00:29 INFO - mozversion application_version: 49.0a1 05:00:29 INFO - mozversion platform_buildid: 20160525023005 05:00:29 INFO - mozversion platform_changeset: 3c599aa289d8df66c7959dd65fd58cb1067c7fa9 05:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:29 INFO - mozversion platform_version: 49.0a1 05:00:29 INFO - using testdate: 1464177629 05:00:29 INFO - actual date: 1464177629 05:00:29 INFO - starting webserver on 'localhost:33932' 05:00:29 INFO - SUITE-START | Running 2 tests 05:00:29 INFO - TEST-START | dromaeo_css 05:00:29 INFO - operating with platform_type : linux_ 05:00:29 INFO - Initialising browser for dromaeo_css test... 05:00:29 INFO - TEST-INFO | started process 3275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZl2JEC/profile http://localhost:33932/getInfo.html) 05:00:35 INFO - PROCESS | 3275 | __metrics Screen width/height:1600/1200 05:00:35 INFO - PROCESS | 3275 | colorDepth:24 05:00:35 INFO - PROCESS | 3275 | Browser inner width/height: 1024/697 05:00:35 INFO - PROCESS | 3275 | __metrics 05:00:36 ERROR - PROCESS | 3275 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:00:37 INFO - TEST-INFO | 3275: exit 0 05:00:37 INFO - Browser initialized. 05:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:37 INFO - TEST-INFO | started process 3358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZl2JEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:49 INFO - PROCESS | 3358 | RSS: Main: 152956928 05:00:49 INFO - PROCESS | 3358 | 05:01:40 INFO - PROCESS | 3358 | 1464177700722 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:03:48 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33932/tests/dromaeo/cssquery-ext.html) 05:03:49 INFO - PROCESS | 3358 | RSS: Main: 256155648 05:03:49 INFO - PROCESS | 3358 | 05:06:51 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-ext.html (next: http://localhost:33932/tests/dromaeo/cssquery-jquery.html) 05:06:52 INFO - PROCESS | 3358 | RSS: Main: 236457984 05:06:52 INFO - PROCESS | 3358 | 05:09:54 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33932/tests/dromaeo/cssquery-mootools.html) 05:09:54 INFO - PROCESS | 3358 | RSS: Main: 235847680 05:09:54 INFO - PROCESS | 3358 | 05:12:57 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33932/tests/dromaeo/cssquery-prototype.html) 05:12:57 INFO - PROCESS | 3358 | RSS: Main: 234201088 05:12:57 INFO - PROCESS | 3358 | 05:16:00 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33932/tests/dromaeo/cssquery-yui.html) 05:16:00 INFO - PROCESS | 3358 | RSS: Main: 220413952 05:16:00 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:33932/tests/dromaeo/cssquery-yui.html (next: http://localhost:33932/tests/dromaeo/cssquery-dojo.html) 05:19:03 INFO - PROCESS | 3358 | RSS: Main: 304963584 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | __start_tp_report 05:19:03 INFO - PROCESS | 3358 | _x_x_mozilla_page_load 05:19:03 INFO - PROCESS | 3358 | _x_x_mozilla_page_load_details 05:19:03 INFO - PROCESS | 3358 | |i|pagename|runs| 05:19:03 INFO - PROCESS | 3358 | |0;dojo.html;3153.6057992750907;3155.54244634528;3189.0273466592694;3204.006757905051;3221.967780322196;5295.629305948585;5339.6262261641705;5459.181122831572;5547.916781248279;5558.666480011197;5501.0648189807725;5504.119340905456;5507.091329930567;5560.582956278286;5589.357223919251;4955.554000139987;4988.351514303135;5040.319556859814;5055.5702765265;5199.974000129994;5096.923546146792;5121.5390614844655;5136.075506408845;5165.199394093903;5172.12073947428;4846.224604063351;4943.233798761198;4986.351774269358;5008.524190201925;5019.67372120811;5003.199488081926;5008.649394542384;5085.186370180753;5098.974505127488;5120.206368012964;4870.123377791996;5027.296178535008;5045.697258164522;5053.6967781932835;5062;5389.83830485086;5450.04624190765;5450.945490545084;5505.614606977473;5546.140348246028;5934;5946.464818166386;5965.075413310944;5991.161237426763;6006.429389208019;5709.457601527848;5846.649201047951;5995.940040599626;6032.306284777263;6034.064719968368;5532;5635.070213414822;5636.436356364413;5636.859078523029;5638.2670252866865;6126.068514845503;6138.386161383826;6139.447449729546;6141.806260744388;6143.477804386677;5585.664860108325;5729.2265544151005;5779.393163717833;5898.646081235054;5910.320313164041;5874.530037596982;5885.440883116097;5940.673262970492;5949.405059494103;5961.195238642815;5784.797532086357;5800.941990580124;5806.071028635398;5830.271216097988;5871.706414679249;5611.242482264924;5818.010938140526;5872.236609240771;5885.087811389241;5889.411058894162;4455.732656040648;4462.576055274743;4462.665300102505;4464.196444639931;4496.258117410656;3941.52701675795;3975.224831157954;4002.0595160137345;4036.9596304036586;4037;5374.059539580558;5429.348478182565;5490.670559766347;5564.4991950724625;5565.193047008162;5978.402159784074;6008.7296071676;6010.699465026732;6012.158297838306;6069.51443884497;5563.082091454865;5583.218349431083;5583.776648934078;5584.944150558524;5589.245451863946;4972.676776009548;5084.618653600995;5122.974385128051;5134.204198349262;5135.563477104488;6216.067589861557;6230.096635987757;6230.968845155745;6232.75068997235;6233.937660623426;5676.233708449472;6018.909716354171;6025.698715064317;6025.758969641341;6028.216331876828;6111.388861113853;6120.660465672032;6123.892747182578;6208.81373558794;6210.347913469021;5857.560682948882;5895.20414744004;5907.49786268172;5926.377730338252;5936.079907614327;5767.3367562729145;5916.852078697895;5970.31341395745;6018.307894592002;6036.84907877289;5778.508826749605;5800.767969281182;5805.564582656233;5836.854078648068;5891.734871930859;5800.709964501673;5813.447722466359;5813.883722325614;5814.273215848019;5820.505257053198;5451.972740136274;5643.294588176478;5711.628744131618;5735.139729040678;5736.856578585569;5896.764129434946;5904.380040095728;5938.584299099021;5946.762129514771;5947.434993675594;5755.7122143893475;5761.366249712444;5765.740541675551;5767.625104368202;5798.449147330997 05:19:03 INFO - PROCESS | 3358 | |1;ext.html;598.3986093975554;625.6027422586658;642.4571237304477;645.2611759535336;649.6719156825802;33195.33609327812;36241.27517449656;36260;36297.63702362979;36301.63698363015;42582;43254;43574;47311.29033064498;47344.76327618366;8725.258353039999;8893.644254229823;8901.465912045265;8904.910950890473;8909.910900891005;8562.315014798802;8702.086280940473;8716.041235464094;8721;8723.520206388646;8765.868511972325;8814.603342849587;8818.559072046404;8820.603072861704;8821.558922053904;8666.046734859161;8715.651373945035;8727.389082764177;8731.126887311282;8740.3444741644;8751;8817.426867253607;8828.42615230008;8839.558022098934;8850.114988501162;42181.15637687229;42440.78779606113;42489.57510424887;42506;42618.57381426177;3477.826108694555;3541.8937431877084;3657.7256705747177;3741.8129093545485;3980.144268982154;32807.50788738171;33323.3335333292;33604;33628.663713362796;33697.15757106068;3636.2000359920776;3661.5695009039096;3686.7972261525606;3764.171882185915;3808.6000969898037;327947;328955;329006;329261;329969;58110.7094464525;59005;59129.40870591239;59213;59249.70375148096;57054.7147264261;63571.36428635747;63748;63796;63882;15664.530064098095;15847.52457426279;15868.44460443879;15875.761863572056;15878.761818572731;11952.820707689392;11963.76072478563;12060.57787977434;12079.094067944763;12083.939580302042;15288.770668439982;17408.912955435397;17574.64850702979;17585.20866561008;17643.73534396985;5597.860053498695;6420.74317027323;6598.241202261705;6695.665216739241;6945.201301850251;1051.363924825485;1073.581303291717;1079.83262594298;1081.0162751895894;1120.506976930148;32621.51067733986;33095.50356744651;33275.83362083174;33301.833490832876;33361.66638333634;1082.2316155529504;1139.4473680265064;1173.0674114079327;1173.530587764901;1190.8273300371397;16945.83054169467;17067.914660426868;17142.657146857244;17289.913550432168;17440.47678569645;451943;455688;464463;473930;807518;59564.10653840196;59634.70182649059;60100.09849852256;60124.39875601188;60239;1288.3815768431205;1391.4086513231837;1407.936642851074;1439.978400323996;1532.5862017255502;29813.552796707634;31890.68109318877;34451;34463.4830477548;34716.90639467195;52832.47167528275;53456.198157028455;53717.73141134269;53774.73112634568;54017.459825401245;453592;455704;456039;456594;458531;44338.77830610827;44657.55342446534;44802.327965081204;45484.77257613691;47138.292925605456;41401.37897931594;42048.789756051025;42105.57894421017;43205;43475;40750.79624601977;40846.387304191056;41223;41414.37878431886;41463;40544.79727601461;41345.48702060006;41626.37560436656;41972.580274196866;42036.3694544576;40693.79653101716;41655.37516937188;41740;41878.79060604677;42197.789011054745;34964.82517587396;36573.817130914176;36698.082547935446;37088.686231146436;37336.25327493489;28299;28370.148895533166;29596.520173990782;30581.54127688042;30850.537241941838 05:19:03 INFO - PROCESS | 3358 | |2;jquery.html;391.24684981410775;392.31110071143735;397.9980100099499;402.18758108620585;418.51034289880835;17849.732254016184;19351.903240483796;19367;19375.70936435953;19896.10467528961;18746.906265468686;18834.246630134778;18901.52746181346;19243.230270789187;19307.131179096938;5533.501984821355;5562.554995600362;5608.6073974821775;5637;5648.181013753004;5503.669779813204;5573.804916827912;5602.551795856321;5604.299462567179;5610.775568977236;5446.128619420893;5459.890802183954;5530.5852061095375;5541.0580201365665;5571.582131340146;5511.476409741068;5540.36285827131;5550.417206193332;5563.972180139114;5575.470330318613;4718.952810471886;4998.57512111471;5007.924881126786;5043.42000669924;5049.3183420238165;19388.515287117934;21877.453063673376;22326.10228130611;22443.887780561156;22478.88760556203;2465.8767061646845;2553.616957456378;2915.9562606560917;3090.134762266569;3135.81185128893;13440.798388024188;14289.285535723173;14349.28253587327;14515.274236288249;14607.853921460863;1901.7432646592672;1942.9805701943083;1986.5728868293386;1994.351835653404;1995.4412764425983;47112.7644361776;50110.999999999636;50799.49200507985;68986.31013689899;74543.25456745418;10383.9480802597;10456.947715261527;10541.631042913614;10743.301685390425;10776;12873.549425770054;14452.494162704255;14532.491362802251;14537;14565.344559494848;7541.321281084729;7890.64492097857;7918.129005809356;7924.207579242145;8049.718259860877;7648.541087534766;7655.770326890202;7712.267334603203;7858.882116768253;7877.172896845863;6491.9350806492275;6603;6652.534322597372;6723.966380168068;6825.9317406826285;1870.2799422222542;1887.6507846048526;1905.3426567834076;1923.5768131011155;1957.6867701167744;931.725141083382;1010.0959641121156;1016.598443614768;1030.7783826477344;1081.7782354617284;19301.90349048274;19601.1179496923;19756.60486790285;19965.401037968884;20340.898295508723;998.7802683409784;1027.8098551767946;1028.280203857288;1044.070777008463;1053.7154968158554;10826.458677066274;11427.48576314068;11429.828552571718;11469.598564050219;11474.942625286987;426590;441674.24931756296;442157;445594;446505;78643;82017.58991205005;82359;82536.17463825404;83044.58477707572;1041.9010194031555;1053.3363980692268;1099.4997276239292;1114.0808832713044;1123.7303047268597;17536.298548057934;17606.119694014993;17705.822941770417;17790.91104544469;18208.36270730518;37894.242115156994;38744.03139921412;38933.41599876061;39132.60867391404;39621;53247.20129197988;53797.731011344695;56638.433615664966;62202.37797622147;63045.68477157768;7317.341439270491;7598.772036838904;7684.077910650534;8173.18268173178;8551.187637174458;9396.01341859095;10166.898331016595;12135.635930922086;13012.674683132998;13173.93413032967;11383.812532490916;11433.371164586028;11608.24546404481;11956.34240116802;11972.58095966637;11142.164337674869;11413.828792568283;11589.362585057903;11668.358240296866;11844.230125041844;11369.829452558384;11469.254498457574;11552.537898483966;11856.11079169083;12001.699957501132;7244.710211591688;7591.164971852982;7626.8093297668;7931.365490760841;8066;11095.72260693489;11305.547778089114;11595.710107247387;11654.650360489199;11862.22895511789 05:19:03 INFO - PROCESS | 3358 | |3;mootools.html;1344.468934770765;1493.1190597547445;1534.225216265786;1687.8143404225534;1836.0452564666366;8430;8703.173198546145;8761.561921903904;9025.819483610323;9065.864012039825;8804.955975220131;8952.955235223815;8973.192412682858;8973.833401657776;9025.95487022564;2026.2502873936664;2267.46714522088;2354.8351615386887;2364.408897775556;2376.536575367804;2376.66726658268;2378.4172877645;2380.2621187431864;2381.011880069778;2384.654225137354;2304.2050492580115;2329.77867102625;2330.4057465346314;2331.708536432946;2334.673145759595;1950.6878899376102;2230.687703721464;2282.7146606674164;2287.5081857400573;2289.8969546370286;2299.7010388649537;2306.5156317173246;2317.3279748872974;2319.4665226997886;2320.454693147109;8907.242884354837;8954.37319387643;8967.686130985385;8976.147266009719;8980.371374003822;5087.923681144785;5194.740262986836;5211.140161873286;5213.426523082458;5215.791368345262;3255.6093268807895;3326.933461330784;3338.6327503974544;3348.614909285439;3398.4392575225056;1053.0364716284666;1056.308118182584;1073.3398959639844;1073.983890241647;1087.6682611803396;12470.81293780585;12480.750384992249;12549.686257843627;12579.937100314532;12587.244765314019;4807.134715751198;4813.3983252093485;4883;4893.4617192108835;4927.556519913225;10380.221483388776;10408.167346612252;10421;10423.114035307084;10428.061474467335;5418.431064738224;5420.214068959979;5426.348838139448;5426.9185962210595;5434.347878254555;4362.738235705868;4776.9761151194025;4924.926126108111;4926.211806111005;4971.875703107379;4027.864738681808;4067.28822456069;4115.218108559424;4118.732282401635;4191.224623444673;1277.201748906933;1306.1248963194682;1312.534050412109;1316.9539066132638;1331.8268625078679;1001.2140469731225;1001.6444162322271;1004.3622299839508;1015.4973288222229;1017.7150397888603;5933.465988061009;6028;6081.513478921675;6146.631202127797;6245.313015568284;446.62037268322314;454.5000499450644;460.83870645273885;464.18072102738694;464.579555502271;4255.106427650228;4277.786110694453;4312.913741725148;4314.913701726011;4336.176126535948;10826.837597436044;11281.041111505614;11293.435328233556;11305.660830175108;11307.660770176908;11057.50241239146;11131.053860421793;11178.217524773188;11186.944065279622;11213.551457941754;7935.761927142195;8231.135730748305;8239.752807415787;8290.46112002718;8429.536375499283;6241;6424.325445828121;6498.935010649833;6503.187101612299;6538.9795002243745;9909.55407006672;10312.845307320546;10342.896571034193;10436.947815260875;10576.894231057591;10168.542415591464;10506.579736810441;10508.369497830156;10643.627473038407;10646.562714033505;7188.17336006366;7481.812954676177;7697.461177717506;7742.070951485858;7858.528488290721;8789.384743067923;8846.424982376126;8895.377323587545;8899.15458031486;8929.464232146092;7580.810479738051;7607.163212046781;7738.110117336579;7835.725749598737;7882.802929926568;7519.774406767806;7527.88708169367;7611.961940190264;7675.309222170032;7725.420593455401;6948.9305106950305;6978.895316570357;7013.684384202825;7016.333448322402;7025.297470252934;5212.244224587338;5226.477352264743;5324.600654950972;5372.5433338166695;5395.595330350318;5389;5420.810271640474;5451.291332126798;5602.915956260741;5626.662400255997 05:19:03 INFO - PROCESS | 3358 | |4;prototype.html;312.20232306457;317.81028712173133;321.3091852517089;322.6160868566407;323.1114435302917;5296.993571221466;5319.946800531999;5324.334458192726;5342.2253773202865;5359.517643412092;5213.2701421800975;5248.947510524894;5257.0046764459;5297.073012222855;5298.682079075258;3927.3519869221545;3958.3270843956598;4055.817488213023;4082.203970225807;4083.816228269735;4032.3145065338817;4041.3533834586474;4064.4512990746316;4074.22589707956;4081.530623978251;3917.941230881539;3993.3211354069877;4005.3190957537145;4007.4790277263915;4010.4786377770847;3956.4569817771094;4113.71204015719;4114.8148333324925;4120.835166593332;4133.648639865615;3610.8986759038485;3627.9455808162897;3628.8911332660064;3634.963650363489;3635.600083990759;5065.39215294167;5083.6441449098575;5090.338256026693;5104.412992505872;5131.255967884673;4481.574250446202;4659.347691323217;4676.7427791471455;4688.69523480976;4704.059188162347;5367.677939323653;5385.192221166856;5412.809181979958;5414.377346605152;5437.972810135924;3898.629630185128;3926.764394136361;3926.803659816998;3926.820614558919;3929.7249192556533;5325.946740532584;5665.49010589049;5691.630044047165;5711.286089238845;5717.542596592262;3920.764754114762;3939.1727737174942;3945.2504024235304;3949.8025098744947;3952.596828125974;3998.980005099956;4005.759654420744;4006.979965100156;4034.7377420467574;4045.3122969095325;4384.4081049058605;4581.266997280419;4582.358469814229;4645.837395691135;4657.953420465819;5471.261379713767;5476.288082549323;5500.772187264164;5549.250851135126;5576.884623075402;1366.3304980559653;1387.7016441464932;1387.7085811979396;1399.9080717040724;1400.649837540615;889.8920843549822;892.5180402582532;903.8644203369415;925.4354843545432;931.7810314576069;5207.557357624569;5214.69632591852;5241.711705856138;5256.9737151314;5285.233641122016;5568.972155139199;5606.383297837235;5628.324601047819;5646.181303711021;5659.320881494247;5018.372703412074;5200.271961925334;5214.13966695491;5357.142857142839;5383.892322153535;2986.5818785370066;3002.9549556756665;3004.504256797604;3005.353848922492;3061.249993751545;5639.351474580394;5859.091840764689;5867.823965281048;5879.970600147058;5881.911771323434;5715.31416230055;5735.283089613798;5739;5740.081586946152;5757.424257574209;5758.049921762862;5812.564057695689;5815.447532484407;5838.737256823369;5847.415258474119;5421.969825733098;5623.746931388179;5642.85892852682;5659.688717120598;5681.204631351531;5519;5581.804636837691;5597.944020559742;5608.4111168326735;5623.690697011703;5754.6547207167705;5778.508826749773;5786.148432501559;5838.211841401357;5878.764849406147;3735.3649879520003;3941.152652179795;3962;3982.5420076690393;3988.222296652241;5654;5678.5457163426;5684.971575142098;5686.545076393962;5704.629199102211;5203.323567936144;5434.510894019557;5471.425500322409;5473.562115030868;5520.475554822286;5397.8110766123;5437.755301011385;5461.590380721383;5461.781528738806;5463;5164.457731938242;5227.457899919609;5365.973170134124;5366.6243362964215;5397.3523177218985;5535.142052981794;5555.2778138841695;5581.134924086773;5590.161475778666;5596.272484576979;5403.648762830403;5412.215228791882;5437.972810135924;5447.673139611636;5476.67139971587 05:19:03 INFO - PROCESS | 3358 | |5;yui.html;783.8784988326811;794.3565711773464;817.3665409307787;859.4757198109153;866.4411454611771;12987.545435909746;13723.17660940343;13835.654108647288;13864.029517933735;13865.168089914612;13178.670533236675;13196.142250753719;13217.537386191485;13220.272884991322;13236.669083272924;678.0405725897849;800.4076983032543;804.6861723927673;807.9474834135792;836.9121242269534;806.0971711682923;813.3858936502961;816.2572059425923;816.3836303590781;817.9918200818005;867.3408209760596;871.0592560035146;871.1680345270252;871.4335681806813;871.4509858788954;720.1106633307861;836.0719601242616;838.5304229631425;845.750503601436;866.3632230310717;631.5768435148416;632.9936700633027;633.4045996763074;633.4235845380681;634.3212762344293;12957.222566645936;12995.155314904501;13013;13019.283939383331;13028.869711302861;12720.300383478905;12871.485140594365;12949.611511654666;13067.17949482454;13183.209007459584;10803.297785643987;10936.671899842939;11048.281861678965;11176.888231117748;11265.324080555192;4321.481422229353;4329.415528903589;4339.891502712426;4340.240457919851;4461.040876211598;59576;59595.70202149005;59748.70125649344;59753.10370344448;60077.39922600762;9488.573014214377;9519.143277105093;9639.228861691048;9674.75813104664;9695.854562181574;19897.104630291673;20122.19511219535;20206.292779752934;20223;20227.19091236334;8008.83982320362;8226.547539885243;8467.915320846836;8500.617472213766;8528.232459078712;4515.909681806345;4608.700434471749;4629.699069560468;4650.139724151043;4680.789364478606;3230.7576931730214;3326.168457885529;3353.3293341331832;3356.429407000816;3532.7350448716447;637.4517914593446;641.3105911145537;642.5405834828027;643.1285608001091;651.6285717141279;713.846522997558;714.3249629100554;714.3749219432996;726.8727972604773;733.1641928201855;8797.47215167092;8801.779955501164;8829.779255518664;8838.861144824008;9116.635334586676;632.4118569730103;716.2479396633618;716.6094478509225;726.9418446524265;739.3715341959291;4108.77401742901;4199.748015119103;4205.705600607989;4249.107687385684;4296.0978194578865;65767;68414.3158568408;69867;70233.2976670237;70415;58662;58853;59190.70404647949;59568;60149.398506015255;56155.71922140445;56288.43711562914;56586.43413565894;56989.43010569924;58089.709551451975;8307.127751586238;8351.29014033814;8392.706255281037;8538.146185381413;8596.226339629464;35623.28753424969;36887.44668829916;37373.81313093526;37406.62593374032;37585;47186.76406617945;50934;51031;51205;52259;11129.944350278196;11391.316521008766;11451.25566838153;11456.828147577626;11683.123765717435;11248.151449213932;11446.37044962535;11568.305901645928;11575.305481671126;12060.155789094679;11580.36308003068;11840.28958262507;11883.821742673694;11900.464479098635;12157.939210303892;10969.122470202205;10992.835107473555;11307;11342.035926946302;11361.318320900773;11388.37363944991;11403.429828508375;11454.198206125491;11725.296482211095;11863.703407414883;8972.461652300883;9202.769930751518;9227.677031303872;9449.858252126362;9557.139857412867;9053.68312109073;9188.724338269863;9801.16690081351;9813.901860981585;9846.803063938825 05:19:03 INFO - PROCESS | 3358 | __end_tp_report 05:19:03 INFO - PROCESS | 3358 | __start_cc_report 05:19:03 INFO - PROCESS | 3358 | _x_x_mozilla_cycle_collect,934 05:19:03 INFO - PROCESS | 3358 | __end_cc_report 05:19:03 INFO - PROCESS | 3358 | __startTimestamp1464178743622__endTimestamp 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | ------- Summary: start ------- 05:19:03 INFO - PROCESS | 3358 | Number of tests: 6 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#0] dojo.html Cycles:165 Average:5504.30 Median:5729.23 stddev:644.00 (11.2%) stddev-sans-first:619.01 05:19:03 INFO - PROCESS | 3358 | Values: 3153.6 3155.5 3189.0 3204.0 3222.0 5295.6 5339.6 5459.2 5547.9 5558.7 5501.1 5504.1 5507.1 5560.6 5589.4 4955.6 4988.4 5040.3 5055.6 5200.0 5096.9 5121.5 5136.1 5165.2 5172.1 4846.2 4943.2 4986.4 5008.5 5019.7 5003.2 5008.6 5085.2 5099.0 5120.2 4870.1 5027.3 5045.7 5053.7 5062.0 5389.8 5450.0 5450.9 5505.6 5546.1 5934.0 5946.5 5965.1 5991.2 6006.4 5709.5 5846.6 5995.9 6032.3 6034.1 5532.0 5635.1 5636.4 5636.9 5638.3 6126.1 6138.4 6139.4 6141.8 6143.5 5585.7 5729.2 5779.4 5898.6 5910.3 5874.5 5885.4 5940.7 5949.4 5961.2 5784.8 5800.9 5806.1 5830.3 5871.7 5611.2 5818.0 5872.2 5885.1 5889.4 4455.7 4462.6 4462.7 4464.2 4496.3 3941.5 3975.2 4002.1 4037.0 4037.0 5374.1 5429.3 5490.7 5564.5 5565.2 5978.4 6008.7 6010.7 6012.2 6069.5 5563.1 5583.2 5583.8 5584.9 5589.2 4972.7 5084.6 5123.0 5134.2 5135.6 6216.1 6230.1 6231.0 6232.8 6233.9 5676.2 6018.9 6025.7 6025.8 6028.2 6111.4 6120.7 6123.9 6208.8 6210.3 5857.6 5895.2 5907.5 5926.4 5936.1 5767.3 5916.9 5970.3 6018.3 6036.8 5778.5 5800.8 5805.6 5836.9 5891.7 5800.7 5813.4 5813.9 5814.3 5820.5 5452.0 5643.3 5711.6 5735.1 5736.9 5896.8 5904.4 5938.6 5946.8 5947.4 5755.7 5761.4 5765.7 5767.6 5798.4 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#1] ext.html Cycles:180 Average:60428.61 Median:41697.69 stddev:120587.48 (289.2%) stddev-sans-first:120842.09 05:19:03 INFO - PROCESS | 3358 | Values: 598.4 625.6 642.5 645.3 649.7 33195.3 36241.3 36260.0 36297.6 36301.6 42582.0 43254.0 43574.0 47311.3 47344.8 8725.3 8893.6 8901.5 8904.9 8909.9 8562.3 8702.1 8716.0 8721.0 8723.5 8765.9 8814.6 8818.6 8820.6 8821.6 8666.0 8715.7 8727.4 8731.1 8740.3 8751.0 8817.4 8828.4 8839.6 8850.1 42181.2 42440.8 42489.6 42506.0 42618.6 3477.8 3541.9 3657.7 3741.8 3980.1 32807.5 33323.3 33604.0 33628.7 33697.2 3636.2 3661.6 3686.8 3764.2 3808.6 327947.0 328955.0 329006.0 329261.0 329969.0 58110.7 59005.0 59129.4 59213.0 59249.7 57054.7 63571.4 63748.0 63796.0 63882.0 15664.5 15847.5 15868.4 15875.8 15878.8 11952.8 11963.8 12060.6 12079.1 12083.9 15288.8 17408.9 17574.6 17585.2 17643.7 5597.9 6420.7 6598.2 6695.7 6945.2 1051.4 1073.6 1079.8 1081.0 1120.5 32621.5 33095.5 33275.8 33301.8 33361.7 1082.2 1139.4 1173.1 1173.5 1190.8 16945.8 17067.9 17142.7 17289.9 17440.5 451943.0 455688.0 464463.0 473930.0 807518.0 59564.1 59634.7 60100.1 60124.4 60239.0 1288.4 1391.4 1407.9 1440.0 1532.6 29813.6 31890.7 34451.0 34463.5 34716.9 52832.5 53456.2 53717.7 53774.7 54017.5 453592.0 455704.0 456039.0 456594.0 458531.0 44338.8 44657.6 44802.3 45484.8 47138.3 41401.4 42048.8 42105.6 43205.0 43475.0 40750.8 40846.4 41223.0 41414.4 41463.0 40544.8 41345.5 41626.4 41972.6 42036.4 40693.8 41655.4 41740.0 41878.8 42197.8 34964.8 36573.8 36698.1 37088.7 37336.3 28299.0 28370.1 29596.5 30581.5 30850.5 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#2] jquery.html Cycles:180 Average:26615.69 Median:22461.39 stddev:72341.11 (322.1%) stddev-sans-first:72517.25 05:19:03 INFO - PROCESS | 3358 | Values: 391.2 392.3 398.0 402.2 418.5 17849.7 19351.9 19367.0 19375.7 19896.1 18746.9 18834.2 18901.5 19243.2 19307.1 5533.5 5562.6 5608.6 5637.0 5648.2 5503.7 5573.8 5602.6 5604.3 5610.8 5446.1 5459.9 5530.6 5541.1 5571.6 5511.5 5540.4 5550.4 5564.0 5575.5 4719.0 4998.6 5007.9 5043.4 5049.3 19388.5 21877.5 22326.1 22443.9 22478.9 2465.9 2553.6 2916.0 3090.1 3135.8 13440.8 14289.3 14349.3 14515.3 14607.9 1901.7 1943.0 1986.6 1994.4 1995.4 47112.8 50111.0 50799.5 68986.3 74543.3 10383.9 10456.9 10541.6 10743.3 10776.0 12873.5 14452.5 14532.5 14537.0 14565.3 7541.3 7890.6 7918.1 7924.2 8049.7 7648.5 7655.8 7712.3 7858.9 7877.2 6491.9 6603.0 6652.5 6724.0 6825.9 1870.3 1887.7 1905.3 1923.6 1957.7 931.7 1010.1 1016.6 1030.8 1081.8 19301.9 19601.1 19756.6 19965.4 20340.9 998.8 1027.8 1028.3 1044.1 1053.7 10826.5 11427.5 11429.8 11469.6 11474.9 426590.0 441674.2 442157.0 445594.0 446505.0 78643.0 82017.6 82359.0 82536.2 83044.6 1041.9 1053.3 1099.5 1114.1 1123.7 17536.3 17606.1 17705.8 17790.9 18208.4 37894.2 38744.0 38933.4 39132.6 39621.0 53247.2 53797.7 56638.4 62202.4 63045.7 7317.3 7598.8 7684.1 8173.2 8551.2 9396.0 10166.9 12135.6 13012.7 13173.9 11383.8 11433.4 11608.2 11956.3 11972.6 11142.2 11413.8 11589.4 11668.4 11844.2 11369.8 11469.3 11552.5 11856.1 12001.7 7244.7 7591.2 7626.8 7931.4 8066.0 11095.7 11305.5 11595.7 11654.7 11862.2 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#3] mootools.html Cycles:180 Average:5891.87 Median:450.56 stddev:3385.85 (751.5%) stddev-sans-first:3378.10 05:19:03 INFO - PROCESS | 3358 | Values: 1344.5 1493.1 1534.2 1687.8 1836.0 8430.0 8703.2 8761.6 9025.8 9065.9 8805.0 8953.0 8973.2 8973.8 9026.0 2026.3 2267.5 2354.8 2364.4 2376.5 2376.7 2378.4 2380.3 2381.0 2384.7 2304.2 2329.8 2330.4 2331.7 2334.7 1950.7 2230.7 2282.7 2287.5 2289.9 2299.7 2306.5 2317.3 2319.5 2320.5 8907.2 8954.4 8967.7 8976.1 8980.4 5087.9 5194.7 5211.1 5213.4 5215.8 3255.6 3326.9 3338.6 3348.6 3398.4 1053.0 1056.3 1073.3 1074.0 1087.7 12470.8 12480.8 12549.7 12579.9 12587.2 4807.1 4813.4 4883.0 4893.5 4927.6 10380.2 10408.2 10421.0 10423.1 10428.1 5418.4 5420.2 5426.3 5426.9 5434.3 4362.7 4777.0 4924.9 4926.2 4971.9 4027.9 4067.3 4115.2 4118.7 4191.2 1277.2 1306.1 1312.5 1317.0 1331.8 1001.2 1001.6 1004.4 1015.5 1017.7 5933.5 6028.0 6081.5 6146.6 6245.3 446.6 454.5 460.8 464.2 464.6 4255.1 4277.8 4312.9 4314.9 4336.2 10826.8 11281.0 11293.4 11305.7 11307.7 11057.5 11131.1 11178.2 11186.9 11213.6 7935.8 8231.1 8239.8 8290.5 8429.5 6241.0 6424.3 6498.9 6503.2 6539.0 9909.6 10312.8 10342.9 10436.9 10576.9 10168.5 10506.6 10508.4 10643.6 10646.6 7188.2 7481.8 7697.5 7742.1 7858.5 8789.4 8846.4 8895.4 8899.2 8929.5 7580.8 7607.2 7738.1 7835.7 7882.8 7519.8 7527.9 7612.0 7675.3 7725.4 6948.9 6978.9 7013.7 7016.3 7025.3 5212.2 5226.5 5324.6 5372.5 5395.6 5389.0 5420.8 5451.3 5602.9 5626.7 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#4] prototype.html Cycles:180 Average:4610.77 Median:5297.88 stddev:1366.23 (25.8%) stddev-sans-first:1331.42 05:19:03 INFO - PROCESS | 3358 | Values: 312.2 317.8 321.3 322.6 323.1 5297.0 5319.9 5324.3 5342.2 5359.5 5213.3 5248.9 5257.0 5297.1 5298.7 3927.4 3958.3 4055.8 4082.2 4083.8 4032.3 4041.4 4064.5 4074.2 4081.5 3917.9 3993.3 4005.3 4007.5 4010.5 3956.5 4113.7 4114.8 4120.8 4133.6 3610.9 3627.9 3628.9 3635.0 3635.6 5065.4 5083.6 5090.3 5104.4 5131.3 4481.6 4659.3 4676.7 4688.7 4704.1 5367.7 5385.2 5412.8 5414.4 5438.0 3898.6 3926.8 3926.8 3926.8 3929.7 5325.9 5665.5 5691.6 5711.3 5717.5 3920.8 3939.2 3945.3 3949.8 3952.6 3999.0 4005.8 4007.0 4034.7 4045.3 4384.4 4581.3 4582.4 4645.8 4658.0 5471.3 5476.3 5500.8 5549.3 5576.9 1366.3 1387.7 1387.7 1399.9 1400.6 889.9 892.5 903.9 925.4 931.8 5207.6 5214.7 5241.7 5257.0 5285.2 5569.0 5606.4 5628.3 5646.2 5659.3 5018.4 5200.3 5214.1 5357.1 5383.9 2986.6 3003.0 3004.5 3005.4 3061.2 5639.4 5859.1 5867.8 5880.0 5881.9 5715.3 5735.3 5739.0 5740.1 5757.4 5758.0 5812.6 5815.4 5838.7 5847.4 5422.0 5623.7 5642.9 5659.7 5681.2 5519.0 5581.8 5597.9 5608.4 5623.7 5754.7 5778.5 5786.1 5838.2 5878.8 3735.4 3941.2 3962.0 3982.5 3988.2 5654.0 5678.5 5685.0 5686.5 5704.6 5203.3 5434.5 5471.4 5473.6 5520.5 5397.8 5437.8 5461.6 5461.8 5463.0 5164.5 5227.5 5366.0 5366.6 5397.4 5535.1 5555.3 5581.1 5590.2 5596.3 5403.6 5412.2 5438.0 5447.7 5476.7 05:19:03 INFO - PROCESS | 3358 | 05:19:03 INFO - PROCESS | 3358 | [#5] yui.html Cycles:180 Average:15316.41 Median:58757.50 stddev:19057.52 (32.4%) stddev-sans-first:19079.73 05:19:03 INFO - PROCESS | 3358 | Values: 783.9 794.4 817.4 859.5 866.4 12987.5 13723.2 13835.7 13864.0 13865.2 13178.7 13196.1 13217.5 13220.3 13236.7 678.0 800.4 804.7 807.9 836.9 806.1 813.4 816.3 816.4 818.0 867.3 871.1 871.2 871.4 871.5 720.1 836.1 838.5 845.8 866.4 631.6 633.0 633.4 633.4 634.3 12957.2 12995.2 13013.0 13019.3 13028.9 12720.3 12871.5 12949.6 13067.2 13183.2 10803.3 10936.7 11048.3 11176.9 11265.3 4321.5 4329.4 4339.9 4340.2 4461.0 59576.0 59595.7 59748.7 59753.1 60077.4 9488.6 9519.1 9639.2 9674.8 9695.9 19897.1 20122.2 20206.3 20223.0 20227.2 8008.8 8226.5 8467.9 8500.6 8528.2 4515.9 4608.7 4629.7 4650.1 4680.8 3230.8 3326.2 3353.3 3356.4 3532.7 637.5 641.3 642.5 643.1 651.6 713.8 714.3 714.4 726.9 733.2 8797.5 8801.8 8829.8 8838.9 9116.6 632.4 716.2 716.6 726.9 739.4 4108.8 4199.7 4205.7 4249.1 4296.1 65767.0 68414.3 69867.0 70233.3 70415.0 58662.0 58853.0 59190.7 59568.0 60149.4 56155.7 56288.4 56586.4 56989.4 58089.7 8307.1 8351.3 8392.7 8538.1 8596.2 35623.3 36887.4 37373.8 37406.6 37585.0 47186.8 50934.0 51031.0 51205.0 52259.0 11129.9 11391.3 11451.3 11456.8 11683.1 11248.2 11446.4 11568.3 11575.3 12060.2 11580.4 11840.3 11883.8 11900.5 12157.9 10969.1 10992.8 11307.0 11342.0 11361.3 11388.4 11403.4 11454.2 11725.3 11863.7 8972.5 9202.8 9227.7 9449.9 9557.1 9053.7 9188.7 9801.2 9813.9 9846.8 05:19:03 INFO - PROCESS | 3358 | -------- Summary: end -------- 05:19:03 INFO - PROCESS | 3358 | 05:19:04 INFO - TEST-INFO | 3358: exit 0 05:19:04 INFO - TEST-OK | dromaeo_css | took 1115139ms 05:19:04 INFO - TEST-START | kraken 05:19:04 INFO - operating with platform_type : linux_ 05:19:04 INFO - Initialising browser for kraken test... 05:19:04 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRbVaIy/profile http://localhost:33932/getInfo.html) 05:19:08 INFO - PROCESS | 3545 | __metrics Screen width/height:1600/1200 05:19:08 INFO - PROCESS | 3545 | colorDepth:24 05:19:08 INFO - PROCESS | 3545 | Browser inner width/height: 1024/697 05:19:08 INFO - PROCESS | 3545 | __metrics 05:19:09 ERROR - PROCESS | 3545 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:19:10 INFO - TEST-INFO | 3545: exit 0 05:19:10 INFO - Browser initialized. 05:19:10 INFO - Running cycle 1/1 for kraken test... 05:19:10 INFO - TEST-INFO | started process 3627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRbVaIy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:22 INFO - PROCESS | 3627 | RSS: Main: 153337856 05:19:22 INFO - PROCESS | 3627 | 05:19:24 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33932/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:25 INFO - PROCESS | 3627 | RSS: Main: 209633280 05:19:25 INFO - PROCESS | 3627 | 05:19:28 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33932/tests/kraken/driver.html?testName=audio-dft) 05:19:28 INFO - PROCESS | 3627 | RSS: Main: 197701632 05:19:28 INFO - PROCESS | 3627 | 05:19:32 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33932/tests/kraken/driver.html?testName=audio-fft) 05:19:32 INFO - PROCESS | 3627 | RSS: Main: 265515008 05:19:32 INFO - PROCESS | 3627 | 05:19:34 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33932/tests/kraken/driver.html?testName=audio-oscillator) 05:19:35 INFO - PROCESS | 3627 | RSS: Main: 174247936 05:19:35 INFO - PROCESS | 3627 | 05:19:37 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:38 INFO - PROCESS | 3627 | RSS: Main: 178872320 05:19:38 INFO - PROCESS | 3627 | 05:19:41 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33932/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:41 INFO - PROCESS | 3627 | RSS: Main: 215715840 05:19:41 INFO - PROCESS | 3627 | 05:19:45 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33932/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:45 INFO - PROCESS | 3627 | RSS: Main: 215048192 05:19:45 INFO - PROCESS | 3627 | 05:19:48 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33932/tests/kraken/driver.html?testName=json-parse-financial) 05:19:49 INFO - PROCESS | 3627 | RSS: Main: 216109056 05:19:49 INFO - PROCESS | 3627 | 05:19:50 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:51 INFO - PROCESS | 3627 | RSS: Main: 202821632 05:19:51 INFO - PROCESS | 3627 | 05:19:52 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:53 INFO - PROCESS | 3627 | RSS: Main: 205959168 05:19:53 INFO - PROCESS | 3627 | 05:19:55 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:56 INFO - PROCESS | 3627 | RSS: Main: 216797184 05:19:56 INFO - PROCESS | 3627 | 05:19:58 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:59 INFO - PROCESS | 3627 | RSS: Main: 225710080 05:19:59 INFO - PROCESS | 3627 | 05:20:02 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:02 INFO - PROCESS | 3627 | RSS: Main: 221433856 05:20:02 INFO - PROCESS | 3627 | 05:20:04 INFO - PROCESS | 3627 | Cycle 1(1): loaded http://localhost:33932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33932/tests/kraken/driver.html?testName=ai-astar) 05:20:05 INFO - PROCESS | 3627 | RSS: Main: 267190272 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | __start_tp_report 05:20:05 INFO - PROCESS | 3627 | _x_x_mozilla_page_load 05:20:05 INFO - PROCESS | 3627 | _x_x_mozilla_page_load_details 05:20:05 INFO - PROCESS | 3627 | |i|pagename|runs| 05:20:05 INFO - PROCESS | 3627 | |0;ai-astar;109;103;110;109;110;111;109;110;111;111 05:20:05 INFO - PROCESS | 3627 | |1;audio-beat-detection;154;132;129;177;127;137;129;163;166;135 05:20:05 INFO - PROCESS | 3627 | |2;audio-dft;161;159;159;160;159;160;161;159;161;161 05:20:05 INFO - PROCESS | 3627 | |3;audio-fft;73;74;74;106;76;75;74;73;97;76 05:20:05 INFO - PROCESS | 3627 | |4;audio-oscillator;83;83;122;83;90;82;116;82;83;130 05:20:05 INFO - PROCESS | 3627 | |5;imaging-gaussian-blur;117;117;116;116;116;117;118;117;116;117 05:20:05 INFO - PROCESS | 3627 | |6;imaging-darkroom;146;146;146;146;146;146;145;145;145;145 05:20:05 INFO - PROCESS | 3627 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;96;95 05:20:05 INFO - PROCESS | 3627 | |8;json-parse-financial;55;56;55;56;56;55;55;70;52;53 05:20:05 INFO - PROCESS | 3627 | |9;json-stringify-tinderbox;62;63;62;62;62;62;68;62;61;62 05:20:05 INFO - PROCESS | 3627 | |10;stanford-crypto-aes;79;78;79;80;80;81;80;80;80;82 05:20:05 INFO - PROCESS | 3627 | |11;stanford-crypto-ccm;119;123;131;122;127;119;126;123;178;132 05:20:05 INFO - PROCESS | 3627 | |12;stanford-crypto-pbkdf2;164;162;162;157;157;157;163;166;162;159 05:20:05 INFO - PROCESS | 3627 | |13;stanford-crypto-sha256-iterative;67;63;64;63;65;62;63;61;60;61 05:20:05 INFO - PROCESS | 3627 | __end_tp_report 05:20:05 INFO - PROCESS | 3627 | __start_cc_report 05:20:05 INFO - PROCESS | 3627 | _x_x_mozilla_cycle_collect,1648 05:20:05 INFO - PROCESS | 3627 | __end_cc_report 05:20:05 INFO - PROCESS | 3627 | __startTimestamp1464178805097__endTimestamp 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | ------- Summary: start ------- 05:20:05 INFO - PROCESS | 3627 | Number of tests: 14 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.36 (2.1%) stddev-sans-first:2.50 05:20:05 INFO - PROCESS | 3627 | Values: 109.0 103.0 110.0 109.0 110.0 111.0 109.0 110.0 111.0 111.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:145.50 stddev:18.38 (12.6%) stddev-sans-first:19.19 05:20:05 INFO - PROCESS | 3627 | Values: 154.0 132.0 129.0 177.0 127.0 137.0 129.0 163.0 166.0 135.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 05:20:05 INFO - PROCESS | 3627 | Values: 161.0 159.0 159.0 160.0 159.0 160.0 161.0 159.0 161.0 161.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.50 stddev:11.68 (15.7%) stddev-sans-first:12.13 05:20:05 INFO - PROCESS | 3627 | Values: 73.0 74.0 74.0 106.0 76.0 75.0 74.0 73.0 97.0 76.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:83.00 stddev:19.24 (23.2%) stddev-sans-first:19.88 05:20:05 INFO - PROCESS | 3627 | Values: 83.0 83.0 122.0 83.0 90.0 82.0 116.0 82.0 83.0 130.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:20:05 INFO - PROCESS | 3627 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 118.0 117.0 116.0 117.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:20:05 INFO - PROCESS | 3627 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:20:05 INFO - PROCESS | 3627 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:4.99 (9.0%) stddev-sans-first:5.27 05:20:05 INFO - PROCESS | 3627 | Values: 55.0 56.0 55.0 56.0 56.0 55.0 55.0 70.0 52.0 53.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:1.96 (3.2%) stddev-sans-first:2.06 05:20:05 INFO - PROCESS | 3627 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 68.0 62.0 61.0 62.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.10 (1.4%) stddev-sans-first:1.12 05:20:05 INFO - PROCESS | 3627 | Values: 79.0 78.0 79.0 80.0 80.0 81.0 80.0 80.0 80.0 82.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:126.50 stddev:17.44 (13.8%) stddev-sans-first:18.04 05:20:05 INFO - PROCESS | 3627 | Values: 119.0 123.0 131.0 122.0 127.0 119.0 126.0 123.0 178.0 132.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:3.21 (2.0%) stddev-sans-first:3.21 05:20:05 INFO - PROCESS | 3627 | Values: 164.0 162.0 162.0 157.0 157.0 157.0 163.0 166.0 162.0 159.0 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - PROCESS | 3627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.08 (3.3%) stddev-sans-first:1.59 05:20:05 INFO - PROCESS | 3627 | Values: 67.0 63.0 64.0 63.0 65.0 62.0 63.0 61.0 60.0 61.0 05:20:05 INFO - PROCESS | 3627 | -------- Summary: end -------- 05:20:05 INFO - PROCESS | 3627 | 05:20:05 INFO - TEST-INFO | 3627: exit 0 05:20:06 INFO - TEST-OK | kraken | took 61691ms 05:20:06 INFO - SUITE-END | took 1176s 05:20:06 INFO - Completed test suite (00:19:37) 05:20:06 INFO - javascript benchmark 05:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.6057992750907, 3155.54244634528, 3189.0273466592694, 3204.006757905051, 3221.967780322196, 5295.629305948585, 5339.6262261641705, 5459.181122831572, 5547.916781248279, 5558.666480011197, 5501.0648189807725, 5504.119340905456, 5507.091329930567, 5560.582956278286, 5589.357223919251, 4955.554000139987, 4988.351514303135, 5040.319556859814, 5055.5702765265, 5199.974000129994, 5096.923546146792, 5121.5390614844655, 5136.075506408845, 5165.199394093903, 5172.12073947428, 4846.224604063351, 4943.233798761198, 4986.351774269358, 5008.524190201925, 5019.67372120811, 5003.199488081926, 5008.649394542384, 5085.186370180753, 5098.974505127488, 5120.206368012964, 4870.123377791996, 5027.296178535008, 5045.697258164522, 5053.6967781932835, 5062.0, 5389.83830485086, 5450.04624190765, 5450.945490545084, 5505.614606977473, 5546.140348246028, 5934.0, 5946.464818166386, 5965.075413310944, 5991.161237426763, 6006.429389208019, 5709.457601527848, 5846.649201047951, 5995.940040599626, 6032.306284777263, 6034.064719968368, 5532.0, 5635.070213414822, 5636.436356364413, 5636.859078523029, 5638.2670252866865, 6126.068514845503, 6138.386161383826, 6139.447449729546, 6141.806260744388, 6143.477804386677, 5585.664860108325, 5729.2265544151005, 5779.393163717833, 5898.646081235054, 5910.320313164041, 5874.530037596982, 5885.440883116097, 5940.673262970492, 5949.405059494103, 5961.195238642815, 5784.797532086357, 5800.941990580124, 5806.071028635398, 5830.271216097988, 5871.706414679249, 5611.242482264924, 5818.010938140526, 5872.236609240771, 5885.087811389241, 5889.411058894162, 4455.732656040648, 4462.576055274743, 4462.665300102505, 4464.196444639931, 4496.258117410656, 3941.52701675795, 3975.224831157954, 4002.0595160137345, 4036.9596304036586, 4037.0, 5374.059539580558, 5429.348478182565, 5490.670559766347, 5564.4991950724625, 5565.193047008162, 5978.402159784074, 6008.7296071676, 6010.699465026732, 6012.158297838306, 6069.51443884497, 5563.082091454865, 5583.218349431083, 5583.776648934078, 5584.944150558524, 5589.245451863946, 4972.676776009548, 5084.618653600995, 5122.974385128051, 5134.204198349262, 5135.563477104488, 6216.067589861557, 6230.096635987757, 6230.968845155745, 6232.75068997235, 6233.937660623426, 5676.233708449472, 6018.909716354171, 6025.698715064317, 6025.758969641341, 6028.216331876828, 6111.388861113853, 6120.660465672032, 6123.892747182578, 6208.81373558794, 6210.347913469021, 5857.560682948882, 5895.20414744004, 5907.49786268172, 5926.377730338252, 5936.079907614327, 5767.3367562729145, 5916.852078697895, 5970.31341395745, 6018.307894592002, 6036.84907877289, 5778.508826749605, 5800.767969281182, 5805.564582656233, 5836.854078648068, 5891.734871930859, 5800.709964501673, 5813.447722466359, 5813.883722325614, 5814.273215848019, 5820.505257053198, 5451.972740136274, 5643.294588176478, 5711.628744131618, 5735.139729040678, 5736.856578585569, 5896.764129434946, 5904.380040095728, 5938.584299099021, 5946.762129514771, 5947.434993675594, 5755.7122143893475, 5761.366249712444, 5765.740541675551, 5767.625104368202, 5798.449147330997], "value": 5459.741727342614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3986093975554, 625.6027422586658, 642.4571237304477, 645.2611759535336, 649.6719156825802, 33195.33609327812, 36241.27517449656, 36260.0, 36297.63702362979, 36301.63698363015, 42582.0, 43254.0, 43574.0, 47311.29033064498, 47344.76327618366, 8725.258353039999, 8893.644254229823, 8901.465912045265, 8904.910950890473, 8909.910900891005, 8562.315014798802, 8702.086280940473, 8716.041235464094, 8721.0, 8723.520206388646, 8765.868511972325, 8814.603342849587, 8818.559072046404, 8820.603072861704, 8821.558922053904, 8666.046734859161, 8715.651373945035, 8727.389082764177, 8731.126887311282, 8740.3444741644, 8751.0, 8817.426867253607, 8828.42615230008, 8839.558022098934, 8850.114988501162, 42181.15637687229, 42440.78779606113, 42489.57510424887, 42506.0, 42618.57381426177, 3477.826108694555, 3541.8937431877084, 3657.7256705747177, 3741.8129093545485, 3980.144268982154, 32807.50788738171, 33323.3335333292, 33604.0, 33628.663713362796, 33697.15757106068, 3636.2000359920776, 3661.5695009039096, 3686.7972261525606, 3764.171882185915, 3808.6000969898037, 327947.0, 328955.0, 329006.0, 329261.0, 329969.0, 58110.7094464525, 59005.0, 59129.40870591239, 59213.0, 59249.70375148096, 57054.7147264261, 63571.36428635747, 63748.0, 63796.0, 63882.0, 15664.530064098095, 15847.52457426279, 15868.44460443879, 15875.761863572056, 15878.761818572731, 11952.820707689392, 11963.76072478563, 12060.57787977434, 12079.094067944763, 12083.939580302042, 15288.770668439982, 17408.912955435397, 17574.64850702979, 17585.20866561008, 17643.73534396985, 5597.860053498695, 6420.74317027323, 6598.241202261705, 6695.665216739241, 6945.201301850251, 1051.363924825485, 1073.581303291717, 1079.83262594298, 1081.0162751895894, 1120.506976930148, 32621.51067733986, 33095.50356744651, 33275.83362083174, 33301.833490832876, 33361.66638333634, 1082.2316155529504, 1139.4473680265064, 1173.0674114079327, 1173.530587764901, 1190.8273300371397, 16945.83054169467, 17067.914660426868, 17142.657146857244, 17289.913550432168, 17440.47678569645, 451943.0, 455688.0, 464463.0, 473930.0, 807518.0, 59564.10653840196, 59634.70182649059, 60100.09849852256, 60124.39875601188, 60239.0, 1288.3815768431205, 1391.4086513231837, 1407.936642851074, 1439.978400323996, 1532.5862017255502, 29813.552796707634, 31890.68109318877, 34451.0, 34463.4830477548, 34716.90639467195, 52832.47167528275, 53456.198157028455, 53717.73141134269, 53774.73112634568, 54017.459825401245, 453592.0, 455704.0, 456039.0, 456594.0, 458531.0, 44338.77830610827, 44657.55342446534, 44802.327965081204, 45484.77257613691, 47138.292925605456, 41401.37897931594, 42048.789756051025, 42105.57894421017, 43205.0, 43475.0, 40750.79624601977, 40846.387304191056, 41223.0, 41414.37878431886, 41463.0, 40544.79727601461, 41345.48702060006, 41626.37560436656, 41972.580274196866, 42036.3694544576, 40693.79653101716, 41655.37516937188, 41740.0, 41878.79060604677, 42197.789011054745, 34964.82517587396, 36573.817130914176, 36698.082547935446, 37088.686231146436, 37336.25327493489, 28299.0, 28370.148895533166, 29596.520173990782, 30581.54127688042, 30850.537241941838], "value": 20202.48769822559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.24684981410775, 392.31110071143735, 397.9980100099499, 402.18758108620585, 418.51034289880835, 17849.732254016184, 19351.903240483796, 19367.0, 19375.70936435953, 19896.10467528961, 18746.906265468686, 18834.246630134778, 18901.52746181346, 19243.230270789187, 19307.131179096938, 5533.501984821355, 5562.554995600362, 5608.6073974821775, 5637.0, 5648.181013753004, 5503.669779813204, 5573.804916827912, 5602.551795856321, 5604.299462567179, 5610.775568977236, 5446.128619420893, 5459.890802183954, 5530.5852061095375, 5541.0580201365665, 5571.582131340146, 5511.476409741068, 5540.36285827131, 5550.417206193332, 5563.972180139114, 5575.470330318613, 4718.952810471886, 4998.57512111471, 5007.924881126786, 5043.42000669924, 5049.3183420238165, 19388.515287117934, 21877.453063673376, 22326.10228130611, 22443.887780561156, 22478.88760556203, 2465.8767061646845, 2553.616957456378, 2915.9562606560917, 3090.134762266569, 3135.81185128893, 13440.798388024188, 14289.285535723173, 14349.28253587327, 14515.274236288249, 14607.853921460863, 1901.7432646592672, 1942.9805701943083, 1986.5728868293386, 1994.351835653404, 1995.4412764425983, 47112.7644361776, 50110.999999999636, 50799.49200507985, 68986.31013689899, 74543.25456745418, 10383.9480802597, 10456.947715261527, 10541.631042913614, 10743.301685390425, 10776.0, 12873.549425770054, 14452.494162704255, 14532.491362802251, 14537.0, 14565.344559494848, 7541.321281084729, 7890.64492097857, 7918.129005809356, 7924.207579242145, 8049.718259860877, 7648.541087534766, 7655.770326890202, 7712.267334603203, 7858.882116768253, 7877.172896845863, 6491.9350806492275, 6603.0, 6652.534322597372, 6723.966380168068, 6825.9317406826285, 1870.2799422222542, 1887.6507846048526, 1905.3426567834076, 1923.5768131011155, 1957.6867701167744, 931.725141083382, 1010.0959641121156, 1016.598443614768, 1030.7783826477344, 1081.7782354617284, 19301.90349048274, 19601.1179496923, 19756.60486790285, 19965.401037968884, 20340.898295508723, 998.7802683409784, 1027.8098551767946, 1028.280203857288, 1044.070777008463, 1053.7154968158554, 10826.458677066274, 11427.48576314068, 11429.828552571718, 11469.598564050219, 11474.942625286987, 426590.0, 441674.24931756296, 442157.0, 445594.0, 446505.0, 78643.0, 82017.58991205005, 82359.0, 82536.17463825404, 83044.58477707572, 1041.9010194031555, 1053.3363980692268, 1099.4997276239292, 1114.0808832713044, 1123.7303047268597, 17536.298548057934, 17606.119694014993, 17705.822941770417, 17790.91104544469, 18208.36270730518, 37894.242115156994, 38744.03139921412, 38933.41599876061, 39132.60867391404, 39621.0, 53247.20129197988, 53797.731011344695, 56638.433615664966, 62202.37797622147, 63045.68477157768, 7317.341439270491, 7598.772036838904, 7684.077910650534, 8173.18268173178, 8551.187637174458, 9396.01341859095, 10166.898331016595, 12135.635930922086, 13012.674683132998, 13173.93413032967, 11383.812532490916, 11433.371164586028, 11608.24546404481, 11956.34240116802, 11972.58095966637, 11142.164337674869, 11413.828792568283, 11589.362585057903, 11668.358240296866, 11844.230125041844, 11369.829452558384, 11469.254498457574, 11552.537898483966, 11856.11079169083, 12001.699957501132, 7244.710211591688, 7591.164971852982, 7626.8093297668, 7931.365490760841, 8066.0, 11095.72260693489, 11305.547778089114, 11595.710107247387, 11654.650360489199, 11862.22895511789], "value": 9128.043607151714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.468934770765, 1493.1190597547445, 1534.225216265786, 1687.8143404225534, 1836.0452564666366, 8430.0, 8703.173198546145, 8761.561921903904, 9025.819483610323, 9065.864012039825, 8804.955975220131, 8952.955235223815, 8973.192412682858, 8973.833401657776, 9025.95487022564, 2026.2502873936664, 2267.46714522088, 2354.8351615386887, 2364.408897775556, 2376.536575367804, 2376.66726658268, 2378.4172877645, 2380.2621187431864, 2381.011880069778, 2384.654225137354, 2304.2050492580115, 2329.77867102625, 2330.4057465346314, 2331.708536432946, 2334.673145759595, 1950.6878899376102, 2230.687703721464, 2282.7146606674164, 2287.5081857400573, 2289.8969546370286, 2299.7010388649537, 2306.5156317173246, 2317.3279748872974, 2319.4665226997886, 2320.454693147109, 8907.242884354837, 8954.37319387643, 8967.686130985385, 8976.147266009719, 8980.371374003822, 5087.923681144785, 5194.740262986836, 5211.140161873286, 5213.426523082458, 5215.791368345262, 3255.6093268807895, 3326.933461330784, 3338.6327503974544, 3348.614909285439, 3398.4392575225056, 1053.0364716284666, 1056.308118182584, 1073.3398959639844, 1073.983890241647, 1087.6682611803396, 12470.81293780585, 12480.750384992249, 12549.686257843627, 12579.937100314532, 12587.244765314019, 4807.134715751198, 4813.3983252093485, 4883.0, 4893.4617192108835, 4927.556519913225, 10380.221483388776, 10408.167346612252, 10421.0, 10423.114035307084, 10428.061474467335, 5418.431064738224, 5420.214068959979, 5426.348838139448, 5426.9185962210595, 5434.347878254555, 4362.738235705868, 4776.9761151194025, 4924.926126108111, 4926.211806111005, 4971.875703107379, 4027.864738681808, 4067.28822456069, 4115.218108559424, 4118.732282401635, 4191.224623444673, 1277.201748906933, 1306.1248963194682, 1312.534050412109, 1316.9539066132638, 1331.8268625078679, 1001.2140469731225, 1001.6444162322271, 1004.3622299839508, 1015.4973288222229, 1017.7150397888603, 5933.465988061009, 6028.0, 6081.513478921675, 6146.631202127797, 6245.313015568284, 446.62037268322314, 454.5000499450644, 460.83870645273885, 464.18072102738694, 464.579555502271, 4255.106427650228, 4277.786110694453, 4312.913741725148, 4314.913701726011, 4336.176126535948, 10826.837597436044, 11281.041111505614, 11293.435328233556, 11305.660830175108, 11307.660770176908, 11057.50241239146, 11131.053860421793, 11178.217524773188, 11186.944065279622, 11213.551457941754, 7935.761927142195, 8231.135730748305, 8239.752807415787, 8290.46112002718, 8429.536375499283, 6241.0, 6424.325445828121, 6498.935010649833, 6503.187101612299, 6538.9795002243745, 9909.55407006672, 10312.845307320546, 10342.896571034193, 10436.947815260875, 10576.894231057591, 10168.542415591464, 10506.579736810441, 10508.369497830156, 10643.627473038407, 10646.562714033505, 7188.17336006366, 7481.812954676177, 7697.461177717506, 7742.070951485858, 7858.528488290721, 8789.384743067923, 8846.424982376126, 8895.377323587545, 8899.15458031486, 8929.464232146092, 7580.810479738051, 7607.163212046781, 7738.110117336579, 7835.725749598737, 7882.802929926568, 7519.774406767806, 7527.88708169367, 7611.961940190264, 7675.309222170032, 7725.420593455401, 6948.9305106950305, 6978.895316570357, 7013.684384202825, 7016.333448322402, 7025.297470252934, 5212.244224587338, 5226.477352264743, 5324.600654950972, 5372.5433338166695, 5395.595330350318, 5389.0, 5420.810271640474, 5451.291332126798, 5602.915956260741, 5626.662400255997], "value": 4617.06881188719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.20232306457, 317.81028712173133, 321.3091852517089, 322.6160868566407, 323.1114435302917, 5296.993571221466, 5319.946800531999, 5324.334458192726, 5342.2253773202865, 5359.517643412092, 5213.2701421800975, 5248.947510524894, 5257.0046764459, 5297.073012222855, 5298.682079075258, 3927.3519869221545, 3958.3270843956598, 4055.817488213023, 4082.203970225807, 4083.816228269735, 4032.3145065338817, 4041.3533834586474, 4064.4512990746316, 4074.22589707956, 4081.530623978251, 3917.941230881539, 3993.3211354069877, 4005.3190957537145, 4007.4790277263915, 4010.4786377770847, 3956.4569817771094, 4113.71204015719, 4114.8148333324925, 4120.835166593332, 4133.648639865615, 3610.8986759038485, 3627.9455808162897, 3628.8911332660064, 3634.963650363489, 3635.600083990759, 5065.39215294167, 5083.6441449098575, 5090.338256026693, 5104.412992505872, 5131.255967884673, 4481.574250446202, 4659.347691323217, 4676.7427791471455, 4688.69523480976, 4704.059188162347, 5367.677939323653, 5385.192221166856, 5412.809181979958, 5414.377346605152, 5437.972810135924, 3898.629630185128, 3926.764394136361, 3926.803659816998, 3926.820614558919, 3929.7249192556533, 5325.946740532584, 5665.49010589049, 5691.630044047165, 5711.286089238845, 5717.542596592262, 3920.764754114762, 3939.1727737174942, 3945.2504024235304, 3949.8025098744947, 3952.596828125974, 3998.980005099956, 4005.759654420744, 4006.979965100156, 4034.7377420467574, 4045.3122969095325, 4384.4081049058605, 4581.266997280419, 4582.358469814229, 4645.837395691135, 4657.953420465819, 5471.261379713767, 5476.288082549323, 5500.772187264164, 5549.250851135126, 5576.884623075402, 1366.3304980559653, 1387.7016441464932, 1387.7085811979396, 1399.9080717040724, 1400.649837540615, 889.8920843549822, 892.5180402582532, 903.8644203369415, 925.4354843545432, 931.7810314576069, 5207.557357624569, 5214.69632591852, 5241.711705856138, 5256.9737151314, 5285.233641122016, 5568.972155139199, 5606.383297837235, 5628.324601047819, 5646.181303711021, 5659.320881494247, 5018.372703412074, 5200.271961925334, 5214.13966695491, 5357.142857142839, 5383.892322153535, 2986.5818785370066, 3002.9549556756665, 3004.504256797604, 3005.353848922492, 3061.249993751545, 5639.351474580394, 5859.091840764689, 5867.823965281048, 5879.970600147058, 5881.911771323434, 5715.31416230055, 5735.283089613798, 5739.0, 5740.081586946152, 5757.424257574209, 5758.049921762862, 5812.564057695689, 5815.447532484407, 5838.737256823369, 5847.415258474119, 5421.969825733098, 5623.746931388179, 5642.85892852682, 5659.688717120598, 5681.204631351531, 5519.0, 5581.804636837691, 5597.944020559742, 5608.4111168326735, 5623.690697011703, 5754.6547207167705, 5778.508826749773, 5786.148432501559, 5838.211841401357, 5878.764849406147, 3735.3649879520003, 3941.152652179795, 3962.0, 3982.5420076690393, 3988.222296652241, 5654.0, 5678.5457163426, 5684.971575142098, 5686.545076393962, 5704.629199102211, 5203.323567936144, 5434.510894019557, 5471.425500322409, 5473.562115030868, 5520.475554822286, 5397.8110766123, 5437.755301011385, 5461.590380721383, 5461.781528738806, 5463.0, 5164.457731938242, 5227.457899919609, 5365.973170134124, 5366.6243362964215, 5397.3523177218985, 5535.142052981794, 5555.2778138841695, 5581.134924086773, 5590.161475778666, 5596.272484576979, 5403.648762830403, 5412.215228791882, 5437.972810135924, 5447.673139611636, 5476.67139971587], "value": 4171.210225618178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.8784988326811, 794.3565711773464, 817.3665409307787, 859.4757198109153, 866.4411454611771, 12987.545435909746, 13723.17660940343, 13835.654108647288, 13864.029517933735, 13865.168089914612, 13178.670533236675, 13196.142250753719, 13217.537386191485, 13220.272884991322, 13236.669083272924, 678.0405725897849, 800.4076983032543, 804.6861723927673, 807.9474834135792, 836.9121242269534, 806.0971711682923, 813.3858936502961, 816.2572059425923, 816.3836303590781, 817.9918200818005, 867.3408209760596, 871.0592560035146, 871.1680345270252, 871.4335681806813, 871.4509858788954, 720.1106633307861, 836.0719601242616, 838.5304229631425, 845.750503601436, 866.3632230310717, 631.5768435148416, 632.9936700633027, 633.4045996763074, 633.4235845380681, 634.3212762344293, 12957.222566645936, 12995.155314904501, 13013.0, 13019.283939383331, 13028.869711302861, 12720.300383478905, 12871.485140594365, 12949.611511654666, 13067.17949482454, 13183.209007459584, 10803.297785643987, 10936.671899842939, 11048.281861678965, 11176.888231117748, 11265.324080555192, 4321.481422229353, 4329.415528903589, 4339.891502712426, 4340.240457919851, 4461.040876211598, 59576.0, 59595.70202149005, 59748.70125649344, 59753.10370344448, 60077.39922600762, 9488.573014214377, 9519.143277105093, 9639.228861691048, 9674.75813104664, 9695.854562181574, 19897.104630291673, 20122.19511219535, 20206.292779752934, 20223.0, 20227.19091236334, 8008.83982320362, 8226.547539885243, 8467.915320846836, 8500.617472213766, 8528.232459078712, 4515.909681806345, 4608.700434471749, 4629.699069560468, 4650.139724151043, 4680.789364478606, 3230.7576931730214, 3326.168457885529, 3353.3293341331832, 3356.429407000816, 3532.7350448716447, 637.4517914593446, 641.3105911145537, 642.5405834828027, 643.1285608001091, 651.6285717141279, 713.846522997558, 714.3249629100554, 714.3749219432996, 726.8727972604773, 733.1641928201855, 8797.47215167092, 8801.779955501164, 8829.779255518664, 8838.861144824008, 9116.635334586676, 632.4118569730103, 716.2479396633618, 716.6094478509225, 726.9418446524265, 739.3715341959291, 4108.77401742901, 4199.748015119103, 4205.705600607989, 4249.107687385684, 4296.0978194578865, 65767.0, 68414.3158568408, 69867.0, 70233.2976670237, 70415.0, 58662.0, 58853.0, 59190.70404647949, 59568.0, 60149.398506015255, 56155.71922140445, 56288.43711562914, 56586.43413565894, 56989.43010569924, 58089.709551451975, 8307.127751586238, 8351.29014033814, 8392.706255281037, 8538.146185381413, 8596.226339629464, 35623.28753424969, 36887.44668829916, 37373.81313093526, 37406.62593374032, 37585.0, 47186.76406617945, 50934.0, 51031.0, 51205.0, 52259.0, 11129.944350278196, 11391.316521008766, 11451.25566838153, 11456.828147577626, 11683.123765717435, 11248.151449213932, 11446.37044962535, 11568.305901645928, 11575.305481671126, 12060.155789094679, 11580.36308003068, 11840.28958262507, 11883.821742673694, 11900.464479098635, 12157.939210303892, 10969.122470202205, 10992.835107473555, 11307.0, 11342.035926946302, 11361.318320900773, 11388.37363944991, 11403.429828508375, 11454.198206125491, 11725.296482211095, 11863.703407414883, 8972.461652300883, 9202.769930751518, 9227.677031303872, 9449.858252126362, 9557.139857412867, 9053.68312109073, 9188.724338269863, 9801.16690081351, 9813.901860981585, 9846.803063938825], "value": 6653.019647200601, "unit": "score"}], "name": "dromaeo_css", "value": 7108.444276548333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 111.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 129.0, 177.0, 127.0, 137.0, 129.0, 163.0, 166.0, 135.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 160.0, 159.0, 160.0, 161.0, 159.0, 161.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 106.0, 76.0, 75.0, 74.0, 73.0, 97.0, 76.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 83.0, 90.0, 82.0, 116.0, 82.0, 83.0, 130.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0, 70.0, 52.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 68.0, 62.0, 61.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0, 82.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 123.0, 131.0, 122.0, 127.0, 119.0, 126.0, 123.0, 178.0, 132.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 157.0, 157.0, 157.0, 163.0, 166.0, 162.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 63.0, 65.0, 62.0, 63.0, 61.0, 60.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1499.6000000000001, "alertThreshold": 2.0}]} 05:20:06 INFO - Return code: 0 05:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:06 ERROR - # TBPL SUCCESS # 05:20:06 INFO - Running post-action listener: _resource_record_post_action 05:20:06 INFO - ##### 05:20:06 INFO - ##### Finished run-tests step (success) 05:20:06 INFO - ##### 05:20:06 INFO - Running post-run listener: _resource_record_post_run 05:20:06 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7852032; Write bytes: 464658432; Read time: 1064; Write time: 406984 05:20:06 INFO - TinderboxPrint: CPU usage
13.1% 05:20:06 INFO - TinderboxPrint: I/O read bytes / time
7,852,032 / 1,064 05:20:06 INFO - TinderboxPrint: I/O write bytes / time
464,658,432 / 406,984 05:20:06 INFO - TinderboxPrint: CPU idle
8,287.3 (86.9%) 05:20:06 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 05:20:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:20:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 62914560; Read time: 0; Write time: 25352 05:20:06 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 6115328; Write bytes: 401743872; Read time: 1020; Write time: 381632 05:20:07 INFO - Running post-run listener: _upload_blobber_files 05:20:07 INFO - Blob upload gear active. 05:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:20:07 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:20:07 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:20:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:08 INFO - (blobuploader) - INFO - Done attempting. 05:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:09 INFO - (blobuploader) - INFO - Done attempting. 05:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:12 INFO - (blobuploader) - INFO - Done attempting. 05:20:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:12 INFO - Return code: 0 05:20:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a1b745772d1ed54c44f289c2165b6c1ab0a6c01ad837c851380513e55535a00def7bf350764ad8237c9f27fb2940497ea4461a9b2275c58bdcdcff8a2896fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f477be5f5d00ad385f2c1e8c7f06163543a798aac8ef17203dffc5580fc4bf0d7012980add83abb9148fa521110a2c30ea87460898e152fc535d38a8beb9f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaa196f27027d3267945818f8aa84fe61ba9e2b5ef71e7cf47f3476bce6e4452a86150651e10931b001088f02f6ffbc3aa870627b4fb7b4b230ca36a87bb3bce"} 05:20:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:12 INFO - Contents: 05:20:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33a1b745772d1ed54c44f289c2165b6c1ab0a6c01ad837c851380513e55535a00def7bf350764ad8237c9f27fb2940497ea4461a9b2275c58bdcdcff8a2896fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f477be5f5d00ad385f2c1e8c7f06163543a798aac8ef17203dffc5580fc4bf0d7012980add83abb9148fa521110a2c30ea87460898e152fc535d38a8beb9f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaa196f27027d3267945818f8aa84fe61ba9e2b5ef71e7cf47f3476bce6e4452a86150651e10931b001088f02f6ffbc3aa870627b4fb7b4b230ca36a87bb3bce"} 05:20:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:12 INFO - Copying logs to upload dir... 05:20:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.387293 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-25 05:20:13.003091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:13.008037) ========= 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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 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/sha512/33a1b745772d1ed54c44f289c2165b6c1ab0a6c01ad837c851380513e55535a00def7bf350764ad8237c9f27fb2940497ea4461a9b2275c58bdcdcff8a2896fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f477be5f5d00ad385f2c1e8c7f06163543a798aac8ef17203dffc5580fc4bf0d7012980add83abb9148fa521110a2c30ea87460898e152fc535d38a8beb9f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaa196f27027d3267945818f8aa84fe61ba9e2b5ef71e7cf47f3476bce6e4452a86150651e10931b001088f02f6ffbc3aa870627b4fb7b4b230ca36a87bb3bce"} build_url:https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/cOu4WoIFR6eLFhusK2AAww/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/sha512/33a1b745772d1ed54c44f289c2165b6c1ab0a6c01ad837c851380513e55535a00def7bf350764ad8237c9f27fb2940497ea4461a9b2275c58bdcdcff8a2896fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f477be5f5d00ad385f2c1e8c7f06163543a798aac8ef17203dffc5580fc4bf0d7012980add83abb9148fa521110a2c30ea87460898e152fc535d38a8beb9f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaa196f27027d3267945818f8aa84fe61ba9e2b5ef71e7cf47f3476bce6e4452a86150651e10931b001088f02f6ffbc3aa870627b4fb7b4b230ca36a87bb3bce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:13.042118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:13.042576) ========= 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=7de08804244eb36560b44971000001c3-1464176832.986633-1665956217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.33 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 05:20:13.380566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:20:13.380970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 05:20:13.381314) ========= ========= Total master_lag: 0.50 =========