builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1464034052.88 results: success (0) buildid: 20160523123849 builduid: 6868965a10b743daa85bc62f122a91c2 revision: e5e4114404d05d341781e10c71333ffd838285cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:32.883963) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:32.884543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:32.884940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:32.948213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:32.948556) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 13:07:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.2K=0.2s 2016-05-23 13:07:33 (53.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.305031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:33.268589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:33.268924) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:33.321269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 13:07:33.321908) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5e4114404d05d341781e10c71333ffd838285cb --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 e5e4114404d05d341781e10c71333ffd838285cb --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=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 13:07:34,002 truncating revision to first 12 chars 2016-05-23 13:07:34,002 Setting DEBUG logging. 2016-05-23 13:07:34,002 attempt 1/10 2016-05-23 13:07:34,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5e4114404d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 13:07:34,733 unpacking tar archive at: fx-team-e5e4114404d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 13:07:34.341477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:34.341969) ========= script_repo_revision: e5e4114404d05d341781e10c71333ffd838285cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:34.342627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:34.342948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 13:07:34.353279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-23 13:07:34.353659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:35 INFO - MultiFileLogger online at 20160523 13:07:35 in /builds/slave/test 13:07:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:07:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:35 INFO - {'append_to_log': False, 13:07:35 INFO - 'base_work_dir': '/builds/slave/test', 13:07:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:07:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:35 INFO - 'branch': 'Fx-Team-Non-PGO', 13:07:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:35 INFO - 'config_files': ('talos/linux_config.py',), 13:07:35 INFO - 'default_actions': ('clobber', 13:07:35 INFO - 'read-buildbot-config', 13:07:35 INFO - 'download-and-extract', 13:07:35 INFO - 'populate-webroot', 13:07:35 INFO - 'create-virtualenv', 13:07:35 INFO - 'install', 13:07:35 INFO - 'run-tests'), 13:07:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:35 INFO - 'download_minidump_stackwalk': True, 13:07:35 INFO - 'download_symbols': 'ondemand', 13:07:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:35 INFO - 'installer_path': 'installer.exe', 13:07:35 INFO - 'log_level': 'info', 13:07:35 INFO - 'log_name': 'talos', 13:07:35 INFO - 'log_to_console': True, 13:07:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:35 INFO - 'opt_config_files': (), 13:07:35 INFO - 'pip_index': False, 13:07:35 INFO - 'sps_profile': False, 13:07:35 INFO - 'sps_profile_interval': 0, 13:07:35 INFO - 'suite': 'dromaeojs', 13:07:35 INFO - 'system_bits': '32', 13:07:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:35 INFO - 'title': 'talos-linux64-ix-041', 13:07:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:35 INFO - 'use_talos_json': True, 13:07:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:35 INFO - 'work_dir': 'build'} 13:07:35 INFO - ##### 13:07:35 INFO - ##### Running clobber step. 13:07:35 INFO - ##### 13:07:35 INFO - Running pre-action listener: _resource_record_pre_action 13:07:35 INFO - Running main action method: clobber 13:07:35 INFO - rmtree: /builds/slave/test/build 13:07:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:36 INFO - Running post-action listener: _resource_record_post_action 13:07:36 INFO - ##### 13:07:36 INFO - ##### Finished clobber step (success) 13:07:36 INFO - ##### 13:07:36 INFO - ##### 13:07:36 INFO - ##### Running read-buildbot-config step. 13:07:36 INFO - ##### 13:07:36 INFO - Running pre-action listener: _resource_record_pre_action 13:07:36 INFO - Running main action method: read_buildbot_config 13:07:36 INFO - Using buildbot properties: 13:07:36 INFO - { 13:07:36 INFO - "project": "", 13:07:36 INFO - "product": "firefox", 13:07:36 INFO - "script_repo_revision": "production", 13:07:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:07:36 INFO - "repository": "", 13:07:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:07:36 INFO - "buildid": "20160523123849", 13:07:36 INFO - "pgo_build": "False", 13:07:36 INFO - "basedir": "/builds/slave/test", 13:07:36 INFO - "buildnumber": 1706, 13:07:36 INFO - "slavename": "talos-linux64-ix-041", 13:07:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:07:36 INFO - "platform": "ubuntu64_hw", 13:07:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:07:36 INFO - "branch": "fx-team", 13:07:36 INFO - "repo_path": "integration/fx-team", 13:07:36 INFO - "revision": "e5e4114404d05d341781e10c71333ffd838285cb", 13:07:36 INFO - "stage_platform": "linux64", 13:07:36 INFO - "builduid": "6868965a10b743daa85bc62f122a91c2", 13:07:36 INFO - "slavebuilddir": "test" 13:07:36 INFO - } 13:07:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:07:36 INFO - Running post-action listener: _resource_record_post_action 13:07:36 INFO - ##### 13:07:36 INFO - ##### Finished read-buildbot-config step (success) 13:07:36 INFO - ##### 13:07:36 INFO - ##### 13:07:36 INFO - ##### Running download-and-extract step. 13:07:36 INFO - ##### 13:07:36 INFO - Running pre-action listener: _resource_record_pre_action 13:07:36 INFO - Running main action method: download_and_extract 13:07:36 INFO - mkdir: /builds/slave/test/build/tests 13:07:36 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')]} 13:07:36 INFO - https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:39 INFO - Downloaded 1361 bytes. 13:07:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:39 INFO - Using the following test package requirements: 13:07:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'jsshell-linux-x86_64.zip'], 13:07:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07: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')]} 13:07:39 INFO - https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:44 INFO - Downloaded 22814444 bytes. 13:07:44 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'] 13:07:44 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 13:07:45 INFO - Return code: 0 13:07:45 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 13:07:45 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')]} 13:07:45 INFO - https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:46 INFO - Downloaded 22814444 bytes. 13:07:46 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'] 13:07:46 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 13:07:48 INFO - Return code: 0 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:50 INFO - Downloaded 10840359 bytes. 13:07:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:07:50 INFO - Return code: 0 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:50 INFO - https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDWaafhkQdGZ8MuWo7JCiA/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 13:07:51 INFO - Downloaded 54816891 bytes. 13:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:07:51 INFO - mkdir: /builds/slave/test/properties 13:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:51 INFO - Contents: 13:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:07:52 INFO - Running post-action listener: _resource_record_post_action 13:07:52 INFO - Running post-action listener: set_extra_try_arguments 13:07:52 INFO - ##### 13:07:52 INFO - ##### Finished download-and-extract step (success) 13:07:52 INFO - ##### 13:07:52 INFO - ##### 13:07:52 INFO - ##### Running populate-webroot step. 13:07:52 INFO - ##### 13:07:52 INFO - Running pre-action listener: _resource_record_pre_action 13:07:52 INFO - Running main action method: populate_webroot 13:07:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:52 INFO - '--tppagecycles', 13:07:52 INFO - '7'], 13:07:52 INFO - 'tests': ['tsvgm']}}, 13:07:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['damp', 'tps']}, 13:07:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'tests': ['damp', 'tps']}, 13:07:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['dromaeo_dom']}, 13:07:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['a11yr', 13:07:52 INFO - 'ts_paint', 13:07:52 INFO - 'tpaint', 13:07:52 INFO - 'sessionrestore', 13:07:52 INFO - 'sessionrestore_no_auto_restore', 13:07:52 INFO - 'tabpaint']}, 13:07:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['tsvgx', 13:07:52 INFO - 'tsvgr_opacity', 13:07:52 INFO - 'tart', 13:07:52 INFO - 'tscrollx', 13:07:52 INFO - 'cart']}, 13:07:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:52 INFO - 'tsvgr_opacity', 13:07:52 INFO - 'tart', 13:07:52 INFO - 'tscrollx', 13:07:52 INFO - 'cart']}, 13:07:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'talos_options': ['--disable-e10s'], 13:07:52 INFO - 'tests': ['tp5o']}, 13:07:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'tests': ['tp5o']}, 13:07:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'talos_options': ['--disable-e10s', 13:07:52 INFO - '--xperf_path', 13:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:52 INFO - 'tests': ['tp5n']}, 13:07:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:52 INFO - 'talos_options': ['--xperf_path', 13:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:52 INFO - 'tests': ['tp5n']}}, 13:07:52 INFO - 'talos.zip': {'path': '', 13:07:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:52 INFO - Running post-action listener: _resource_record_post_action 13:07:52 INFO - ##### 13:07:52 INFO - ##### Finished populate-webroot step (success) 13:07:52 INFO - ##### 13:07:52 INFO - ##### 13:07:52 INFO - ##### Running create-virtualenv step. 13:07:52 INFO - ##### 13:07:52 INFO - Running pre-action listener: _resource_record_pre_action 13:07:52 INFO - Running main action method: create_virtualenv 13:07:52 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:07:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:52 INFO - Using real prefix '/usr' 13:07:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:54 INFO - Installing pip.................done. 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:07:55 INFO - Cleaning up... 13:07:55 INFO - Return code: 0 13:07:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:07:55 INFO - Using env: {'DISPLAY': ':0', 13:07:55 INFO - 'HOME': '/home/cltbld', 13:07:55 INFO - 'LANG': 'en_US.UTF-8', 13:07:55 INFO - 'LANGUAGE': 'en_US:en', 13:07:55 INFO - 'LOGNAME': 'cltbld', 13:07:55 INFO - 'MAIL': '/var/mail/cltbld', 13:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:55 INFO - 'MOZ_NO_REMOTE': '1', 13:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:55 INFO - 'NO_EM_RESTART': '1', 13:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:55 INFO - 'PWD': '/builds/slave/test', 13:07:55 INFO - 'SHELL': '/bin/bash', 13:07:55 INFO - 'SHLVL': '1', 13:07:55 INFO - 'TERM': 'linux', 13:07:55 INFO - 'TMOUT': '86400', 13:07:55 INFO - 'USER': 'cltbld', 13:07:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:55 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 INFO - Downloading/unpacking psutil>=3.1.1 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:57 INFO - Installing collected packages: psutil 13:07:57 INFO - Running setup.py install for psutil 13:07:57 INFO - building 'psutil._psutil_linux' extension 13:07:57 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 13:07:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:07:57 INFO - building 'psutil._psutil_posix' extension 13:07:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:07:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:57 INFO - Successfully installed psutil 13:07:57 INFO - Cleaning up... 13:07:57 INFO - Return code: 0 13:07:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:07:57 INFO - Using env: {'DISPLAY': ':0', 13:07:57 INFO - 'HOME': '/home/cltbld', 13:07:57 INFO - 'LANG': 'en_US.UTF-8', 13:07:57 INFO - 'LANGUAGE': 'en_US:en', 13:07:57 INFO - 'LOGNAME': 'cltbld', 13:07:57 INFO - 'MAIL': '/var/mail/cltbld', 13:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:57 INFO - 'MOZ_NO_REMOTE': '1', 13:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:57 INFO - 'NO_EM_RESTART': '1', 13:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:57 INFO - 'PWD': '/builds/slave/test', 13:07:57 INFO - 'SHELL': '/bin/bash', 13:07:57 INFO - 'SHLVL': '1', 13:07:57 INFO - 'TERM': 'linux', 13:07:57 INFO - 'TMOUT': '86400', 13:07:57 INFO - 'USER': 'cltbld', 13:07:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:57 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:00 INFO - Installing collected packages: mozsystemmonitor 13:08:00 INFO - Running setup.py install for mozsystemmonitor 13:08:00 INFO - Successfully installed mozsystemmonitor 13:08:00 INFO - Cleaning up... 13:08:00 INFO - Return code: 0 13:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:00 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')]} 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:00 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')]} 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:00 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 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:00 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 13:08:00 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 13:08:00 INFO - Using env: {'DISPLAY': ':0', 13:08:00 INFO - 'HOME': '/home/cltbld', 13:08:00 INFO - 'LANG': 'en_US.UTF-8', 13:08:00 INFO - 'LANGUAGE': 'en_US:en', 13:08:00 INFO - 'LOGNAME': 'cltbld', 13:08:00 INFO - 'MAIL': '/var/mail/cltbld', 13:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:00 INFO - 'MOZ_NO_REMOTE': '1', 13:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:00 INFO - 'NO_EM_RESTART': '1', 13:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:00 INFO - 'PWD': '/builds/slave/test', 13:08:00 INFO - 'SHELL': '/bin/bash', 13:08:00 INFO - 'SHLVL': '1', 13:08:00 INFO - 'TERM': 'linux', 13:08:00 INFO - 'TMOUT': '86400', 13:08:00 INFO - 'USER': 'cltbld', 13:08:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:00 INFO - '_': '/tools/buildbot/bin/python'} 13:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:02 INFO - Downloading docopt-0.6.1.tar.gz 13:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:03 INFO - Running setup.py install for blobuploader 13:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:03 INFO - Running setup.py install for requests 13:08:03 INFO - Running setup.py install for docopt 13:08:03 INFO - Successfully installed blobuploader requests docopt 13:08:03 INFO - Cleaning up... 13:08:03 INFO - Return code: 0 13:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:03 INFO - Using env: {'DISPLAY': ':0', 13:08:03 INFO - 'HOME': '/home/cltbld', 13:08:03 INFO - 'LANG': 'en_US.UTF-8', 13:08:03 INFO - 'LANGUAGE': 'en_US:en', 13:08:03 INFO - 'LOGNAME': 'cltbld', 13:08:03 INFO - 'MAIL': '/var/mail/cltbld', 13:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:03 INFO - 'MOZ_NO_REMOTE': '1', 13:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:03 INFO - 'NO_EM_RESTART': '1', 13:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:03 INFO - 'PWD': '/builds/slave/test', 13:08:03 INFO - 'SHELL': '/bin/bash', 13:08:03 INFO - 'SHLVL': '1', 13:08:03 INFO - 'TERM': 'linux', 13:08:03 INFO - 'TMOUT': '86400', 13:08:03 INFO - 'USER': 'cltbld', 13:08:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:03 INFO - '_': '/tools/buildbot/bin/python'} 13:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:03 INFO - Running setup.py (path:/tmp/pip-DOjREj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:03 INFO - Running setup.py (path:/tmp/pip-zpAhGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:04 INFO - Running setup.py (path:/tmp/pip-tzmREB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:04 INFO - Running setup.py (path:/tmp/pip-V0xx3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:04 INFO - Running setup.py (path:/tmp/pip-ZrlUuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:04 INFO - Running setup.py (path:/tmp/pip-2sYjJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:04 INFO - Running setup.py (path:/tmp/pip-0yphde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:04 INFO - Running setup.py (path:/tmp/pip-Pz5N_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:04 INFO - Running setup.py (path:/tmp/pip-N5tGOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:04 INFO - Running setup.py (path:/tmp/pip-77KgI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:04 INFO - Running setup.py (path:/tmp/pip-b5rwz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:04 INFO - Running setup.py (path:/tmp/pip-pykIfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:04 INFO - Running setup.py (path:/tmp/pip-6psJB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:04 INFO - Running setup.py (path:/tmp/pip-mQE7el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:04 INFO - Running setup.py (path:/tmp/pip-ImSTwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:04 INFO - Running setup.py (path:/tmp/pip-0JZKDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:05 INFO - Running setup.py (path:/tmp/pip-ldt6gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:05 INFO - Running setup.py install for manifestparser 13:08:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozcrash 13:08:05 INFO - Running setup.py install for mozdebug 13:08:05 INFO - Running setup.py install for mozdevice 13:08:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozfile 13:08:05 INFO - Running setup.py install for mozhttpd 13:08:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozinfo 13:08:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozInstall 13:08:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:05 INFO - Running setup.py install for mozleak 13:08:06 INFO - Running setup.py install for mozlog 13:08:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for moznetwork 13:08:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozprocess 13:08:06 INFO - Running setup.py install for mozprofile 13:08:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozrunner 13:08:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Running setup.py install for mozscreenshot 13:08:06 INFO - Running setup.py install for moztest 13:08:06 INFO - Running setup.py install for mozversion 13:08:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:06 INFO - Cleaning up... 13:08:06 INFO - Return code: 0 13:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:06 INFO - Using env: {'DISPLAY': ':0', 13:08:06 INFO - 'HOME': '/home/cltbld', 13:08:06 INFO - 'LANG': 'en_US.UTF-8', 13:08:06 INFO - 'LANGUAGE': 'en_US:en', 13:08:06 INFO - 'LOGNAME': 'cltbld', 13:08:06 INFO - 'MAIL': '/var/mail/cltbld', 13:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:06 INFO - 'MOZ_NO_REMOTE': '1', 13:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:06 INFO - 'NO_EM_RESTART': '1', 13:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:06 INFO - 'PWD': '/builds/slave/test', 13:08:06 INFO - 'SHELL': '/bin/bash', 13:08:06 INFO - 'SHLVL': '1', 13:08:06 INFO - 'TERM': 'linux', 13:08:06 INFO - 'TMOUT': '86400', 13:08:06 INFO - 'USER': 'cltbld', 13:08:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:06 INFO - '_': '/tools/buildbot/bin/python'} 13:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:07 INFO - Running setup.py (path:/tmp/pip-_HZ3Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:07 INFO - Running setup.py (path:/tmp/pip-F6deXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:07 INFO - Running setup.py (path:/tmp/pip-egse0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:07 INFO - Running setup.py (path:/tmp/pip-ZIrSKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:07 INFO - Running setup.py (path:/tmp/pip-Ry8SUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:07 INFO - Running setup.py (path:/tmp/pip-0tKtna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:07 INFO - Running setup.py (path:/tmp/pip-zGKiUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:07 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)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:07 INFO - Running setup.py (path:/tmp/pip-xoSM4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:07 INFO - Running setup.py (path:/tmp/pip-pRrzny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:07 INFO - Running setup.py (path:/tmp/pip-vTIaWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:07 INFO - Running setup.py (path:/tmp/pip-4omVDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:07 INFO - Running setup.py (path:/tmp/pip-TceZOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:08 INFO - Running setup.py (path:/tmp/pip-mtCTvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:08 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)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:08 INFO - Running setup.py (path:/tmp/pip-X1rI7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:08 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)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:08 INFO - Running setup.py (path:/tmp/pip-8sWz02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:08 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)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:08 INFO - Running setup.py (path:/tmp/pip-X0kcsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:08 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)) 13:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:08 INFO - Running setup.py (path:/tmp/pip-bHWFGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 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)) 13:08:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:10 INFO - Downloading blessings-1.6.tar.gz 13:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:10 INFO - Installing collected packages: blessings 13:08:10 INFO - Running setup.py install for blessings 13:08:10 INFO - Successfully installed blessings 13:08:10 INFO - Cleaning up... 13:08:10 INFO - Return code: 0 13:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:10 INFO - Reading from file tmpfile_stdout 13:08:10 INFO - Current package versions: 13:08:10 INFO - argparse == 1.2.1 13:08:10 INFO - blessings == 1.6 13:08:10 INFO - blobuploader == 1.2.4 13:08:10 INFO - docopt == 0.6.1 13:08:10 INFO - manifestparser == 1.1 13:08:10 INFO - mozInstall == 1.12 13:08:10 INFO - mozcrash == 0.17 13:08:10 INFO - mozdebug == 0.1 13:08:10 INFO - mozdevice == 0.48 13:08:10 INFO - mozfile == 1.2 13:08:10 INFO - mozhttpd == 0.7 13:08:10 INFO - mozinfo == 0.9 13:08:10 INFO - mozleak == 0.1 13:08:10 INFO - mozlog == 3.2 13:08:10 INFO - moznetwork == 0.27 13:08:10 INFO - mozprocess == 0.22 13:08:10 INFO - mozprofile == 0.28 13:08:10 INFO - mozrunner == 6.11 13:08:10 INFO - mozscreenshot == 0.1 13:08:10 INFO - mozsystemmonitor == 0.3 13:08:10 INFO - moztest == 0.7 13:08:10 INFO - mozversion == 1.4 13:08:10 INFO - psutil == 3.1.1 13:08:10 INFO - requests == 1.2.3 13:08:10 INFO - wsgiref == 0.1.2 13:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:10 INFO - Using env: {'DISPLAY': ':0', 13:08:10 INFO - 'HOME': '/home/cltbld', 13:08:10 INFO - 'LANG': 'en_US.UTF-8', 13:08:10 INFO - 'LANGUAGE': 'en_US:en', 13:08:10 INFO - 'LOGNAME': 'cltbld', 13:08:10 INFO - 'MAIL': '/var/mail/cltbld', 13:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:10 INFO - 'MOZ_NO_REMOTE': '1', 13:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:10 INFO - 'NO_EM_RESTART': '1', 13:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:10 INFO - 'PWD': '/builds/slave/test', 13:08:10 INFO - 'SHELL': '/bin/bash', 13:08:10 INFO - 'SHLVL': '1', 13:08:10 INFO - 'TERM': 'linux', 13:08:10 INFO - 'TMOUT': '86400', 13:08:10 INFO - 'USER': 'cltbld', 13:08:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:10 INFO - '_': '/tools/buildbot/bin/python'} 13:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:10 INFO - Cleaning up... 13:08:10 INFO - Return code: 0 13:08:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:10 INFO - Using env: {'DISPLAY': ':0', 13:08:10 INFO - 'HOME': '/home/cltbld', 13:08:10 INFO - 'LANG': 'en_US.UTF-8', 13:08:10 INFO - 'LANGUAGE': 'en_US:en', 13:08:10 INFO - 'LOGNAME': 'cltbld', 13:08:10 INFO - 'MAIL': '/var/mail/cltbld', 13:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:10 INFO - 'MOZ_NO_REMOTE': '1', 13:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:10 INFO - 'NO_EM_RESTART': '1', 13:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:10 INFO - 'PWD': '/builds/slave/test', 13:08:10 INFO - 'SHELL': '/bin/bash', 13:08:10 INFO - 'SHLVL': '1', 13:08:10 INFO - 'TERM': 'linux', 13:08:10 INFO - 'TMOUT': '86400', 13:08:10 INFO - 'USER': 'cltbld', 13:08:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:10 INFO - '_': '/tools/buildbot/bin/python'} 13:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:11 INFO - Downloading/unpacking jsonschema 13:08:11 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 13:08:11 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 13:08:11 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 13:08:11 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 13:08:11 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 13:08:11 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 13:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:13 INFO - warning: no files found matching '*.txt' 13:08:13 INFO - no previously-included directories found matching 'build' 13:08:13 INFO - no previously-included directories found matching 'dist' 13:08:13 INFO - no previously-included directories found matching '.git*' 13:08:13 INFO - Installing collected packages: jsonschema, functools32 13:08:13 INFO - Running setup.py install for functools32 13:08:13 INFO - warning: no files found matching '*.txt' 13:08:13 INFO - no previously-included directories found matching 'build' 13:08:13 INFO - no previously-included directories found matching 'dist' 13:08:13 INFO - no previously-included directories found matching '.git*' 13:08:13 INFO - Successfully installed jsonschema functools32 13:08:13 INFO - Cleaning up... 13:08:13 INFO - Return code: 0 13:08:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:08:13 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')]} 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 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')]} 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 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 0x7f6960f8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1305770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', '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 13:08:13 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 13:08:13 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 13:08:13 INFO - Using env: {'DISPLAY': ':0', 13:08:13 INFO - 'HOME': '/home/cltbld', 13:08:13 INFO - 'LANG': 'en_US.UTF-8', 13:08:13 INFO - 'LANGUAGE': 'en_US:en', 13:08:13 INFO - 'LOGNAME': 'cltbld', 13:08:13 INFO - 'MAIL': '/var/mail/cltbld', 13:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:13 INFO - 'MOZ_NO_REMOTE': '1', 13:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:13 INFO - 'NO_EM_RESTART': '1', 13:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:13 INFO - 'PWD': '/builds/slave/test', 13:08:13 INFO - 'SHELL': '/bin/bash', 13:08:13 INFO - 'SHLVL': '1', 13:08:13 INFO - 'TERM': 'linux', 13:08:13 INFO - 'TMOUT': '86400', 13:08:13 INFO - 'USER': 'cltbld', 13:08:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:13 INFO - '_': '/tools/buildbot/bin/python'} 13:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:13 INFO - Downloading/unpacking flake8 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:08:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:08:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:08:16 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 13:08:16 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 13:08:16 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 13:08:16 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 13:08:16 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 13:08:16 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 13:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:16 INFO - no previously-included directories found matching 'docs/_build' 13:08:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:08:16 INFO - Running setup.py install for pep8 13:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:16 INFO - no previously-included directories found matching 'docs/_build' 13:08:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:08:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:08:16 INFO - Cleaning up... 13:08:16 INFO - Return code: 0 13:08:16 INFO - Running post-action listener: _resource_record_post_action 13:08:16 INFO - Running post-action listener: _start_resource_monitoring 13:08:16 INFO - Starting resource monitoring. 13:08:16 INFO - ##### 13:08:16 INFO - ##### Finished create-virtualenv step (success) 13:08:16 INFO - ##### 13:08:16 INFO - ##### 13:08:16 INFO - ##### Running install step. 13:08:16 INFO - ##### 13:08:16 INFO - Running pre-action listener: _resource_record_pre_action 13:08:16 INFO - Running main action method: install 13:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:16 INFO - Reading from file tmpfile_stdout 13:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:16 INFO - Reading from file tmpfile_stdout 13:08:16 INFO - Output received: 13:08:16 INFO - Usage: mozinstall [options] installer 13:08:16 INFO - Options: 13:08:16 INFO - -h, --help show this help message and exit 13:08:16 INFO - -d DEST, --destination=DEST 13:08:16 INFO - Directory to install application into. [default: 13:08:16 INFO - "/builds/slave/test"] 13:08:16 INFO - --app=APP Application being installed. [default: firefox] 13:08:16 INFO - mkdir: /builds/slave/test/build/application 13:08:16 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'] 13:08:16 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 13:08:32 INFO - Reading from file tmpfile_stdout 13:08:32 INFO - Output received: 13:08:32 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:32 INFO - Running post-action listener: _resource_record_post_action 13:08:32 INFO - ##### 13:08:32 INFO - ##### Finished install step (success) 13:08:32 INFO - ##### 13:08:32 INFO - ##### 13:08:32 INFO - ##### Running run-tests step. 13:08:32 INFO - ##### 13:08:32 INFO - Running pre-action listener: _resource_record_pre_action 13:08:32 INFO - Running main action method: run_tests 13:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:32 INFO - Python 2.7.3 13:08:32 INFO - Return code: 0 13:08:32 INFO - grabbing minidump binary from tooltool 13:08:32 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')]} 13:08:32 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 0x13949c0>, '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 0x13958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1395d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:32 INFO - Return code: 0 13:08:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:08:33 INFO - Return code: 0 13:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 13:08:33 INFO - Using env: {'DISPLAY': ':0', 13:08:33 INFO - 'HOME': '/home/cltbld', 13:08:33 INFO - 'LANG': 'en_US.UTF-8', 13:08:33 INFO - 'LANGUAGE': 'en_US:en', 13:08:33 INFO - 'LOGNAME': 'cltbld', 13:08:33 INFO - 'MAIL': '/var/mail/cltbld', 13:08:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:33 INFO - 'MOZ_NO_REMOTE': '1', 13:08:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:33 INFO - 'NO_EM_RESTART': '1', 13:08:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:33 INFO - 'PWD': '/builds/slave/test', 13:08:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:33 INFO - 'SHELL': '/bin/bash', 13:08:33 INFO - 'SHLVL': '1', 13:08:33 INFO - 'TERM': 'linux', 13:08:33 INFO - 'TMOUT': '86400', 13:08:33 INFO - 'USER': 'cltbld', 13:08:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025', 13:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:33 INFO - '_': '/tools/buildbot/bin/python'} 13:08:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:08:33 INFO - mozversion application_buildid: 20160523123849 13:08:33 INFO - mozversion application_changeset: e5e4114404d05d341781e10c71333ffd838285cb 13:08:33 INFO - mozversion application_display_name: Nightly 13:08:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:33 INFO - mozversion application_name: Firefox 13:08:33 INFO - mozversion application_remotingname: firefox 13:08:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:08:33 INFO - mozversion application_vendor: Mozilla 13:08:33 INFO - mozversion application_version: 49.0a1 13:08:33 INFO - mozversion platform_buildid: 20160523123849 13:08:33 INFO - mozversion platform_changeset: e5e4114404d05d341781e10c71333ffd838285cb 13:08:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:08:33 INFO - mozversion platform_version: 49.0a1 13:08:33 INFO - using testdate: 1464034113 13:08:33 INFO - actual date: 1464034113 13:08:33 INFO - starting webserver on 'localhost:59197' 13:08:33 INFO - SUITE-START | Running 2 tests 13:08:33 INFO - TEST-START | dromaeo_css 13:08:33 INFO - operating with platform_type : linux_ 13:08:33 INFO - Initialising browser for dromaeo_css test... 13:08:33 INFO - TEST-INFO | started process 21891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_AyPMq/profile http://localhost:59197/getInfo.html) 13:08:38 INFO - PROCESS | 21891 | __metrics Screen width/height:1600/1200 13:08:38 INFO - PROCESS | 21891 | colorDepth:24 13:08:38 INFO - PROCESS | 21891 | Browser inner width/height: 1024/697 13:08:38 INFO - PROCESS | 21891 | __metrics 13:08:39 ERROR - PROCESS | 21891 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:08:40 INFO - TEST-INFO | 21891: exit 0 13:08:40 INFO - Browser initialized. 13:08:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:40 INFO - TEST-INFO | started process 21971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_AyPMq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:52 INFO - PROCESS | 21971 | RSS: Main: 154775552 13:08:52 INFO - PROCESS | 21971 | 13:09:44 INFO - PROCESS | 21971 | 1464034184088 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] 13:11:55 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59197/tests/dromaeo/cssquery-ext.html) 13:11:56 INFO - PROCESS | 21971 | RSS: Main: 268238848 13:11:56 INFO - PROCESS | 21971 | 13:14:59 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-ext.html (next: http://localhost:59197/tests/dromaeo/cssquery-jquery.html) 13:15:00 INFO - PROCESS | 21971 | RSS: Main: 236777472 13:15:00 INFO - PROCESS | 21971 | 13:18:02 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59197/tests/dromaeo/cssquery-mootools.html) 13:18:02 INFO - PROCESS | 21971 | RSS: Main: 238391296 13:18:02 INFO - PROCESS | 21971 | 13:21:04 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59197/tests/dromaeo/cssquery-prototype.html) 13:21:05 INFO - PROCESS | 21971 | RSS: Main: 233664512 13:21:05 INFO - PROCESS | 21971 | 13:24:08 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59197/tests/dromaeo/cssquery-yui.html) 13:24:08 INFO - PROCESS | 21971 | RSS: Main: 207572992 13:24:08 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | Cycle 1(1): loaded http://localhost:59197/tests/dromaeo/cssquery-yui.html (next: http://localhost:59197/tests/dromaeo/cssquery-dojo.html) 13:27:11 INFO - PROCESS | 21971 | RSS: Main: 279293952 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | __start_tp_report 13:27:11 INFO - PROCESS | 21971 | _x_x_mozilla_page_load 13:27:11 INFO - PROCESS | 21971 | _x_x_mozilla_page_load_details 13:27:11 INFO - PROCESS | 21971 | |i|pagename|runs| 13:27:11 INFO - PROCESS | 21971 | |0;dojo.html;2671.198640407878;2695.5687090065594;2724.155511791344;2726.0867609350867;2744.656917885264;4669.696469729473;4709.882252943678;4728.101660684468;4800.5679488846;4853.005133947541;4712.03403302323;4714.5756881880625;4721.38621979143;4769.950610865604;4774.045190961813;4301.698881078318;4370.584794444522;4382.693211475198;4435.268180750172;4542.295944128666;4477.888052798674;4496.460424749034;4497.662675299365;4521.864344069683;4557.248054071074;4307.978460107711;4361.0841723237845;4368.606825385698;4409.82360705573;4417.094495628388;4360.847370342054;4370.519242883281;4376.452943382077;4460.553944605514;4474.932876006863;4387.188370151533;4388.1004394099455;4389;4400.581944715279;4425.3140763181755;4544.295634176708;4628.375169352128;4662.393888794435;4692.36653051837;4753.191957367221;5172.405173405069;5182.481751824787;5183.481651834824;5189.143791274435;5194.480551944813;5172.32759741235;5187.3775146982225;5192.3769147702515;5196.53231209193;5210.817621383271;4666.906661866744;4692.906141877143;4727.0073284609925;4735;4850.8059677612855;5271.314729085195;5273.1035723927025;5293.708846013506;5293.947060529345;5295.12630415977;4999.675021123615;5039.44566097729;5041.873953151201;5048.545630893237;5048.798048078036;4951.702897826142;5048.293238946477;5093.490650934877;5094.1849304111165;5134.101532231844;5053.393592768818;5074.82238121664;5082.796688132434;5085.135526960352;5133.486651334837;4909.165441874889;5057.974710126426;5079.1365467870555;5080.974595127001;5084.771185296597;4212.957870421318;4242.066745316026;4261.680373971964;4262.211490874198;4270.50889147752;3756.7370284079852;3770.3967365221984;3811.7522361047;3855.9807200963814;3866.574676785551;4444.711093778894;4446.288593824973;4447.822087116544;4454.420925279757;4499.190145773792;5002.57478114357;5018.824341148043;5082.771275292621;5159.948400516022;5177.456367081478;4382.561743825592;4385.057212699285;4385.846495372647;4425.402570652921;4455.933161002587;4547.931781023287;4558.111168322212;4559.726416414959;4565.680402371869;4573.839915602938;4758.785854636619;4759.286107083826;4792.496787837227;4816.181249187716;4837.153498137882;5056.797728090983;5070.873228169326;5081.263216833612;5085.084684756779;5121.257417674491;4820.156472617208;4824.807007719652;4826.179549476527;4830.637702172421;4868.269759535956;4886.755662216804;4928.211486162197;4954.628402869871;4977.129002424634;5047.015831912742;5039.899202015866;5047.2429135629945;5058.418281897629;5061.620378471703;5123;4915.26271059344;4924.901501969869;4933.9013219736125;4937.111319962298;4974.253861920741;4837.105135549935;4909.828156014522;4922.778474968563;4959.057779022119;4999.550040496373;4876.463589005278;4909.803607855646;4915.18899381598;4956.132676781477;4963.975180124076;4858.222684370484;5023.4725353838785;5024.673396229234;5060.924086138637;5079.034983353151;4881.267809828554;4937.456879743298;4938.2098864183;4938.654294199371;4962.33008543842 13:27:11 INFO - PROCESS | 21971 | |1;ext.html;552.542819627961;577.024828040611;581.0035788622512;584.1646445582816;598.4643743849253;40172.799136004316;41218;41263.58736412635;41348;45237;41803.16393672132;42543.787281063625;42557;42578.574214257846;42639;7681.116671582769;7881.684732610689;7899.170587088359;7899.4075444341615;7902.3283020943;7703.229677032308;7777.883331750028;7849.960750196269;7851.175626559215;7853.332466740334;7809.297163255306;7888.684452621888;7898;7901.328387087105;7901.762947111596;7858.174891636381;7888.605569721491;7904.723334683258;7904.960475197645;7905.841883162333;7828.099768526636;7904.604769761489;7919.881201781978;7924.405669574805;7927.167647397056;39130;39518.40722389166;39577.60422395768;39663.20673586512;39692.206155876724;3101.65881753007;3107.331923636429;3179.856906439216;3315.7678962472637;3460.3079384123025;29825.552616710767;30443.543346849816;30508.694913050807;30530.54204186939;30617;3376.7805092669146;3435.347284016029;3515.9121021974656;3576.7853928764357;3603.621619729917;181394;181505;181623.09188454106;181635;182630;31549.684503155135;32643.34713305768;52410;52849.735751321765;52881;34140.829295853364;34159;34277.657223427945;34277.828610856785;34320.82839585786;11131.888681113247;11166.553337866557;11203;11207.71980700489;11275.66173014811;9008.279337653103;9056.547172641342;9078.364514483923;9081.77295567603;9087.591058402388;7781.377489800916;7799.45403821727;7851.803704907423;7876.212378762078;7916.881246781303;3122.6408962969094;3134.5768321276337;3139.121046107048;3148.3471177631927;3159.526071089309;900.2123142250531;931.3340961212765;966.7873067925045;980.1472718734747;1085.0831047764784;26827.195184144508;27871.44257114887;28083.444065899934;28183.57724634132;28593.28516787097;969.1035791892472;992.0922356044283;1000.6097621927454;1000.6497725796058;1025.2566889005411;14655.560333190022;14947.626309342353;15128.54614361571;15227.238638068053;15404.38382464689;398665;401879;402376;403646;405026;48274.517254827006;48815.26777098346;48969.51030489721;49089.263661045115;49190.75404623026;1093.792179485895;1181.8073295929269;1213.4478812140455;1222.1567118688076;1233.5250928392634;28272.85863570669;28779.683047543036;29021.12936611905;29308.85345573344;29390;41078.58921410867;41305.380419293135;41712.1657566853;41744.58255417407;41750.79124604358;304812;306474;306861;307174;307575;21964.670529941744;24242.393940151636;24767.752322476543;24912;25103.623445647965;37475.625243747214;37656;41760.07096899572;43115.7844210777;43455;37348;37415.6258437423;37717.245655087296;37818.24363512659;37853.43219851759;36650.26699466049;37107.814460927526;39100;40261.1947761049;40532.18935621212;36081.09797254985;36810;36913.630863692095;37253.25493490169;37342.62657373391;31734;33573.19374216838;33734;34159;34278.82860585681;24801.50396992086;25182.62226066574;25392.746072539037;25430.364240894127;25531.617025745 13:27:11 INFO - PROCESS | 21971 | |2;jquery.html;368.657148851568;369.4255432801993;370.8442454169249;373.36527902565626;379.133679542246;15651.686966260668;16488.42290519832;16506.58733531661;16880.07159606221;16903.66192676146;15257.77113343298;15923.20383980802;16683;16685.83314166861;16705.749413758804;5059.620528460362;5175.171972484403;5183.844484665466;5242.266082748418;5245.947540524603;3745.045013521562;3926.9803650981703;5142.0487209866105;5723.370429252779;6062.666553339564;6097.756089756426;6115.633062016271;6120.326764055951;6120.755169793225;6128.3258841527395;5983.1623572699855;6110.327863934964;6114.0828875669;6122.724477398506;6136.048912418582;3391.169163554945;4919.827806026772;5234.26720259164;5263.6841789492755;5413.53984911283;19149.329773457863;20094.598108037757;20243.39269821908;20526.794732052636;20532;1996.950076248091;2024.4230394337544;2059.258666879922;2385.666006759038;2531.4304281536693;12790.424430900632;12895.935520322431;13018.934905325508;13188.934055329757;13400.128991615515;1708.7949446066552;1754.929802807899;1756.2448147296657;1756.58720200754;1756.7891852977725;64999.35000650027;67792.66103669499;67927;68023;68189.65905170492;8581.914180858237;8678.132186781271;9710.854337184948;9909.256805739455;10070.647527336509;13371.465141394236;13525.39135738894;13546;13587.456501740018;13587.86412135866;6444.742210311629;6476.319986401454;6680.028718439557;6741.831454213684;6761.4590832733265;5962.910556341659;6103.267607886994;6170.074488826712;6212.751489940351;6225.439710426083;5965.343812180657;6187.133801267826;6237.037407231529;6266.780662676784;6274;1665.209025712801;1714.6056407026203;1724.749911262885;1752.9386471473438;1780.857531397485;789.6525528767324;901.5762591581946;923.3029063057348;976.4483067067226;999.3753903810118;16294.103824289541;16426.178691065397;16655.83344166567;17386.21762020712;17391.217395217245;878.83302172587;894.1505569708803;908.5729707037682;915.5305734296359;916.4272329793879;9436.245100391952;9926.900730992742;9969.152622027064;9981.451020193814;10161.39031658088;370265;377067;381568;382084;395354;64967.35032649613;65401.34598654048;66063.00905486422;66554;67790.3220967784;909.5952301225891;911.444019148319;941.8916824565263;945.394947233771;962.8748262725941;15120.697586048438;15140.091594504365;15266.465673701367;15285.159316237268;15491.922540387226;31332.686673132976;31630.841845790623;31725.841370792998;32320.35359292848;32472;40034;41268.587314126475;42112.84153688425;42124.4725316482;43230;7374.926250737424;7399.852002959803;7441.144268409203;7486.5508069516;7606.20134885829;6700.664966751546;9112;10425.322354046963;10812.783744324912;11101.889811018833;9592.616295348107;9679.177269932135;9703.02969703024;9747.415155090717;10090.495475226357;10033.849492257476;10160.237982151517;10174.491275436347;10199.337043092175;10241.283110182514;9930.453825039693;10027.29808913369;10112.544935477774;10337.793244135226;10703.411312377582;7532.585707786125;7578.810529736801;7685.654145563351;7704.922950770645;7838.608069596611;7804.84390312202;9335.953320233355;10350.741231469274;10363.37281951311;10481.633142839964 13:27:11 INFO - PROCESS | 21971 | |3;mootools.html;1275.0373468031635;1395.246566853899;1448.9929498998197;1513.1526345246664;1686.949391518254;6555.573887697302;7500.287472690093;7663.693452261909;7667.348275396584;7923.445358824884;7687.423443241765;7826;7829.256220659043;7833.764987050397;7849.136594974549;1834.7614810074672;2108.8840113793735;2143.6891650710677;2170.7395112586432;2177.4882902517975;2215.7784221577876;2234.340869443518;2235.35174799308;2239.4513344230686;2242.9102835886547;2162.740471143457;2184.4102092435032;2206.205765924274;2212.4690074382193;2212.966805497919;1813.7551430556905;2079.46973521751;2117.227212067592;2150.47313408216;2155.051777218019;2129.4676330917273;2152.1176317709665;2152.773958734326;2154.1814110638015;2157.2018353209255;7670.539767613961;7708.421868359896;7713.4214933880185;7717.421193410461;7723.227677232288;4308.612224899774;4433.490148632884;4444.577765112309;4447.444069491314;4448.510663826976;2811.676657184409;2858.3568697042997;2988.745956593692;3012.021093144737;3016.185629879942;937.0676177203658;954.9092836180621;958.3100167879115;961.3558915526614;962.9903700963041;10798.298110622864;10800.729981750519;10802.945985270102;10811.459427028618;10816.621418250403;4107.507099148062;4142.399352093929;4229.97885010573;4279.101388708406;4279.550647182001;9053.411528250643;9067.591958361758;9077.228435582918;9080.500572468578;9094.81810363789;4378.299472084451;4412.5659160772875;4433.224185767478;4445.622122119591;4454.22051141049;3369.4945758136478;3885.0675837798726;3920.5491368492417;3934.429507721364;4037.5356833963883;3602.0634634994567;3650.9817450913106;3720.162963333228;3745.4830793528663;3773.58490566043;1177.270092542612;1201.2492192379764;1204.644629834201;1208.2931485081326;1209.8064309710403;761.6991288441035;763.7059732003219;810.7810891059498;818.758466252457;835.778518692547;4891.070696567641;4905.3623029006;5163.122269214243;5198.142306519382;5410.215518749759;826.7478419082238;828.8756686496953;854.4019186569302;888.9733308000771;889.9911000889908;3533.5583052118486;3625.637436256406;3664.890053298352;3674.412094064937;3702.72229582777;8933.419327743675;9098.181163695299;9161.267098632094;9191.31065170115;9211.815763684688;9062.637494500277;9109;9154.542272886329;9168.954155229314;9173.220276276457;7224.349808517153;7249.565026098451;7447.180810110884;7488.850222995509;7515.774526764097;4948.752562371939;4978.029284289529;5019.749012549285;5026.070177017264;5121.487851214849;8754.430961987451;8807.251383632463;9067.138621830916;9114.088591140833;9148.268138548767;8969.192772650493;9173.128552787475;9178.128077832594;9250.95374523123;9336.159745622926;5687.77248910039;6010.579259451796;6214.316425193316;6220.968895155495;6358.936410635834;7402.222766609644;7419.740309089156;7475.88786168197;7502.662380192795;7508.624568771649;6792.592444453348;6794.93205067943;6798.354156355138;6866.073080134118;7110.5022648414115;6740.494462915399;6786.660666966533;6908.965455172893;6932.133483314586;6996.300369962963;6428.8071357859335;6436.227652681709;6503.707333170113;6510.44661203803;6512.641804700787;4407.647388208871;4411.0957253763545;4442.733820861039;4477.8208871644765;4533.614642755403;4306.461692288464;4410.140022695544;4426.667999899956;4461.643068554443;4475.7985890635655 13:27:11 INFO - PROCESS | 21971 | |4;prototype.html;298.44191362152776;300.8796481407438;304.53254254718996;307.72766101999724;309.41983780411726;4673.275642275448;4735.952640473594;4810.941592849576;4829.734364609945;4838.371011768474;4716.302131232754;4716.976415117928;4732.621390288778;4742.170120228955;4759.833405830796;3532.6507872264915;3625.4229410206513;3640.7087433005427;3715.90710232245;3729;3709.666130048295;3718;3719.8326075326677;3722.088088418341;3725.944110838326;3664.5236119304454;3680.650338217865;3682.981585092084;3686.4838922550866;3700.703943684499;3489.6510348965153;3546.4680297955256;3664.926701465956;3672.2288319452946;3683.7053035757076;3211.486162214058;3231.1727238666167;3236.6277878043857;3237.320162765822;3244.1403028197547;4518.570735780096;4529.433820772403;4532.841350552748;4543.477500087499;4548.317752337143;4000.159966407058;4177.6866734995;4186.330187170069;4193.370994350872;4200.70595058346;4904.798324410506;4924.409070911478;4934.9013019739405;4940;4940.6788558743565;3550.609432962372;3555.1823080691584;3559.804210768407;3560.12776869666;3562.6615471530163;5153.3558305211845;5169.922451163236;5170.508801663836;5175.404828444702;5189.299444574972;3441.63862794408;3602.1174812171184;3612.006698157975;3633.2006958469096;3652.3060618482937;3628.546431696038;3643.3259846928404;3643.3806252937065;3645.1616128290643;3662.6886714629554;4161.56303588125;4177.749335039907;4179;4180.7909604519655;4188.371744238389;4751.667383283137;4866.683665561727;4899.853004409873;4922.75386230687;4965.255211718271;1256.3969294738577;1261.2936755416995;1262.9242245465118;1271.3960868587346;1274.5730180389487;800.5636927874323;810.602804625741;815.3599424451895;823.4190354519337;856.6444925356033;4386.342048692658;4388.1223755249075;4398.670099742532;4401.889952751207;4406.735595864195;5013.473585273494;5017.67385119966;5023.648344615842;5032.295478632995;5033.697978121324;4232.920167125633;4365.738055716667;4385.407969924083;4386.8903277417685;4387.912241755211;2609.58246680534;2675.7190494998135;2680.544307467735;2688.534748562038;2692.192342297303;4758.906081324276;4771.4512831024185;4776.829676729154;4778.1638213312535;4816.157172494799;4859.1496488114435;5107.310513080761;5124.256982737556;5136.743162841843;5160.793568257228;4750.216214324736;4774.498677638868;4791.305260737174;4794.472608013186;4801.903961920742;5009.949900500948;5024.824131155392;5029.371328583927;5031.647784655039;5036.294918711456;4798.592119669867;4882.4385195701525;4892.657513973988;4932.3341348918875;4933.136701077226;4920.778564964657;4926.630502712239;4928.581070609039;4929.728864912464;4933.753312334297;3651.9634803652684;3660.10327469761;3663.432168013962;3664.047347689567;3675.761075530082;5008;5158.865049689062;5163.561097306771;5168.664036837594;5170.40540337866;4984.75076246179;4990.253411306014;4991.376077990251;4993.875153121201;5018.172001619692;4946.406431228275;4958.6281028923695;4961.454240033666;4966.801327946986;4978.257609836528;4714.882127946828;4870.4171144377515;4882.853514394574;4900.509949005071;4904.6566740327835;4798.7840547174765;4892.65751397413;4952.653314267966;4990.700557966534;5040.49595040493;4854.19905715553;4863.294822250825;4870.90258194827;4871.926921096116;4892.2661600760175 13:27:11 INFO - PROCESS | 21971 | |5;yui.html;673.8618583190445;701.4949236549684;726.8546290741853;735.2500449541468;755.9546427214364;12118.757624847509;12660.493580256778;12711.173773704715;12711.36443177842;12726.300053497054;12312.507499700001;12337.753244935097;12342.81485777714;12366.50533978642;12379.442925068372;629.3203340392388;782.069337488387;801.527099011583;802.5626033811558;805.6737021506299;803.6303300481785;805.9919400806004;807.5558442856435;809.3686924199134;810.1129263456505;665.4377051391566;849.9575021248944;851.8977722673288;852.3309202276214;852.5055467828645;823.505896462121;849.0575461238021;849.1126772522729;849.9630450849953;852.1521086518892;627.3318915355133;627.4948666323608;627.5857933763695;627.7991042866284;628.0108828594981;12043.277403355827;12107.818382724266;12128.514859405701;12196.939015304955;12218.511259549696;11575.652730418102;11810.40947952599;11914;12190.573329933499;12429.689257768538;9441.15029647335;9493.288003399704;9640.807183856283;10973.945130274378;11114.722131946766;4141.295979683431;4143.958560414388;4186.832526698929;4200.1179752252065;4212.936805947913;46990;47399.526004739855;47656.52343476556;47717.284240736415;47935.99999999965;9826.213902887752;9839.3112482127;9866.210703143732;9924.751881203028;10019.949900250453;16439.424620138238;16468.752968705478;16497.505074847773;16610.58473538171;16755.83244167567;6511.9348806511325;6528.347165283529;6540.771073012422;6568.704408301638;6668.166479190101;3621.855125794991;3674.375356189401;3691.53855768029;3697.1126929537254;3698.7595806272507;2666.719994400599;2757.8621068946472;2759.199832048683;2779.3190668286397;2790;399.55449673613714;538.4211972129976;553.6263022459824;556.3073972903679;568.3123420660963;602.17802699316;603.9124326972565;608.0757248981612;608.3794529579803;611.5566214494456;7779.7666070017995;8084.191580841869;8091.55496447701;8211.794705132419;8216.46988342782;581.1428143488321;598.6557729305666;600.642617642502;616.4144063140035;620.5376994139395;3718.1819999600043;3927.6072392761066;3968.146848427602;4030.6976976726864;4054.189162167578;58876.41123588795;59545;60794.69602652047;62162;62188.37811621826;53943.730281349126;54789.452105479235;56988.71505642528;57122.14316785252;58217;49496.75251623791;49708;49920.75356608961;50136;50998;7685.846283074419;7791.571463569559;7821.921780782347;7890.250426209501;7901.407394445325;33795.66204338024;33963.49054764131;34498.655013450545;34525.309493810484;34688.479672804424;40521.392179116745;44817;44910.55089449064;45679.77160114311;46090.308645369674;9651.662191823252;10041.598336066476;10504.42225677595;10604.204684648528;10614.469276536296;11726.94136529346;11885.16803823724;11907.571775673061;12052.216605920587;12392.690182745504;10499.737506562396;11290.49192786343;11321.320720756781;11997.820032699341;12151.635450936486;11280.379579123228;11438.370889601152;11464.656060318204;11607;11724.824127637921;10223.539940702834;10566.471676415995;10881.45592720345;11245.98786109254;11332.943335283271;9517.857232141385;9523.952380238054;9712.562934667816;9856.31005829585;9918;9569.952150239204;9638.10875224218;9682.75793105178;9717.659881904383;9897.25770567196 13:27:11 INFO - PROCESS | 21971 | __end_tp_report 13:27:11 INFO - PROCESS | 21971 | __start_cc_report 13:27:11 INFO - PROCESS | 21971 | _x_x_mozilla_cycle_collect,1050 13:27:11 INFO - PROCESS | 21971 | __end_cc_report 13:27:11 INFO - PROCESS | 21971 | __startTimestamp1464035231818__endTimestamp 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | ------- Summary: start ------- 13:27:11 INFO - PROCESS | 21971 | Number of tests: 6 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#0] dojo.html Cycles:165 Average:4715.75 Median:4837.15 stddev:485.56 (10.0%) stddev-sans-first:459.79 13:27:11 INFO - PROCESS | 21971 | Values: 2671.2 2695.6 2724.2 2726.1 2744.7 4669.7 4709.9 4728.1 4800.6 4853.0 4712.0 4714.6 4721.4 4770.0 4774.0 4301.7 4370.6 4382.7 4435.3 4542.3 4477.9 4496.5 4497.7 4521.9 4557.2 4308.0 4361.1 4368.6 4409.8 4417.1 4360.8 4370.5 4376.5 4460.6 4474.9 4387.2 4388.1 4389.0 4400.6 4425.3 4544.3 4628.4 4662.4 4692.4 4753.2 5172.4 5182.5 5183.5 5189.1 5194.5 5172.3 5187.4 5192.4 5196.5 5210.8 4666.9 4692.9 4727.0 4735.0 4850.8 5271.3 5273.1 5293.7 5293.9 5295.1 4999.7 5039.4 5041.9 5048.5 5048.8 4951.7 5048.3 5093.5 5094.2 5134.1 5053.4 5074.8 5082.8 5085.1 5133.5 4909.2 5058.0 5079.1 5081.0 5084.8 4213.0 4242.1 4261.7 4262.2 4270.5 3756.7 3770.4 3811.8 3856.0 3866.6 4444.7 4446.3 4447.8 4454.4 4499.2 5002.6 5018.8 5082.8 5159.9 5177.5 4382.6 4385.1 4385.8 4425.4 4455.9 4547.9 4558.1 4559.7 4565.7 4573.8 4758.8 4759.3 4792.5 4816.2 4837.2 5056.8 5070.9 5081.3 5085.1 5121.3 4820.2 4824.8 4826.2 4830.6 4868.3 4886.8 4928.2 4954.6 4977.1 5047.0 5039.9 5047.2 5058.4 5061.6 5123.0 4915.3 4924.9 4933.9 4937.1 4974.3 4837.1 4909.8 4922.8 4959.1 4999.6 4876.5 4909.8 4915.2 4956.1 4964.0 4858.2 5023.5 5024.7 5060.9 5079.0 4881.3 4937.5 4938.2 4938.7 4962.3 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#1] ext.html Cycles:180 Average:44550.05 Median:37565.81 stddev:82149.11 (218.7%) stddev-sans-first:82313.14 13:27:11 INFO - PROCESS | 21971 | Values: 552.5 577.0 581.0 584.2 598.5 40172.8 41218.0 41263.6 41348.0 45237.0 41803.2 42543.8 42557.0 42578.6 42639.0 7681.1 7881.7 7899.2 7899.4 7902.3 7703.2 7777.9 7850.0 7851.2 7853.3 7809.3 7888.7 7898.0 7901.3 7901.8 7858.2 7888.6 7904.7 7905.0 7905.8 7828.1 7904.6 7919.9 7924.4 7927.2 39130.0 39518.4 39577.6 39663.2 39692.2 3101.7 3107.3 3179.9 3315.8 3460.3 29825.6 30443.5 30508.7 30530.5 30617.0 3376.8 3435.3 3515.9 3576.8 3603.6 181394.0 181505.0 181623.1 181635.0 182630.0 31549.7 32643.3 52410.0 52849.7 52881.0 34140.8 34159.0 34277.7 34277.8 34320.8 11131.9 11166.6 11203.0 11207.7 11275.7 9008.3 9056.5 9078.4 9081.8 9087.6 7781.4 7799.5 7851.8 7876.2 7916.9 3122.6 3134.6 3139.1 3148.3 3159.5 900.2 931.3 966.8 980.1 1085.1 26827.2 27871.4 28083.4 28183.6 28593.3 969.1 992.1 1000.6 1000.6 1025.3 14655.6 14947.6 15128.5 15227.2 15404.4 398665.0 401879.0 402376.0 403646.0 405026.0 48274.5 48815.3 48969.5 49089.3 49190.8 1093.8 1181.8 1213.4 1222.2 1233.5 28272.9 28779.7 29021.1 29308.9 29390.0 41078.6 41305.4 41712.2 41744.6 41750.8 304812.0 306474.0 306861.0 307174.0 307575.0 21964.7 24242.4 24767.8 24912.0 25103.6 37475.6 37656.0 41760.1 43115.8 43455.0 37348.0 37415.6 37717.2 37818.2 37853.4 36650.3 37107.8 39100.0 40261.2 40532.2 36081.1 36810.0 36913.6 37253.3 37342.6 31734.0 33573.2 33734.0 34159.0 34278.8 24801.5 25182.6 25392.7 25430.4 25531.6 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#2] jquery.html Cycles:180 Average:23298.29 Median:24074.91 stddev:62638.05 (260.2%) stddev-sans-first:62790.11 13:27:11 INFO - PROCESS | 21971 | Values: 368.7 369.4 370.8 373.4 379.1 15651.7 16488.4 16506.6 16880.1 16903.7 15257.8 15923.2 16683.0 16685.8 16705.7 5059.6 5175.2 5183.8 5242.3 5245.9 3745.0 3927.0 5142.0 5723.4 6062.7 6097.8 6115.6 6120.3 6120.8 6128.3 5983.2 6110.3 6114.1 6122.7 6136.0 3391.2 4919.8 5234.3 5263.7 5413.5 19149.3 20094.6 20243.4 20526.8 20532.0 1997.0 2024.4 2059.3 2385.7 2531.4 12790.4 12895.9 13018.9 13188.9 13400.1 1708.8 1754.9 1756.2 1756.6 1756.8 64999.4 67792.7 67927.0 68023.0 68189.7 8581.9 8678.1 9710.9 9909.3 10070.6 13371.5 13525.4 13546.0 13587.5 13587.9 6444.7 6476.3 6680.0 6741.8 6761.5 5962.9 6103.3 6170.1 6212.8 6225.4 5965.3 6187.1 6237.0 6266.8 6274.0 1665.2 1714.6 1724.7 1752.9 1780.9 789.7 901.6 923.3 976.4 999.4 16294.1 16426.2 16655.8 17386.2 17391.2 878.8 894.2 908.6 915.5 916.4 9436.2 9926.9 9969.2 9981.5 10161.4 370265.0 377067.0 381568.0 382084.0 395354.0 64967.4 65401.3 66063.0 66554.0 67790.3 909.6 911.4 941.9 945.4 962.9 15120.7 15140.1 15266.5 15285.2 15491.9 31332.7 31630.8 31725.8 32320.4 32472.0 40034.0 41268.6 42112.8 42124.5 43230.0 7374.9 7399.9 7441.1 7486.6 7606.2 6700.7 9112.0 10425.3 10812.8 11101.9 9592.6 9679.2 9703.0 9747.4 10090.5 10033.8 10160.2 10174.5 10199.3 10241.3 9930.5 10027.3 10112.5 10337.8 10703.4 7532.6 7578.8 7685.7 7704.9 7838.6 7804.8 9336.0 10350.7 10363.4 10481.6 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#3] mootools.html Cycles:180 Average:5072.16 Median:5073.78 stddev:2853.27 (56.2%) stddev-sans-first:2847.00 13:27:11 INFO - PROCESS | 21971 | Values: 1275.0 1395.2 1449.0 1513.2 1686.9 6555.6 7500.3 7663.7 7667.3 7923.4 7687.4 7826.0 7829.3 7833.8 7849.1 1834.8 2108.9 2143.7 2170.7 2177.5 2215.8 2234.3 2235.4 2239.5 2242.9 2162.7 2184.4 2206.2 2212.5 2213.0 1813.8 2079.5 2117.2 2150.5 2155.1 2129.5 2152.1 2152.8 2154.2 2157.2 7670.5 7708.4 7713.4 7717.4 7723.2 4308.6 4433.5 4444.6 4447.4 4448.5 2811.7 2858.4 2988.7 3012.0 3016.2 937.1 954.9 958.3 961.4 963.0 10798.3 10800.7 10802.9 10811.5 10816.6 4107.5 4142.4 4230.0 4279.1 4279.6 9053.4 9067.6 9077.2 9080.5 9094.8 4378.3 4412.6 4433.2 4445.6 4454.2 3369.5 3885.1 3920.5 3934.4 4037.5 3602.1 3651.0 3720.2 3745.5 3773.6 1177.3 1201.2 1204.6 1208.3 1209.8 761.7 763.7 810.8 818.8 835.8 4891.1 4905.4 5163.1 5198.1 5410.2 826.7 828.9 854.4 889.0 890.0 3533.6 3625.6 3664.9 3674.4 3702.7 8933.4 9098.2 9161.3 9191.3 9211.8 9062.6 9109.0 9154.5 9169.0 9173.2 7224.3 7249.6 7447.2 7488.9 7515.8 4948.8 4978.0 5019.7 5026.1 5121.5 8754.4 8807.3 9067.1 9114.1 9148.3 8969.2 9173.1 9178.1 9251.0 9336.2 5687.8 6010.6 6214.3 6221.0 6358.9 7402.2 7419.7 7475.9 7502.7 7508.6 6792.6 6794.9 6798.4 6866.1 7110.5 6740.5 6786.7 6909.0 6932.1 6996.3 6428.8 6436.2 6503.7 6510.4 6512.6 4407.6 4411.1 4442.7 4477.8 4533.6 4306.5 4410.1 4426.7 4461.6 4475.8 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#4] prototype.html Cycles:180 Average:4104.78 Median:4739.06 stddev:1191.35 (25.1%) stddev-sans-first:1159.93 13:27:11 INFO - PROCESS | 21971 | Values: 298.4 300.9 304.5 307.7 309.4 4673.3 4736.0 4810.9 4829.7 4838.4 4716.3 4717.0 4732.6 4742.2 4759.8 3532.7 3625.4 3640.7 3715.9 3729.0 3709.7 3718.0 3719.8 3722.1 3725.9 3664.5 3680.7 3683.0 3686.5 3700.7 3489.7 3546.5 3664.9 3672.2 3683.7 3211.5 3231.2 3236.6 3237.3 3244.1 4518.6 4529.4 4532.8 4543.5 4548.3 4000.2 4177.7 4186.3 4193.4 4200.7 4904.8 4924.4 4934.9 4940.0 4940.7 3550.6 3555.2 3559.8 3560.1 3562.7 5153.4 5169.9 5170.5 5175.4 5189.3 3441.6 3602.1 3612.0 3633.2 3652.3 3628.5 3643.3 3643.4 3645.2 3662.7 4161.6 4177.7 4179.0 4180.8 4188.4 4751.7 4866.7 4899.9 4922.8 4965.3 1256.4 1261.3 1262.9 1271.4 1274.6 800.6 810.6 815.4 823.4 856.6 4386.3 4388.1 4398.7 4401.9 4406.7 5013.5 5017.7 5023.6 5032.3 5033.7 4232.9 4365.7 4385.4 4386.9 4387.9 2609.6 2675.7 2680.5 2688.5 2692.2 4758.9 4771.5 4776.8 4778.2 4816.2 4859.1 5107.3 5124.3 5136.7 5160.8 4750.2 4774.5 4791.3 4794.5 4801.9 5009.9 5024.8 5029.4 5031.6 5036.3 4798.6 4882.4 4892.7 4932.3 4933.1 4920.8 4926.6 4928.6 4929.7 4933.8 3652.0 3660.1 3663.4 3664.0 3675.8 5008.0 5158.9 5163.6 5168.7 5170.4 4984.8 4990.3 4991.4 4993.9 5018.2 4946.4 4958.6 4961.5 4966.8 4978.3 4714.9 4870.4 4882.9 4900.5 4904.7 4798.8 4892.7 4952.7 4990.7 5040.5 4854.2 4863.3 4870.9 4871.9 4892.3 13:27:11 INFO - PROCESS | 21971 | 13:27:11 INFO - PROCESS | 21971 | [#5] yui.html Cycles:180 Average:13823.78 Median:50028.38 stddev:16724.38 (33.4%) stddev-sans-first:16742.14 13:27:11 INFO - PROCESS | 21971 | Values: 673.9 701.5 726.9 735.3 756.0 12118.8 12660.5 12711.2 12711.4 12726.3 12312.5 12337.8 12342.8 12366.5 12379.4 629.3 782.1 801.5 802.6 805.7 803.6 806.0 807.6 809.4 810.1 665.4 850.0 851.9 852.3 852.5 823.5 849.1 849.1 850.0 852.2 627.3 627.5 627.6 627.8 628.0 12043.3 12107.8 12128.5 12196.9 12218.5 11575.7 11810.4 11914.0 12190.6 12429.7 9441.2 9493.3 9640.8 10973.9 11114.7 4141.3 4144.0 4186.8 4200.1 4212.9 46990.0 47399.5 47656.5 47717.3 47936.0 9826.2 9839.3 9866.2 9924.8 10019.9 16439.4 16468.8 16497.5 16610.6 16755.8 6511.9 6528.3 6540.8 6568.7 6668.2 3621.9 3674.4 3691.5 3697.1 3698.8 2666.7 2757.9 2759.2 2779.3 2790.0 399.6 538.4 553.6 556.3 568.3 602.2 603.9 608.1 608.4 611.6 7779.8 8084.2 8091.6 8211.8 8216.5 581.1 598.7 600.6 616.4 620.5 3718.2 3927.6 3968.1 4030.7 4054.2 58876.4 59545.0 60794.7 62162.0 62188.4 53943.7 54789.5 56988.7 57122.1 58217.0 49496.8 49708.0 49920.8 50136.0 50998.0 7685.8 7791.6 7821.9 7890.3 7901.4 33795.7 33963.5 34498.7 34525.3 34688.5 40521.4 44817.0 44910.6 45679.8 46090.3 9651.7 10041.6 10504.4 10604.2 10614.5 11726.9 11885.2 11907.6 12052.2 12392.7 10499.7 11290.5 11321.3 11997.8 12151.6 11280.4 11438.4 11464.7 11607.0 11724.8 10223.5 10566.5 10881.5 11246.0 11332.9 9517.9 9524.0 9712.6 9856.3 9918.0 9570.0 9638.1 9682.8 9717.7 9897.3 13:27:11 INFO - PROCESS | 21971 | -------- Summary: end -------- 13:27:11 INFO - PROCESS | 21971 | 13:27:12 INFO - TEST-INFO | 21971: exit 0 13:27:12 INFO - TEST-OK | dromaeo_css | took 1118730ms 13:27:12 INFO - TEST-START | kraken 13:27:12 INFO - operating with platform_type : linux_ 13:27:12 INFO - Initialising browser for kraken test... 13:27:12 INFO - TEST-INFO | started process 22160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRtXOZ/profile http://localhost:59197/getInfo.html) 13:27:16 INFO - PROCESS | 22160 | __metrics Screen width/height:1600/1200 13:27:16 INFO - PROCESS | 22160 | colorDepth:24 13:27:16 INFO - PROCESS | 22160 | Browser inner width/height: 1024/697 13:27:16 INFO - PROCESS | 22160 | __metrics 13:27:18 ERROR - PROCESS | 22160 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:27:18 INFO - TEST-INFO | 22160: exit 0 13:27:18 INFO - Browser initialized. 13:27:18 INFO - Running cycle 1/1 for kraken test... 13:27:18 INFO - TEST-INFO | started process 22241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRtXOZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:30 INFO - PROCESS | 22241 | RSS: Main: 155078656 13:27:30 INFO - PROCESS | 22241 | 13:27:33 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59197/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:34 INFO - PROCESS | 22241 | RSS: Main: 210784256 13:27:34 INFO - PROCESS | 22241 | 13:27:37 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59197/tests/kraken/driver.html?testName=audio-dft) 13:27:38 INFO - PROCESS | 22241 | RSS: Main: 199188480 13:27:38 INFO - PROCESS | 22241 | 13:27:41 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59197/tests/kraken/driver.html?testName=audio-fft) 13:27:42 INFO - PROCESS | 22241 | RSS: Main: 267689984 13:27:42 INFO - PROCESS | 22241 | 13:27:44 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59197/tests/kraken/driver.html?testName=audio-oscillator) 13:27:44 INFO - PROCESS | 22241 | RSS: Main: 177360896 13:27:44 INFO - PROCESS | 22241 | 13:27:47 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:47 INFO - PROCESS | 22241 | RSS: Main: 181387264 13:27:47 INFO - PROCESS | 22241 | 13:27:51 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59197/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:51 INFO - PROCESS | 22241 | RSS: Main: 216641536 13:27:51 INFO - PROCESS | 22241 | 13:27:55 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59197/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:56 INFO - PROCESS | 22241 | RSS: Main: 215089152 13:27:56 INFO - PROCESS | 22241 | 13:27:59 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59197/tests/kraken/driver.html?testName=json-parse-financial) 13:27:59 INFO - PROCESS | 22241 | RSS: Main: 216154112 13:27:59 INFO - PROCESS | 22241 | 13:28:01 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:02 INFO - PROCESS | 22241 | RSS: Main: 202780672 13:28:02 INFO - PROCESS | 22241 | 13:28:04 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:04 INFO - PROCESS | 22241 | RSS: Main: 206311424 13:28:04 INFO - PROCESS | 22241 | 13:28:07 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:07 INFO - PROCESS | 22241 | RSS: Main: 216829952 13:28:07 INFO - PROCESS | 22241 | 13:28:10 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:11 INFO - PROCESS | 22241 | RSS: Main: 225570816 13:28:11 INFO - PROCESS | 22241 | 13:28:14 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:15 INFO - PROCESS | 22241 | RSS: Main: 222937088 13:28:15 INFO - PROCESS | 22241 | 13:28:16 INFO - PROCESS | 22241 | Cycle 1(1): loaded http://localhost:59197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59197/tests/kraken/driver.html?testName=ai-astar) 13:28:17 INFO - PROCESS | 22241 | RSS: Main: 268972032 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | __start_tp_report 13:28:17 INFO - PROCESS | 22241 | _x_x_mozilla_page_load 13:28:17 INFO - PROCESS | 22241 | _x_x_mozilla_page_load_details 13:28:17 INFO - PROCESS | 22241 | |i|pagename|runs| 13:28:17 INFO - PROCESS | 22241 | |0;ai-astar;115;111;115;117;117;115;117;115;115;116 13:28:17 INFO - PROCESS | 22241 | |1;audio-beat-detection;156;130;132;209;129;131;155;133;186;130 13:28:17 INFO - PROCESS | 22241 | |2;audio-dft;162;160;161;161;161;159;163;162;161;162 13:28:17 INFO - PROCESS | 22241 | |3;audio-fft;76;77;75;141;76;79;75;76;136;75 13:28:17 INFO - PROCESS | 22241 | |4;audio-oscillator;94;94;165;93;94;93;123;93;93;137 13:28:17 INFO - PROCESS | 22241 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;117;117 13:28:17 INFO - PROCESS | 22241 | |6;imaging-darkroom;147;146;146;145;146;146;145;145;146;146 13:28:17 INFO - PROCESS | 22241 | |7;imaging-desaturate;94;95;94;95;94;97;94;94;95;95 13:28:17 INFO - PROCESS | 22241 | |8;json-parse-financial;63;65;64;63;65;64;65;129;69;62 13:28:17 INFO - PROCESS | 22241 | |9;json-stringify-tinderbox;65;65;64;65;65;72;64;65;66;65 13:28:17 INFO - PROCESS | 22241 | |10;stanford-crypto-aes;86;84;87;84;89;90;86;84;84;84 13:28:17 INFO - PROCESS | 22241 | |11;stanford-crypto-ccm;133;130;131;130;132;139;139;129;198;133 13:28:17 INFO - PROCESS | 22241 | |12;stanford-crypto-pbkdf2;171;173;170;172;169;174;175;171;173;173 13:28:17 INFO - PROCESS | 22241 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;69;67;66;66;65 13:28:17 INFO - PROCESS | 22241 | __end_tp_report 13:28:17 INFO - PROCESS | 22241 | __start_cc_report 13:28:17 INFO - PROCESS | 22241 | _x_x_mozilla_cycle_collect,2136 13:28:17 INFO - PROCESS | 22241 | __end_cc_report 13:28:17 INFO - PROCESS | 22241 | __startTimestamp1464035297077__endTimestamp 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | ------- Summary: start ------- 13:28:17 INFO - PROCESS | 22241 | Number of tests: 14 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:1.77 (1.5%) stddev-sans-first:1.87 13:28:17 INFO - PROCESS | 22241 | Values: 115.0 111.0 115.0 117.0 117.0 115.0 117.0 115.0 115.0 116.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:144.00 stddev:27.98 (19.4%) stddev-sans-first:29.56 13:28:17 INFO - PROCESS | 22241 | Values: 156.0 130.0 132.0 209.0 129.0 131.0 155.0 133.0 186.0 130.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 13:28:17 INFO - PROCESS | 22241 | Values: 162.0 160.0 161.0 161.0 161.0 159.0 163.0 162.0 161.0 162.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#3] audio-fft Cycles:10 Average:88.60 Median:76.00 stddev:26.35 (34.7%) stddev-sans-first:27.55 13:28:17 INFO - PROCESS | 22241 | Values: 76.0 77.0 75.0 141.0 76.0 79.0 75.0 76.0 136.0 75.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:25.39 (27.3%) stddev-sans-first:26.43 13:28:17 INFO - PROCESS | 22241 | Values: 94.0 94.0 165.0 93.0 94.0 93.0 123.0 93.0 93.0 137.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:28:17 INFO - PROCESS | 22241 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 13:28:17 INFO - PROCESS | 22241 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 13:28:17 INFO - PROCESS | 22241 | Values: 94.0 95.0 94.0 95.0 94.0 97.0 94.0 94.0 95.0 95.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:64.50 stddev:20.50 (31.8%) stddev-sans-first:21.55 13:28:17 INFO - PROCESS | 22241 | Values: 63.0 65.0 64.0 63.0 65.0 64.0 65.0 129.0 69.0 62.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:2.32 (3.6%) stddev-sans-first:2.45 13:28:17 INFO - PROCESS | 22241 | Values: 65.0 65.0 64.0 65.0 65.0 72.0 64.0 65.0 66.0 65.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:2.25 (2.6%) stddev-sans-first:2.39 13:28:17 INFO - PROCESS | 22241 | Values: 86.0 84.0 87.0 84.0 89.0 90.0 86.0 84.0 84.0 84.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:133.00 stddev:20.89 (15.7%) stddev-sans-first:22.03 13:28:17 INFO - PROCESS | 22241 | Values: 133.0 130.0 131.0 130.0 132.0 139.0 139.0 129.0 198.0 133.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:1.85 (1.1%) stddev-sans-first:1.92 13:28:17 INFO - PROCESS | 22241 | Values: 171.0 173.0 170.0 172.0 169.0 174.0 175.0 171.0 173.0 173.0 13:28:17 INFO - PROCESS | 22241 | 13:28:17 INFO - PROCESS | 22241 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 13:28:17 INFO - PROCESS | 22241 | Values: 66.0 66.0 65.0 66.0 67.0 69.0 67.0 66.0 66.0 65.0 13:28:17 INFO - PROCESS | 22241 | -------- Summary: end -------- 13:28:17 INFO - PROCESS | 22241 | 13:28:18 INFO - TEST-INFO | 22241: exit 0 13:28:18 INFO - TEST-OK | kraken | took 65502ms 13:28:18 INFO - SUITE-END | took 1184s 13:28:18 INFO - Completed test suite (00:19:44) 13:28:18 INFO - javascript benchmark 13:28:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.198640407878, 2695.5687090065594, 2724.155511791344, 2726.0867609350867, 2744.656917885264, 4669.696469729473, 4709.882252943678, 4728.101660684468, 4800.5679488846, 4853.005133947541, 4712.03403302323, 4714.5756881880625, 4721.38621979143, 4769.950610865604, 4774.045190961813, 4301.698881078318, 4370.584794444522, 4382.693211475198, 4435.268180750172, 4542.295944128666, 4477.888052798674, 4496.460424749034, 4497.662675299365, 4521.864344069683, 4557.248054071074, 4307.978460107711, 4361.0841723237845, 4368.606825385698, 4409.82360705573, 4417.094495628388, 4360.847370342054, 4370.519242883281, 4376.452943382077, 4460.553944605514, 4474.932876006863, 4387.188370151533, 4388.1004394099455, 4389.0, 4400.581944715279, 4425.3140763181755, 4544.295634176708, 4628.375169352128, 4662.393888794435, 4692.36653051837, 4753.191957367221, 5172.405173405069, 5182.481751824787, 5183.481651834824, 5189.143791274435, 5194.480551944813, 5172.32759741235, 5187.3775146982225, 5192.3769147702515, 5196.53231209193, 5210.817621383271, 4666.906661866744, 4692.906141877143, 4727.0073284609925, 4735.0, 4850.8059677612855, 5271.314729085195, 5273.1035723927025, 5293.708846013506, 5293.947060529345, 5295.12630415977, 4999.675021123615, 5039.44566097729, 5041.873953151201, 5048.545630893237, 5048.798048078036, 4951.702897826142, 5048.293238946477, 5093.490650934877, 5094.1849304111165, 5134.101532231844, 5053.393592768818, 5074.82238121664, 5082.796688132434, 5085.135526960352, 5133.486651334837, 4909.165441874889, 5057.974710126426, 5079.1365467870555, 5080.974595127001, 5084.771185296597, 4212.957870421318, 4242.066745316026, 4261.680373971964, 4262.211490874198, 4270.50889147752, 3756.7370284079852, 3770.3967365221984, 3811.7522361047, 3855.9807200963814, 3866.574676785551, 4444.711093778894, 4446.288593824973, 4447.822087116544, 4454.420925279757, 4499.190145773792, 5002.57478114357, 5018.824341148043, 5082.771275292621, 5159.948400516022, 5177.456367081478, 4382.561743825592, 4385.057212699285, 4385.846495372647, 4425.402570652921, 4455.933161002587, 4547.931781023287, 4558.111168322212, 4559.726416414959, 4565.680402371869, 4573.839915602938, 4758.785854636619, 4759.286107083826, 4792.496787837227, 4816.181249187716, 4837.153498137882, 5056.797728090983, 5070.873228169326, 5081.263216833612, 5085.084684756779, 5121.257417674491, 4820.156472617208, 4824.807007719652, 4826.179549476527, 4830.637702172421, 4868.269759535956, 4886.755662216804, 4928.211486162197, 4954.628402869871, 4977.129002424634, 5047.015831912742, 5039.899202015866, 5047.2429135629945, 5058.418281897629, 5061.620378471703, 5123.0, 4915.26271059344, 4924.901501969869, 4933.9013219736125, 4937.111319962298, 4974.253861920741, 4837.105135549935, 4909.828156014522, 4922.778474968563, 4959.057779022119, 4999.550040496373, 4876.463589005278, 4909.803607855646, 4915.18899381598, 4956.132676781477, 4963.975180124076, 4858.222684370484, 5023.4725353838785, 5024.673396229234, 5060.924086138637, 5079.034983353151, 4881.267809828554, 4937.456879743298, 4938.2098864183, 4938.654294199371, 4962.33008543842], "value": 4685.56804077603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.542819627961, 577.024828040611, 581.0035788622512, 584.1646445582816, 598.4643743849253, 40172.799136004316, 41218.0, 41263.58736412635, 41348.0, 45237.0, 41803.16393672132, 42543.787281063625, 42557.0, 42578.574214257846, 42639.0, 7681.116671582769, 7881.684732610689, 7899.170587088359, 7899.4075444341615, 7902.3283020943, 7703.229677032308, 7777.883331750028, 7849.960750196269, 7851.175626559215, 7853.332466740334, 7809.297163255306, 7888.684452621888, 7898.0, 7901.328387087105, 7901.762947111596, 7858.174891636381, 7888.605569721491, 7904.723334683258, 7904.960475197645, 7905.841883162333, 7828.099768526636, 7904.604769761489, 7919.881201781978, 7924.405669574805, 7927.167647397056, 39130.0, 39518.40722389166, 39577.60422395768, 39663.20673586512, 39692.206155876724, 3101.65881753007, 3107.331923636429, 3179.856906439216, 3315.7678962472637, 3460.3079384123025, 29825.552616710767, 30443.543346849816, 30508.694913050807, 30530.54204186939, 30617.0, 3376.7805092669146, 3435.347284016029, 3515.9121021974656, 3576.7853928764357, 3603.621619729917, 181394.0, 181505.0, 181623.09188454106, 181635.0, 182630.0, 31549.684503155135, 32643.34713305768, 52410.0, 52849.735751321765, 52881.0, 34140.829295853364, 34159.0, 34277.657223427945, 34277.828610856785, 34320.82839585786, 11131.888681113247, 11166.553337866557, 11203.0, 11207.71980700489, 11275.66173014811, 9008.279337653103, 9056.547172641342, 9078.364514483923, 9081.77295567603, 9087.591058402388, 7781.377489800916, 7799.45403821727, 7851.803704907423, 7876.212378762078, 7916.881246781303, 3122.6408962969094, 3134.5768321276337, 3139.121046107048, 3148.3471177631927, 3159.526071089309, 900.2123142250531, 931.3340961212765, 966.7873067925045, 980.1472718734747, 1085.0831047764784, 26827.195184144508, 27871.44257114887, 28083.444065899934, 28183.57724634132, 28593.28516787097, 969.1035791892472, 992.0922356044283, 1000.6097621927454, 1000.6497725796058, 1025.2566889005411, 14655.560333190022, 14947.626309342353, 15128.54614361571, 15227.238638068053, 15404.38382464689, 398665.0, 401879.0, 402376.0, 403646.0, 405026.0, 48274.517254827006, 48815.26777098346, 48969.51030489721, 49089.263661045115, 49190.75404623026, 1093.792179485895, 1181.8073295929269, 1213.4478812140455, 1222.1567118688076, 1233.5250928392634, 28272.85863570669, 28779.683047543036, 29021.12936611905, 29308.85345573344, 29390.0, 41078.58921410867, 41305.380419293135, 41712.1657566853, 41744.58255417407, 41750.79124604358, 304812.0, 306474.0, 306861.0, 307174.0, 307575.0, 21964.670529941744, 24242.393940151636, 24767.752322476543, 24912.0, 25103.623445647965, 37475.625243747214, 37656.0, 41760.07096899572, 43115.7844210777, 43455.0, 37348.0, 37415.6258437423, 37717.245655087296, 37818.24363512659, 37853.43219851759, 36650.26699466049, 37107.814460927526, 39100.0, 40261.1947761049, 40532.18935621212, 36081.09797254985, 36810.0, 36913.630863692095, 37253.25493490169, 37342.62657373391, 31734.0, 33573.19374216838, 33734.0, 34159.0, 34278.82860585681, 24801.50396992086, 25182.62226066574, 25392.746072539037, 25430.364240894127, 25531.617025745], "value": 16325.722262630095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.657148851568, 369.4255432801993, 370.8442454169249, 373.36527902565626, 379.133679542246, 15651.686966260668, 16488.42290519832, 16506.58733531661, 16880.07159606221, 16903.66192676146, 15257.77113343298, 15923.20383980802, 16683.0, 16685.83314166861, 16705.749413758804, 5059.620528460362, 5175.171972484403, 5183.844484665466, 5242.266082748418, 5245.947540524603, 3745.045013521562, 3926.9803650981703, 5142.0487209866105, 5723.370429252779, 6062.666553339564, 6097.756089756426, 6115.633062016271, 6120.326764055951, 6120.755169793225, 6128.3258841527395, 5983.1623572699855, 6110.327863934964, 6114.0828875669, 6122.724477398506, 6136.048912418582, 3391.169163554945, 4919.827806026772, 5234.26720259164, 5263.6841789492755, 5413.53984911283, 19149.329773457863, 20094.598108037757, 20243.39269821908, 20526.794732052636, 20532.0, 1996.950076248091, 2024.4230394337544, 2059.258666879922, 2385.666006759038, 2531.4304281536693, 12790.424430900632, 12895.935520322431, 13018.934905325508, 13188.934055329757, 13400.128991615515, 1708.7949446066552, 1754.929802807899, 1756.2448147296657, 1756.58720200754, 1756.7891852977725, 64999.35000650027, 67792.66103669499, 67927.0, 68023.0, 68189.65905170492, 8581.914180858237, 8678.132186781271, 9710.854337184948, 9909.256805739455, 10070.647527336509, 13371.465141394236, 13525.39135738894, 13546.0, 13587.456501740018, 13587.86412135866, 6444.742210311629, 6476.319986401454, 6680.028718439557, 6741.831454213684, 6761.4590832733265, 5962.910556341659, 6103.267607886994, 6170.074488826712, 6212.751489940351, 6225.439710426083, 5965.343812180657, 6187.133801267826, 6237.037407231529, 6266.780662676784, 6274.0, 1665.209025712801, 1714.6056407026203, 1724.749911262885, 1752.9386471473438, 1780.857531397485, 789.6525528767324, 901.5762591581946, 923.3029063057348, 976.4483067067226, 999.3753903810118, 16294.103824289541, 16426.178691065397, 16655.83344166567, 17386.21762020712, 17391.217395217245, 878.83302172587, 894.1505569708803, 908.5729707037682, 915.5305734296359, 916.4272329793879, 9436.245100391952, 9926.900730992742, 9969.152622027064, 9981.451020193814, 10161.39031658088, 370265.0, 377067.0, 381568.0, 382084.0, 395354.0, 64967.35032649613, 65401.34598654048, 66063.00905486422, 66554.0, 67790.3220967784, 909.5952301225891, 911.444019148319, 941.8916824565263, 945.394947233771, 962.8748262725941, 15120.697586048438, 15140.091594504365, 15266.465673701367, 15285.159316237268, 15491.922540387226, 31332.686673132976, 31630.841845790623, 31725.841370792998, 32320.35359292848, 32472.0, 40034.0, 41268.587314126475, 42112.84153688425, 42124.4725316482, 43230.0, 7374.926250737424, 7399.852002959803, 7441.144268409203, 7486.5508069516, 7606.20134885829, 6700.664966751546, 9112.0, 10425.322354046963, 10812.783744324912, 11101.889811018833, 9592.616295348107, 9679.177269932135, 9703.02969703024, 9747.415155090717, 10090.495475226357, 10033.849492257476, 10160.237982151517, 10174.491275436347, 10199.337043092175, 10241.283110182514, 9930.453825039693, 10027.29808913369, 10112.544935477774, 10337.793244135226, 10703.411312377582, 7532.585707786125, 7578.810529736801, 7685.654145563351, 7704.922950770645, 7838.608069596611, 7804.84390312202, 9335.953320233355, 10350.741231469274, 10363.37281951311, 10481.633142839964], "value": 8144.481083997239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.0373468031635, 1395.246566853899, 1448.9929498998197, 1513.1526345246664, 1686.949391518254, 6555.573887697302, 7500.287472690093, 7663.693452261909, 7667.348275396584, 7923.445358824884, 7687.423443241765, 7826.0, 7829.256220659043, 7833.764987050397, 7849.136594974549, 1834.7614810074672, 2108.8840113793735, 2143.6891650710677, 2170.7395112586432, 2177.4882902517975, 2215.7784221577876, 2234.340869443518, 2235.35174799308, 2239.4513344230686, 2242.9102835886547, 2162.740471143457, 2184.4102092435032, 2206.205765924274, 2212.4690074382193, 2212.966805497919, 1813.7551430556905, 2079.46973521751, 2117.227212067592, 2150.47313408216, 2155.051777218019, 2129.4676330917273, 2152.1176317709665, 2152.773958734326, 2154.1814110638015, 2157.2018353209255, 7670.539767613961, 7708.421868359896, 7713.4214933880185, 7717.421193410461, 7723.227677232288, 4308.612224899774, 4433.490148632884, 4444.577765112309, 4447.444069491314, 4448.510663826976, 2811.676657184409, 2858.3568697042997, 2988.745956593692, 3012.021093144737, 3016.185629879942, 937.0676177203658, 954.9092836180621, 958.3100167879115, 961.3558915526614, 962.9903700963041, 10798.298110622864, 10800.729981750519, 10802.945985270102, 10811.459427028618, 10816.621418250403, 4107.507099148062, 4142.399352093929, 4229.97885010573, 4279.101388708406, 4279.550647182001, 9053.411528250643, 9067.591958361758, 9077.228435582918, 9080.500572468578, 9094.81810363789, 4378.299472084451, 4412.5659160772875, 4433.224185767478, 4445.622122119591, 4454.22051141049, 3369.4945758136478, 3885.0675837798726, 3920.5491368492417, 3934.429507721364, 4037.5356833963883, 3602.0634634994567, 3650.9817450913106, 3720.162963333228, 3745.4830793528663, 3773.58490566043, 1177.270092542612, 1201.2492192379764, 1204.644629834201, 1208.2931485081326, 1209.8064309710403, 761.6991288441035, 763.7059732003219, 810.7810891059498, 818.758466252457, 835.778518692547, 4891.070696567641, 4905.3623029006, 5163.122269214243, 5198.142306519382, 5410.215518749759, 826.7478419082238, 828.8756686496953, 854.4019186569302, 888.9733308000771, 889.9911000889908, 3533.5583052118486, 3625.637436256406, 3664.890053298352, 3674.412094064937, 3702.72229582777, 8933.419327743675, 9098.181163695299, 9161.267098632094, 9191.31065170115, 9211.815763684688, 9062.637494500277, 9109.0, 9154.542272886329, 9168.954155229314, 9173.220276276457, 7224.349808517153, 7249.565026098451, 7447.180810110884, 7488.850222995509, 7515.774526764097, 4948.752562371939, 4978.029284289529, 5019.749012549285, 5026.070177017264, 5121.487851214849, 8754.430961987451, 8807.251383632463, 9067.138621830916, 9114.088591140833, 9148.268138548767, 8969.192772650493, 9173.128552787475, 9178.128077832594, 9250.95374523123, 9336.159745622926, 5687.77248910039, 6010.579259451796, 6214.316425193316, 6220.968895155495, 6358.936410635834, 7402.222766609644, 7419.740309089156, 7475.88786168197, 7502.662380192795, 7508.624568771649, 6792.592444453348, 6794.93205067943, 6798.354156355138, 6866.073080134118, 7110.5022648414115, 6740.494462915399, 6786.660666966533, 6908.965455172893, 6932.133483314586, 6996.300369962963, 6428.8071357859335, 6436.227652681709, 6503.707333170113, 6510.44661203803, 6512.641804700787, 4407.647388208871, 4411.0957253763545, 4442.733820861039, 4477.8208871644765, 4533.614642755403, 4306.461692288464, 4410.140022695544, 4426.667999899956, 4461.643068554443, 4475.7985890635655], "value": 4086.693019254735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.44191362152776, 300.8796481407438, 304.53254254718996, 307.72766101999724, 309.41983780411726, 4673.275642275448, 4735.952640473594, 4810.941592849576, 4829.734364609945, 4838.371011768474, 4716.302131232754, 4716.976415117928, 4732.621390288778, 4742.170120228955, 4759.833405830796, 3532.6507872264915, 3625.4229410206513, 3640.7087433005427, 3715.90710232245, 3729.0, 3709.666130048295, 3718.0, 3719.8326075326677, 3722.088088418341, 3725.944110838326, 3664.5236119304454, 3680.650338217865, 3682.981585092084, 3686.4838922550866, 3700.703943684499, 3489.6510348965153, 3546.4680297955256, 3664.926701465956, 3672.2288319452946, 3683.7053035757076, 3211.486162214058, 3231.1727238666167, 3236.6277878043857, 3237.320162765822, 3244.1403028197547, 4518.570735780096, 4529.433820772403, 4532.841350552748, 4543.477500087499, 4548.317752337143, 4000.159966407058, 4177.6866734995, 4186.330187170069, 4193.370994350872, 4200.70595058346, 4904.798324410506, 4924.409070911478, 4934.9013019739405, 4940.0, 4940.6788558743565, 3550.609432962372, 3555.1823080691584, 3559.804210768407, 3560.12776869666, 3562.6615471530163, 5153.3558305211845, 5169.922451163236, 5170.508801663836, 5175.404828444702, 5189.299444574972, 3441.63862794408, 3602.1174812171184, 3612.006698157975, 3633.2006958469096, 3652.3060618482937, 3628.546431696038, 3643.3259846928404, 3643.3806252937065, 3645.1616128290643, 3662.6886714629554, 4161.56303588125, 4177.749335039907, 4179.0, 4180.7909604519655, 4188.371744238389, 4751.667383283137, 4866.683665561727, 4899.853004409873, 4922.75386230687, 4965.255211718271, 1256.3969294738577, 1261.2936755416995, 1262.9242245465118, 1271.3960868587346, 1274.5730180389487, 800.5636927874323, 810.602804625741, 815.3599424451895, 823.4190354519337, 856.6444925356033, 4386.342048692658, 4388.1223755249075, 4398.670099742532, 4401.889952751207, 4406.735595864195, 5013.473585273494, 5017.67385119966, 5023.648344615842, 5032.295478632995, 5033.697978121324, 4232.920167125633, 4365.738055716667, 4385.407969924083, 4386.8903277417685, 4387.912241755211, 2609.58246680534, 2675.7190494998135, 2680.544307467735, 2688.534748562038, 2692.192342297303, 4758.906081324276, 4771.4512831024185, 4776.829676729154, 4778.1638213312535, 4816.157172494799, 4859.1496488114435, 5107.310513080761, 5124.256982737556, 5136.743162841843, 5160.793568257228, 4750.216214324736, 4774.498677638868, 4791.305260737174, 4794.472608013186, 4801.903961920742, 5009.949900500948, 5024.824131155392, 5029.371328583927, 5031.647784655039, 5036.294918711456, 4798.592119669867, 4882.4385195701525, 4892.657513973988, 4932.3341348918875, 4933.136701077226, 4920.778564964657, 4926.630502712239, 4928.581070609039, 4929.728864912464, 4933.753312334297, 3651.9634803652684, 3660.10327469761, 3663.432168013962, 3664.047347689567, 3675.761075530082, 5008.0, 5158.865049689062, 5163.561097306771, 5168.664036837594, 5170.40540337866, 4984.75076246179, 4990.253411306014, 4991.376077990251, 4993.875153121201, 5018.172001619692, 4946.406431228275, 4958.6281028923695, 4961.454240033666, 4966.801327946986, 4978.257609836528, 4714.882127946828, 4870.4171144377515, 4882.853514394574, 4900.509949005071, 4904.6566740327835, 4798.7840547174765, 4892.65751397413, 4952.653314267966, 4990.700557966534, 5040.49595040493, 4854.19905715553, 4863.294822250825, 4870.90258194827, 4871.926921096116, 4892.2661600760175], "value": 3727.8712473302508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.8618583190445, 701.4949236549684, 726.8546290741853, 735.2500449541468, 755.9546427214364, 12118.757624847509, 12660.493580256778, 12711.173773704715, 12711.36443177842, 12726.300053497054, 12312.507499700001, 12337.753244935097, 12342.81485777714, 12366.50533978642, 12379.442925068372, 629.3203340392388, 782.069337488387, 801.527099011583, 802.5626033811558, 805.6737021506299, 803.6303300481785, 805.9919400806004, 807.5558442856435, 809.3686924199134, 810.1129263456505, 665.4377051391566, 849.9575021248944, 851.8977722673288, 852.3309202276214, 852.5055467828645, 823.505896462121, 849.0575461238021, 849.1126772522729, 849.9630450849953, 852.1521086518892, 627.3318915355133, 627.4948666323608, 627.5857933763695, 627.7991042866284, 628.0108828594981, 12043.277403355827, 12107.818382724266, 12128.514859405701, 12196.939015304955, 12218.511259549696, 11575.652730418102, 11810.40947952599, 11914.0, 12190.573329933499, 12429.689257768538, 9441.15029647335, 9493.288003399704, 9640.807183856283, 10973.945130274378, 11114.722131946766, 4141.295979683431, 4143.958560414388, 4186.832526698929, 4200.1179752252065, 4212.936805947913, 46990.0, 47399.526004739855, 47656.52343476556, 47717.284240736415, 47935.99999999965, 9826.213902887752, 9839.3112482127, 9866.210703143732, 9924.751881203028, 10019.949900250453, 16439.424620138238, 16468.752968705478, 16497.505074847773, 16610.58473538171, 16755.83244167567, 6511.9348806511325, 6528.347165283529, 6540.771073012422, 6568.704408301638, 6668.166479190101, 3621.855125794991, 3674.375356189401, 3691.53855768029, 3697.1126929537254, 3698.7595806272507, 2666.719994400599, 2757.8621068946472, 2759.199832048683, 2779.3190668286397, 2790.0, 399.55449673613714, 538.4211972129976, 553.6263022459824, 556.3073972903679, 568.3123420660963, 602.17802699316, 603.9124326972565, 608.0757248981612, 608.3794529579803, 611.5566214494456, 7779.7666070017995, 8084.191580841869, 8091.55496447701, 8211.794705132419, 8216.46988342782, 581.1428143488321, 598.6557729305666, 600.642617642502, 616.4144063140035, 620.5376994139395, 3718.1819999600043, 3927.6072392761066, 3968.146848427602, 4030.6976976726864, 4054.189162167578, 58876.41123588795, 59545.0, 60794.69602652047, 62162.0, 62188.37811621826, 53943.730281349126, 54789.452105479235, 56988.71505642528, 57122.14316785252, 58217.0, 49496.75251623791, 49708.0, 49920.75356608961, 50136.0, 50998.0, 7685.846283074419, 7791.571463569559, 7821.921780782347, 7890.250426209501, 7901.407394445325, 33795.66204338024, 33963.49054764131, 34498.655013450545, 34525.309493810484, 34688.479672804424, 40521.392179116745, 44817.0, 44910.55089449064, 45679.77160114311, 46090.308645369674, 9651.662191823252, 10041.598336066476, 10504.42225677595, 10604.204684648528, 10614.469276536296, 11726.94136529346, 11885.16803823724, 11907.571775673061, 12052.216605920587, 12392.690182745504, 10499.737506562396, 11290.49192786343, 11321.320720756781, 11997.820032699341, 12151.635450936486, 11280.379579123228, 11438.370889601152, 11464.656060318204, 11607.0, 11724.824127637921, 10223.539940702834, 10566.471676415995, 10881.45592720345, 11245.98786109254, 11332.943335283271, 9517.857232141385, 9523.952380238054, 9712.562934667816, 9856.31005829585, 9918.0, 9569.952150239204, 9638.10875224218, 9682.75793105178, 9717.659881904383, 9897.25770567196], "value": 6108.742192074046, "unit": "score"}], "name": "dromaeo_css", "value": 6221.403970300994, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 115.0, 117.0, 117.0, 115.0, 117.0, 115.0, 115.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 132.0, 209.0, 129.0, 131.0, 155.0, 133.0, 186.0, 130.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 159.0, 163.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 141.0, 76.0, 79.0, 75.0, 76.0, 136.0, 75.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 165.0, 93.0, 94.0, 93.0, 123.0, 93.0, 93.0, 137.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 97.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 65.0, 64.0, 65.0, 129.0, 69.0, 62.0], "value": 70.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 72.0, 64.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 89.0, 90.0, 86.0, 84.0, 84.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 131.0, 130.0, 132.0, 139.0, 139.0, 129.0, 198.0, 133.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 172.0, 169.0, 174.0, 175.0, 171.0, 173.0, 173.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 69.0, 67.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1579.6999999999998, "alertThreshold": 2.0}]} 13:28:18 INFO - Return code: 0 13:28:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:28:18 ERROR - # TBPL SUCCESS # 13:28:18 INFO - Running post-action listener: _resource_record_post_action 13:28:18 INFO - ##### 13:28:18 INFO - ##### Finished run-tests step (success) 13:28:18 INFO - ##### 13:28:18 INFO - Running post-run listener: _resource_record_post_run 13:28:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530690048; Read time: 16; Write time: 539620 13:28:18 INFO - TinderboxPrint: CPU usage
13.1% 13:28:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:28:18 INFO - TinderboxPrint: I/O write bytes / time
530,690,048 / 539,620 13:28:18 INFO - TinderboxPrint: CPU idle
8,332.9 (86.9%) 13:28:18 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 13:28:18 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236691456; Read time: 0; Write time: 236876 13:28:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293998592; Read time: 16; Write time: 302744 13:28:19 INFO - Running post-run listener: _upload_blobber_files 13:28:19 INFO - Blob upload gear active. 13:28:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:19 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 13:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:19 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:23 INFO - (blobuploader) - INFO - Done attempting. 13:28:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:24 INFO - (blobuploader) - INFO - Done attempting. 13:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:28:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:25 INFO - (blobuploader) - INFO - Done attempting. 13:28:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:25 INFO - Return code: 0 13:28:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab5b281e8406237ff14646c2fcaee53eb10a37a73057b3424d035968ba7ac1f6bb4bb99e56ae8001cfe29401babe5178908f2e46dd7be2cd44c3d1806928abac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/789114d2bc3d213b1fa0d61011b837795057a42f708605c9065c95c95cd851de9126aebf82d2e768cc6ce900de1aea602ead5b90ebaaf50021dabe1dddb68be3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/062d547ba0d35cf12c2edda83a934ed7f858b92ab92ca0042c85de946bcbb2f5d85fc7c69bec7a3e133c97a720b6c74bc2cd2423e2238c58787af4264d8d1b84"} 13:28:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:25 INFO - Contents: 13:28:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab5b281e8406237ff14646c2fcaee53eb10a37a73057b3424d035968ba7ac1f6bb4bb99e56ae8001cfe29401babe5178908f2e46dd7be2cd44c3d1806928abac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/789114d2bc3d213b1fa0d61011b837795057a42f708605c9065c95c95cd851de9126aebf82d2e768cc6ce900de1aea602ead5b90ebaaf50021dabe1dddb68be3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/062d547ba0d35cf12c2edda83a934ed7f858b92ab92ca0042c85de946bcbb2f5d85fc7c69bec7a3e133c97a720b6c74bc2cd2423e2238c58787af4264d8d1b84"} 13:28:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:25 INFO - Copying logs to upload dir... 13:28:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.746692 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-23 13:28:25.126911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 13:28:25.130892) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab5b281e8406237ff14646c2fcaee53eb10a37a73057b3424d035968ba7ac1f6bb4bb99e56ae8001cfe29401babe5178908f2e46dd7be2cd44c3d1806928abac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/789114d2bc3d213b1fa0d61011b837795057a42f708605c9065c95c95cd851de9126aebf82d2e768cc6ce900de1aea602ead5b90ebaaf50021dabe1dddb68be3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/062d547ba0d35cf12c2edda83a934ed7f858b92ab92ca0042c85de946bcbb2f5d85fc7c69bec7a3e133c97a720b6c74bc2cd2423e2238c58787af4264d8d1b84"} build_url:https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/HDWaafhkQdGZ8MuWo7JCiA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab5b281e8406237ff14646c2fcaee53eb10a37a73057b3424d035968ba7ac1f6bb4bb99e56ae8001cfe29401babe5178908f2e46dd7be2cd44c3d1806928abac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/789114d2bc3d213b1fa0d61011b837795057a42f708605c9065c95c95cd851de9126aebf82d2e768cc6ce900de1aea602ead5b90ebaaf50021dabe1dddb68be3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/062d547ba0d35cf12c2edda83a934ed7f858b92ab92ca0042c85de946bcbb2f5d85fc7c69bec7a3e133c97a720b6c74bc2cd2423e2238c58787af4264d8d1b84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 13:28:25.160531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:28:25.161118) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464032928.822869-130677025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:28:25.242333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 13:28:25.242686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 13:28:25.242985) ========= ========= Total master_lag: 0.18 =========