builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1463150253.7 results: success (0) buildid: 20160513054947 builduid: 347f26c9372c46e88e9698777bbaf45c revision: 1f1a8b96d5167153d1f750439ba6a1063155a4bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.697160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.697628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.697901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.717255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.717618) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 07:37:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.5M=0s 2016-05-13 07:37:33 (68.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087603 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.851374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.851695) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015755 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.889071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:33.889368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1f1a8b96d5167153d1f750439ba6a1063155a4bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1f1a8b96d5167153d1f750439ba6a1063155a4bc --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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 07:37:34,056 truncating revision to first 12 chars 2016-05-13 07:37:34,056 Setting DEBUG logging. 2016-05-13 07:37:34,056 attempt 1/10 2016-05-13 07:37:34,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1f1a8b96d516?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 07:37:34,319 unpacking tar archive at: mozilla-central-1f1a8b96d516/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586482 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:34.824167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:34.824431) ========= script_repo_revision: 1f1a8b96d5167153d1f750439ba6a1063155a4bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:34.824801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:34.825067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 07:37:34.867487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-13 07:37:34.867742) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:35 INFO - MultiFileLogger online at 20160513 07:37:35 in /builds/slave/test 07:37:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:37:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:35 INFO - {'append_to_log': False, 07:37:35 INFO - 'base_work_dir': '/builds/slave/test', 07:37:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:37:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:35 INFO - 'branch': 'Firefox-Non-PGO', 07:37:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:35 INFO - 'config_files': ('talos/linux_config.py',), 07:37:35 INFO - 'default_actions': ('clobber', 07:37:35 INFO - 'read-buildbot-config', 07:37:35 INFO - 'download-and-extract', 07:37:35 INFO - 'populate-webroot', 07:37:35 INFO - 'create-virtualenv', 07:37:35 INFO - 'install', 07:37:35 INFO - 'run-tests'), 07:37:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:35 INFO - 'download_minidump_stackwalk': True, 07:37:35 INFO - 'download_symbols': 'ondemand', 07:37:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:35 INFO - 'installer_path': 'installer.exe', 07:37:35 INFO - 'log_level': 'info', 07:37:35 INFO - 'log_name': 'talos', 07:37:35 INFO - 'log_to_console': True, 07:37:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:35 INFO - 'opt_config_files': (), 07:37:35 INFO - 'pip_index': False, 07:37:35 INFO - 'sps_profile': False, 07:37:35 INFO - 'sps_profile_interval': 0, 07:37:35 INFO - 'suite': 'dromaeojs', 07:37:35 INFO - 'system_bits': '32', 07:37:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:35 INFO - 'title': 'talos-linux64-ix-030', 07:37:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:35 INFO - 'use_talos_json': True, 07:37:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:35 INFO - 'work_dir': 'build'} 07:37:35 INFO - ##### 07:37:35 INFO - ##### Running clobber step. 07:37:35 INFO - ##### 07:37:35 INFO - Running pre-action listener: _resource_record_pre_action 07:37:35 INFO - Running main action method: clobber 07:37:35 INFO - rmtree: /builds/slave/test/build 07:37:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:36 INFO - Running post-action listener: _resource_record_post_action 07:37:36 INFO - ##### 07:37:36 INFO - ##### Finished clobber step (success) 07:37:36 INFO - ##### 07:37:36 INFO - ##### 07:37:36 INFO - ##### Running read-buildbot-config step. 07:37:36 INFO - ##### 07:37:36 INFO - Running pre-action listener: _resource_record_pre_action 07:37:36 INFO - Running main action method: read_buildbot_config 07:37:36 INFO - Using buildbot properties: 07:37:36 INFO - { 07:37:36 INFO - "project": "", 07:37:36 INFO - "product": "firefox", 07:37:36 INFO - "script_repo_revision": "production", 07:37:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:37:36 INFO - "repository": "", 07:37:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:37:36 INFO - "buildid": "20160513054947", 07:37:36 INFO - "pgo_build": "False", 07:37:36 INFO - "basedir": "/builds/slave/test", 07:37:36 INFO - "buildnumber": 504, 07:37:36 INFO - "slavename": "talos-linux64-ix-030", 07:37:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:37:36 INFO - "platform": "ubuntu64_hw", 07:37:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:37:36 INFO - "branch": "mozilla-central", 07:37:36 INFO - "repo_path": "mozilla-central", 07:37:36 INFO - "revision": "1f1a8b96d5167153d1f750439ba6a1063155a4bc", 07:37:36 INFO - "stage_platform": "linux64", 07:37:36 INFO - "builduid": "347f26c9372c46e88e9698777bbaf45c", 07:37:36 INFO - "slavebuilddir": "test" 07:37:36 INFO - } 07:37:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:37:36 INFO - Running post-action listener: _resource_record_post_action 07:37:36 INFO - ##### 07:37:36 INFO - ##### Finished read-buildbot-config step (success) 07:37:36 INFO - ##### 07:37:36 INFO - ##### 07:37:36 INFO - ##### Running download-and-extract step. 07:37:36 INFO - ##### 07:37:36 INFO - Running pre-action listener: _resource_record_pre_action 07:37:36 INFO - Running main action method: download_and_extract 07:37:36 INFO - mkdir: /builds/slave/test/build/tests 07:37: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')]} 07:37:36 INFO - https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:43 INFO - Downloaded 1361 bytes. 07:37:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:37:43 INFO - Using the following test package requirements: 07:37:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'jsshell-linux-x86_64.zip'], 07:37:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:43 INFO - https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:50 INFO - Downloaded 22334134 bytes. 07:37:50 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'] 07:37:50 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 07:37:51 INFO - Return code: 0 07:37:51 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 07:37:51 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')]} 07:37:51 INFO - https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:37:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:37:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:53 INFO - Downloaded 22334134 bytes. 07:37:53 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'] 07:37:53 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 07:37:55 INFO - Return code: 0 07:37: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')]} 07:37:55 INFO - https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:56 INFO - Downloaded 10840239 bytes. 07:37:56 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'] 07:37:56 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 07:37:56 INFO - Return code: 0 07:37:56 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')]} 07:37:56 INFO - https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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 07:37:57 INFO - Downloaded 54731942 bytes. 07:37:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:57 INFO - mkdir: /builds/slave/test/properties 07:37:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:57 INFO - Contents: 07:37:57 INFO - build_url:https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:58 INFO - Running post-action listener: _resource_record_post_action 07:37:58 INFO - Running post-action listener: set_extra_try_arguments 07:37:58 INFO - ##### 07:37:58 INFO - ##### Finished download-and-extract step (success) 07:37:58 INFO - ##### 07:37:58 INFO - ##### 07:37:58 INFO - ##### Running populate-webroot step. 07:37:58 INFO - ##### 07:37:58 INFO - Running pre-action listener: _resource_record_pre_action 07:37:58 INFO - Running main action method: populate_webroot 07:37:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:58 INFO - '--tppagecycles', 07:37:58 INFO - '7'], 07:37:58 INFO - 'tests': ['tsvgm']}}, 07:37:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['damp', 'tps']}, 07:37:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'tests': ['damp', 'tps']}, 07:37:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['dromaeo_dom']}, 07:37:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['a11yr', 07:37:58 INFO - 'ts_paint', 07:37:58 INFO - 'tpaint', 07:37:58 INFO - 'sessionrestore', 07:37:58 INFO - 'sessionrestore_no_auto_restore', 07:37:58 INFO - 'tabpaint']}, 07:37:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['tsvgx', 07:37:58 INFO - 'tsvgr_opacity', 07:37:58 INFO - 'tart', 07:37:58 INFO - 'tscrollx', 07:37:58 INFO - 'cart']}, 07:37:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:58 INFO - 'tsvgr_opacity', 07:37:58 INFO - 'tart', 07:37:58 INFO - 'tscrollx', 07:37:58 INFO - 'cart']}, 07:37:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'talos_options': ['--disable-e10s'], 07:37:58 INFO - 'tests': ['tp5o']}, 07:37:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'tests': ['tp5o']}, 07:37:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'talos_options': ['--disable-e10s', 07:37:58 INFO - '--xperf_path', 07:37:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:58 INFO - 'tests': ['tp5n']}, 07:37:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:58 INFO - 'talos_options': ['--xperf_path', 07:37:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:58 INFO - 'tests': ['tp5n']}}, 07:37:58 INFO - 'talos.zip': {'path': '', 07:37:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:58 INFO - Running post-action listener: _resource_record_post_action 07:37:58 INFO - ##### 07:37:58 INFO - ##### Finished populate-webroot step (success) 07:37:58 INFO - ##### 07:37:58 INFO - ##### 07:37:58 INFO - ##### Running create-virtualenv step. 07:37:58 INFO - ##### 07:37:58 INFO - Running pre-action listener: _resource_record_pre_action 07:37:58 INFO - Running main action method: create_virtualenv 07:37:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:58 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 07:37:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:58 INFO - Using real prefix '/usr' 07:37:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:01 INFO - Installing pip.................done. 07:38:01 INFO - Return code: 0 07:38:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:38:01 INFO - Using env: {'DISPLAY': ':0', 07:38:01 INFO - 'HOME': '/home/cltbld', 07:38:01 INFO - 'LANG': 'en_US.UTF-8', 07:38:01 INFO - 'LANGUAGE': 'en_US:en', 07:38:01 INFO - 'LOGNAME': 'cltbld', 07:38:01 INFO - 'MAIL': '/var/mail/cltbld', 07:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:01 INFO - 'MOZ_NO_REMOTE': '1', 07:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:01 INFO - 'NO_EM_RESTART': '1', 07:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:01 INFO - 'PWD': '/builds/slave/test', 07:38:01 INFO - 'SHELL': '/bin/bash', 07:38:01 INFO - 'SHLVL': '1', 07:38:01 INFO - 'TERM': 'linux', 07:38:01 INFO - 'TMOUT': '86400', 07:38:01 INFO - 'USER': 'cltbld', 07:38:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:01 INFO - '_': '/tools/buildbot/bin/python'} 07:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:01 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 07:38:01 INFO - Cleaning up... 07:38:01 INFO - Return code: 0 07:38:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:38:01 INFO - Using env: {'DISPLAY': ':0', 07:38:01 INFO - 'HOME': '/home/cltbld', 07:38:01 INFO - 'LANG': 'en_US.UTF-8', 07:38:01 INFO - 'LANGUAGE': 'en_US:en', 07:38:01 INFO - 'LOGNAME': 'cltbld', 07:38:01 INFO - 'MAIL': '/var/mail/cltbld', 07:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:01 INFO - 'MOZ_NO_REMOTE': '1', 07:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:01 INFO - 'NO_EM_RESTART': '1', 07:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:01 INFO - 'PWD': '/builds/slave/test', 07:38:01 INFO - 'SHELL': '/bin/bash', 07:38:01 INFO - 'SHLVL': '1', 07:38:01 INFO - 'TERM': 'linux', 07:38:01 INFO - 'TMOUT': '86400', 07:38:01 INFO - 'USER': 'cltbld', 07:38:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:01 INFO - '_': '/tools/buildbot/bin/python'} 07:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:01 INFO - Downloading/unpacking psutil>=3.1.1 07:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:03 INFO - Installing collected packages: psutil 07:38:03 INFO - Running setup.py install for psutil 07:38:03 INFO - building 'psutil._psutil_linux' extension 07:38:03 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 07:38:03 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 07:38:03 INFO - building 'psutil._psutil_posix' extension 07:38:03 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 07:38:03 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 07:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:04 INFO - Successfully installed psutil 07:38:04 INFO - Cleaning up... 07:38:04 INFO - Return code: 0 07:38:04 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 07:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:04 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:04 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.1'] in /builds/slave/test/build 07:38:04 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.1 07:38:04 INFO - Using env: {'DISPLAY': ':0', 07:38:04 INFO - 'HOME': '/home/cltbld', 07:38:04 INFO - 'LANG': 'en_US.UTF-8', 07:38:04 INFO - 'LANGUAGE': 'en_US:en', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MAIL': '/var/mail/cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SHLVL': '1', 07:38:04 INFO - 'TERM': 'linux', 07:38:04 INFO - 'TMOUT': '86400', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - '_': '/tools/buildbot/bin/python'} 07:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:04 INFO - Downloading/unpacking mozsystemmonitor==0.1 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:06 INFO - Downloading mozsystemmonitor-0.1.tar.gz 07:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 07:38:06 INFO - Installing collected packages: mozsystemmonitor 07:38:06 INFO - Running setup.py install for mozsystemmonitor 07:38:06 INFO - Successfully installed mozsystemmonitor 07:38:06 INFO - Cleaning up... 07:38:06 INFO - Return code: 0 07:38:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:06 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:06 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 07:38:06 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 07:38:06 INFO - Using env: {'DISPLAY': ':0', 07:38:06 INFO - 'HOME': '/home/cltbld', 07:38:06 INFO - 'LANG': 'en_US.UTF-8', 07:38:06 INFO - 'LANGUAGE': 'en_US:en', 07:38:06 INFO - 'LOGNAME': 'cltbld', 07:38:06 INFO - 'MAIL': '/var/mail/cltbld', 07:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:06 INFO - 'MOZ_NO_REMOTE': '1', 07:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:06 INFO - 'NO_EM_RESTART': '1', 07:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:06 INFO - 'PWD': '/builds/slave/test', 07:38:06 INFO - 'SHELL': '/bin/bash', 07:38:06 INFO - 'SHLVL': '1', 07:38:06 INFO - 'TERM': 'linux', 07:38:06 INFO - 'TMOUT': '86400', 07:38:06 INFO - 'USER': 'cltbld', 07:38:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:06 INFO - '_': '/tools/buildbot/bin/python'} 07:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:06 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 07:38:06 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 07:38:06 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 07:38:06 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 07:38:06 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 07:38:06 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 07:38:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:09 INFO - Downloading docopt-0.6.1.tar.gz 07:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:09 INFO - Running setup.py install for blobuploader 07:38:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:09 INFO - Running setup.py install for requests 07:38:09 INFO - Running setup.py install for docopt 07:38:09 INFO - Successfully installed blobuploader requests docopt 07:38:09 INFO - Cleaning up... 07:38:09 INFO - Return code: 0 07:38:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:09 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')]} 07:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:09 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')]} 07:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:09 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:09 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 07:38:09 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 07:38:09 INFO - Using env: {'DISPLAY': ':0', 07:38:09 INFO - 'HOME': '/home/cltbld', 07:38:09 INFO - 'LANG': 'en_US.UTF-8', 07:38:09 INFO - 'LANGUAGE': 'en_US:en', 07:38:09 INFO - 'LOGNAME': 'cltbld', 07:38:09 INFO - 'MAIL': '/var/mail/cltbld', 07:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:09 INFO - 'MOZ_NO_REMOTE': '1', 07:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:09 INFO - 'NO_EM_RESTART': '1', 07:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:09 INFO - 'PWD': '/builds/slave/test', 07:38:09 INFO - 'SHELL': '/bin/bash', 07:38:09 INFO - 'SHLVL': '1', 07:38:09 INFO - 'TERM': 'linux', 07:38:09 INFO - 'TMOUT': '86400', 07:38:09 INFO - 'USER': 'cltbld', 07:38:09 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:09 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:10 INFO - Running setup.py (path:/tmp/pip-YHO30k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:10 INFO - Running setup.py (path:/tmp/pip-Y5rbRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:10 INFO - Running setup.py (path:/tmp/pip-xmfkBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:10 INFO - Running setup.py (path:/tmp/pip-aVEZRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:10 INFO - Running setup.py (path:/tmp/pip-LJzXd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:10 INFO - Running setup.py (path:/tmp/pip-6lqUdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:10 INFO - Running setup.py (path:/tmp/pip-cB_ELP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:10 INFO - Running setup.py (path:/tmp/pip-m9L4r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:10 INFO - Running setup.py (path:/tmp/pip-VGplo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:10 INFO - Running setup.py (path:/tmp/pip-UvU_b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:10 INFO - Running setup.py (path:/tmp/pip-ENYDkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:10 INFO - Running setup.py (path:/tmp/pip-oGYBKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:10 INFO - Running setup.py (path:/tmp/pip-Y1oV50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:10 INFO - Running setup.py (path:/tmp/pip-oyhObS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:11 INFO - Running setup.py (path:/tmp/pip-17KDBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:11 INFO - Running setup.py (path:/tmp/pip-H8qxnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:11 INFO - Running setup.py (path:/tmp/pip-75IBd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:11 INFO - Running setup.py install for manifestparser 07:38:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Running setup.py install for mozcrash 07:38:11 INFO - Running setup.py install for mozdebug 07:38:11 INFO - Running setup.py install for mozdevice 07:38:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Running setup.py install for mozfile 07:38:11 INFO - Running setup.py install for mozhttpd 07:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Running setup.py install for mozinfo 07:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:11 INFO - Running setup.py install for mozInstall 07:38:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Running setup.py install for mozleak 07:38:12 INFO - Running setup.py install for mozlog 07:38:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Running setup.py install for moznetwork 07:38:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Running setup.py install for mozprocess 07:38:12 INFO - Running setup.py install for mozprofile 07:38:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Running setup.py install for mozrunner 07:38:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Running setup.py install for mozscreenshot 07:38:12 INFO - Running setup.py install for moztest 07:38:12 INFO - Running setup.py install for mozversion 07:38:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:12 INFO - Cleaning up... 07:38:13 INFO - Return code: 0 07:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:13 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:13 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 07:38:13 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 07:38:13 INFO - Using env: {'DISPLAY': ':0', 07:38:13 INFO - 'HOME': '/home/cltbld', 07:38:13 INFO - 'LANG': 'en_US.UTF-8', 07:38:13 INFO - 'LANGUAGE': 'en_US:en', 07:38:13 INFO - 'LOGNAME': 'cltbld', 07:38:13 INFO - 'MAIL': '/var/mail/cltbld', 07:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:13 INFO - 'MOZ_NO_REMOTE': '1', 07:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:13 INFO - 'NO_EM_RESTART': '1', 07:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:13 INFO - 'PWD': '/builds/slave/test', 07:38:13 INFO - 'SHELL': '/bin/bash', 07:38:13 INFO - 'SHLVL': '1', 07:38:13 INFO - 'TERM': 'linux', 07:38:13 INFO - 'TMOUT': '86400', 07:38:13 INFO - 'USER': 'cltbld', 07:38:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:13 INFO - '_': '/tools/buildbot/bin/python'} 07:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:13 INFO - Running setup.py (path:/tmp/pip-TUTM2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:13 INFO - Running setup.py (path:/tmp/pip-BlHTI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:13 INFO - Running setup.py (path:/tmp/pip-ydqxXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:13 INFO - Running setup.py (path:/tmp/pip-FS1LF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:13 INFO - Running setup.py (path:/tmp/pip-b0JCHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:13 INFO - Running setup.py (path:/tmp/pip-lUbxOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:13 INFO - Running setup.py (path:/tmp/pip-2odsY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:13 INFO - Running setup.py (path:/tmp/pip-kyd4vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:13 INFO - Running setup.py (path:/tmp/pip-_5K2jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:13 INFO - Running setup.py (path:/tmp/pip-WHBXmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:13 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)) 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:13 INFO - Running setup.py (path:/tmp/pip-lWBMUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 INFO - Running setup.py (path:/tmp/pip-RhDAug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:14 INFO - Running setup.py (path:/tmp/pip-MLOLeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:14 INFO - Running setup.py (path:/tmp/pip-oABNui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:14 INFO - Running setup.py (path:/tmp/pip-9tZ5w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:14 INFO - Running setup.py (path:/tmp/pip-EwJiIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:14 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)) 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:14 INFO - Running setup.py (path:/tmp/pip-nVo2K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:14 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)) 07:38:14 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)) 07:38:14 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)) 07:38:14 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)) 07:38:14 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)) 07:38:14 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)) 07:38:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:16 INFO - Downloading blessings-1.6.tar.gz 07:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:16 INFO - Installing collected packages: blessings 07:38:16 INFO - Running setup.py install for blessings 07:38:16 INFO - Successfully installed blessings 07:38:16 INFO - Cleaning up... 07:38:16 INFO - Return code: 0 07:38:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:16 INFO - Reading from file tmpfile_stdout 07:38:16 INFO - Current package versions: 07:38:16 INFO - argparse == 1.2.1 07:38:16 INFO - blessings == 1.6 07:38:16 INFO - blobuploader == 1.2.4 07:38:16 INFO - docopt == 0.6.1 07:38:16 INFO - manifestparser == 1.1 07:38:16 INFO - mozInstall == 1.12 07:38:16 INFO - mozcrash == 0.17 07:38:16 INFO - mozdebug == 0.1 07:38:16 INFO - mozdevice == 0.48 07:38:16 INFO - mozfile == 1.2 07:38:16 INFO - mozhttpd == 0.7 07:38:16 INFO - mozinfo == 0.9 07:38:16 INFO - mozleak == 0.1 07:38:16 INFO - mozlog == 3.2 07:38:16 INFO - moznetwork == 0.27 07:38:16 INFO - mozprocess == 0.22 07:38:16 INFO - mozprofile == 0.28 07:38:16 INFO - mozrunner == 6.11 07:38:16 INFO - mozscreenshot == 0.1 07:38:16 INFO - mozsystemmonitor == 0.1 07:38:16 INFO - moztest == 0.7 07:38:16 INFO - mozversion == 1.4 07:38:16 INFO - psutil == 3.1.1 07:38:16 INFO - requests == 1.2.3 07:38:16 INFO - wsgiref == 0.1.2 07:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:16 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')]} 07:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:16 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')]} 07:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:16 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:16 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 07:38:16 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 07:38:16 INFO - Using env: {'DISPLAY': ':0', 07:38:16 INFO - 'HOME': '/home/cltbld', 07:38:16 INFO - 'LANG': 'en_US.UTF-8', 07:38:16 INFO - 'LANGUAGE': 'en_US:en', 07:38:16 INFO - 'LOGNAME': 'cltbld', 07:38:16 INFO - 'MAIL': '/var/mail/cltbld', 07:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:16 INFO - 'MOZ_NO_REMOTE': '1', 07:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:16 INFO - 'NO_EM_RESTART': '1', 07:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:16 INFO - 'PWD': '/builds/slave/test', 07:38:16 INFO - 'SHELL': '/bin/bash', 07:38:16 INFO - 'SHLVL': '1', 07:38:16 INFO - 'TERM': 'linux', 07:38:16 INFO - 'TMOUT': '86400', 07:38:16 INFO - 'USER': 'cltbld', 07:38:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:16 INFO - '_': '/tools/buildbot/bin/python'} 07:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 INFO - Cleaning up... 07:38:17 INFO - Return code: 0 07:38:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:17 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')]} 07:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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')]} 07:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:17 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 07:38:17 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 07:38:17 INFO - Using env: {'DISPLAY': ':0', 07:38:17 INFO - 'HOME': '/home/cltbld', 07:38:17 INFO - 'LANG': 'en_US.UTF-8', 07:38:17 INFO - 'LANGUAGE': 'en_US:en', 07:38:17 INFO - 'LOGNAME': 'cltbld', 07:38:17 INFO - 'MAIL': '/var/mail/cltbld', 07:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:17 INFO - 'MOZ_NO_REMOTE': '1', 07:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:17 INFO - 'NO_EM_RESTART': '1', 07:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:17 INFO - 'PWD': '/builds/slave/test', 07:38:17 INFO - 'SHELL': '/bin/bash', 07:38:17 INFO - 'SHLVL': '1', 07:38:17 INFO - 'TERM': 'linux', 07:38:17 INFO - 'TMOUT': '86400', 07:38:17 INFO - 'USER': 'cltbld', 07:38:17 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:17 INFO - '_': '/tools/buildbot/bin/python'} 07:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:17 INFO - Downloading/unpacking jsonschema 07:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:19 INFO - warning: no files found matching '*.txt' 07:38:19 INFO - no previously-included directories found matching 'build' 07:38:19 INFO - no previously-included directories found matching 'dist' 07:38:19 INFO - no previously-included directories found matching '.git*' 07:38:19 INFO - Installing collected packages: jsonschema, functools32 07:38:19 INFO - Running setup.py install for functools32 07:38:19 INFO - warning: no files found matching '*.txt' 07:38:19 INFO - no previously-included directories found matching 'build' 07:38:19 INFO - no previously-included directories found matching 'dist' 07:38:19 INFO - no previously-included directories found matching '.git*' 07:38:19 INFO - Successfully installed jsonschema functools32 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:38:19 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')]} 07:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 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')]} 07:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 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 0x7f25a7373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', '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 07:38:19 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 07:38:19 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 07:38:19 INFO - Using env: {'DISPLAY': ':0', 07:38:19 INFO - 'HOME': '/home/cltbld', 07:38:19 INFO - 'LANG': 'en_US.UTF-8', 07:38:19 INFO - 'LANGUAGE': 'en_US:en', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MAIL': '/var/mail/cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SHLVL': '1', 07:38:19 INFO - 'TERM': 'linux', 07:38:19 INFO - 'TMOUT': '86400', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - '_': '/tools/buildbot/bin/python'} 07:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:19 INFO - Downloading/unpacking flake8 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:19 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 07:38:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:21 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 07:38:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:22 INFO - no previously-included directories found matching 'docs/_build' 07:38:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:22 INFO - Running setup.py install for pep8 07:38:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:22 INFO - no previously-included directories found matching 'docs/_build' 07:38:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:22 INFO - Cleaning up... 07:38:22 INFO - Return code: 0 07:38:22 INFO - Running post-action listener: _resource_record_post_action 07:38:22 INFO - Running post-action listener: _start_resource_monitoring 07:38:22 INFO - Starting resource monitoring. 07:38:22 INFO - ##### 07:38:22 INFO - ##### Finished create-virtualenv step (success) 07:38:22 INFO - ##### 07:38:22 INFO - ##### 07:38:22 INFO - ##### Running install step. 07:38:22 INFO - ##### 07:38:22 INFO - Running pre-action listener: _resource_record_pre_action 07:38:22 INFO - Running main action method: install 07:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:22 INFO - Reading from file tmpfile_stdout 07:38:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:23 INFO - Reading from file tmpfile_stdout 07:38:23 INFO - Output received: 07:38:23 INFO - Usage: mozinstall [options] installer 07:38:23 INFO - Options: 07:38:23 INFO - -h, --help show this help message and exit 07:38:23 INFO - -d DEST, --destination=DEST 07:38:23 INFO - Directory to install application into. [default: 07:38:23 INFO - "/builds/slave/test"] 07:38:23 INFO - --app=APP Application being installed. [default: firefox] 07:38:23 INFO - mkdir: /builds/slave/test/build/application 07:38:23 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'] 07:38:23 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 07:38:38 INFO - Reading from file tmpfile_stdout 07:38:38 INFO - Output received: 07:38:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:38 INFO - Running post-action listener: _resource_record_post_action 07:38:38 INFO - ##### 07:38:38 INFO - ##### Finished install step (success) 07:38:38 INFO - ##### 07:38:38 INFO - ##### 07:38:38 INFO - ##### Running run-tests step. 07:38:38 INFO - ##### 07:38:38 INFO - Running pre-action listener: _resource_record_pre_action 07:38:38 INFO - Running main action method: run_tests 07:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:38 INFO - Python 2.7.3 07:38:38 INFO - Return code: 0 07:38:38 INFO - grabbing minidump binary from tooltool 07:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:38 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 0x229d9c0>, '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 0x229e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:38 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 07:38:38 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 07:38:38 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 07:38:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:38 INFO - Return code: 0 07:38:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:38:39 INFO - Return code: 0 07:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 07:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 07:38:39 INFO - Using env: {'DISPLAY': ':0', 07:38:39 INFO - 'HOME': '/home/cltbld', 07:38:39 INFO - 'LANG': 'en_US.UTF-8', 07:38:39 INFO - 'LANGUAGE': 'en_US:en', 07:38:39 INFO - 'LOGNAME': 'cltbld', 07:38:39 INFO - 'MAIL': '/var/mail/cltbld', 07:38:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:39 INFO - 'MOZ_NO_REMOTE': '1', 07:38:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:39 INFO - 'NO_EM_RESTART': '1', 07:38:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:39 INFO - 'PWD': '/builds/slave/test', 07:38:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:39 INFO - 'SHELL': '/bin/bash', 07:38:39 INFO - 'SHLVL': '1', 07:38:39 INFO - 'TERM': 'linux', 07:38:39 INFO - 'TMOUT': '86400', 07:38:39 INFO - 'USER': 'cltbld', 07:38:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508', 07:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:39 INFO - '_': '/tools/buildbot/bin/python'} 07:38:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 07:38:39 INFO - mozversion application_buildid: 20160513054947 07:38:39 INFO - mozversion application_changeset: 1f1a8b96d5167153d1f750439ba6a1063155a4bc 07:38:39 INFO - mozversion application_display_name: Nightly 07:38:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:39 INFO - mozversion application_name: Firefox 07:38:39 INFO - mozversion application_remotingname: firefox 07:38:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:39 INFO - mozversion application_vendor: Mozilla 07:38:39 INFO - mozversion application_version: 49.0a1 07:38:39 INFO - mozversion platform_buildid: 20160513054947 07:38:39 INFO - mozversion platform_changeset: 1f1a8b96d5167153d1f750439ba6a1063155a4bc 07:38:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:39 INFO - mozversion platform_version: 49.0a1 07:38:39 INFO - using testdate: 1463150319 07:38:39 INFO - actual date: 1463150319 07:38:39 INFO - starting webserver on 'localhost:45392' 07:38:39 INFO - SUITE-START | Running 2 tests 07:38:39 INFO - TEST-START | dromaeo_css 07:38:39 INFO - operating with platform_type : linux_ 07:38:39 INFO - Initialising browser for dromaeo_css test... 07:38:39 INFO - TEST-INFO | started process 11236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqcboSp/profile http://localhost:45392/getInfo.html) 07:38:43 INFO - PROCESS | 11236 | __metrics Screen width/height:1600/1200 07:38:43 INFO - PROCESS | 11236 | colorDepth:24 07:38:43 INFO - PROCESS | 11236 | Browser inner width/height: 1024/697 07:38:43 INFO - PROCESS | 11236 | __metrics 07:38:44 ERROR - PROCESS | 11236 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:38:45 INFO - TEST-INFO | 11236: exit 0 07:38:45 INFO - Browser initialized. 07:38:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:45 INFO - TEST-INFO | started process 11317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqcboSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:57 INFO - PROCESS | 11317 | RSS: Main: 154632192 07:38:57 INFO - PROCESS | 11317 | 07:39:49 INFO - PROCESS | 11317 | 1463150389473 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] 07:42:01 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45392/tests/dromaeo/cssquery-ext.html) 07:42:02 INFO - PROCESS | 11317 | RSS: Main: 270675968 07:42:02 INFO - PROCESS | 11317 | 07:45:05 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-ext.html (next: http://localhost:45392/tests/dromaeo/cssquery-jquery.html) 07:45:05 INFO - PROCESS | 11317 | RSS: Main: 240660480 07:45:05 INFO - PROCESS | 11317 | 07:48:08 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45392/tests/dromaeo/cssquery-mootools.html) 07:48:08 INFO - PROCESS | 11317 | RSS: Main: 234684416 07:48:08 INFO - PROCESS | 11317 | 07:51:10 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45392/tests/dromaeo/cssquery-prototype.html) 07:51:11 INFO - PROCESS | 11317 | RSS: Main: 235659264 07:51:11 INFO - PROCESS | 11317 | 07:54:14 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45392/tests/dromaeo/cssquery-yui.html) 07:54:15 INFO - PROCESS | 11317 | RSS: Main: 223309824 07:54:15 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | Cycle 1(1): loaded http://localhost:45392/tests/dromaeo/cssquery-yui.html (next: http://localhost:45392/tests/dromaeo/cssquery-dojo.html) 07:57:17 INFO - PROCESS | 11317 | RSS: Main: 272158720 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | __start_tp_report 07:57:17 INFO - PROCESS | 11317 | _x_x_mozilla_page_load 07:57:17 INFO - PROCESS | 11317 | _x_x_mozilla_page_load_details 07:57:17 INFO - PROCESS | 11317 | |i|pagename|runs| 07:57:17 INFO - PROCESS | 11317 | |0;dojo.html;2657.4020845309806;2676.1703871799755;2709.200785768197;2713.2267303818408;2725.250556097073;4728.621710263179;4755.191617425037;4789.042191561684;4792.4967878372745;4873.537013983675;4797.928031079537;4830.347903033089;4830.710157390559;4872.707637541741;4879.853604391874;4405.977970110153;4426.800793964279;4474.149911516818;4536.455625324966;4616.676832621718;4546.045330480603;4577.473590537081;4593.977030114861;4597.678162528624;4615.05391394765;4293.592108749664;4344.196323680129;4416.205083085043;4460.955390446086;4480.731156130642;4426.225410553173;4432.490263619693;4434.290513517822;4478.261086920655;4485.282354823213;4463.129689710508;4469.039156581351;4472.932906006413;4474.418325617681;4506.842260520866;4652.534746525354;4671.976640116778;4707.176244157259;4735.431748190204;4816.301636262758;5206.76569554371;5248.422673505949;5254.632175747699;5266.34170728659;5277.208418737182;5243.79024839006;5244.554212891909;5251.186066159751;5255.448177941337;5284.682919024833;4709.434867815884;4787.928181077286;4848.660593758474;4848.757562121879;4926.384201974789;5321.627486075938;5377.892442151135;5390.595705322116;5397.568194544427;5402.972985135049;5119.257707632372;5125.461826508163;5152.742362881841;5174.663646862942;5178.171492561172;5071.746412679351;5169.276301317818;5240.135377662719;5245.868853278622;5338.813141540105;5219.530242278213;5222.764975576109;5229.111051121318;5238.1618940969265;5243.9213411798855;5223.007628550563;5225.895482090413;5233.084210263265;5233.502817232356;5273.815416460406;4341.60925516705;4368.366586844953;4368.868933931987;4432.534583868647;4477.865664030084;3843.942340864889;3870.903227419337;3885.4560361549406;3890.533136023695;3891.0272431892026;4439.933400998988;4449.087936972913;4450.376947227391;4451.6883818133065;4456.019675671347;5201;5204.34945631796;5256.185291279781;5261.921071183935;5337.706426146521;4446.933296000562;4492.483364413069;4493.707908985905;4496;4539.251023581138;4748.7863046163;4752.287156926489;4757.9286310705365;4764.023375208074;4811.639127065484;4802.975985120052;4849.612031037508;4895.853124406345;4911.68074075184;4919.016196760591;5225.372955245395;5238.2404551340605;5238.68567885928;5252.369715634149;5297.788088476418;4772.117158325721;4917.434495033117;4926.802927882988;4930;4933.407991041098;5076.466970968143;5116.2069879168785;5132.79468821243;5135.460776618401;5161.122609156528;5232.764525596282;5237.450067742832;5239.869003274948;5243.737813109253;5292.497212764782;4946.62900282473;5019.0965626187635;5093.7707803148205;5108.974455127701;5118.41138269089;5093.439721630692;5094;5098.337216161875;5108.48915108501;5165;4926.482719314564;4988.5260900214425;5004.449510553909;5039.571636410799;5047.444781074152;4984.37695288089;5048.343715316985;5132.281480592795;5160.845174644766;5161.225816127611;5006.098902197639;5011.5489605935645;5031.698098114125;5034.2951986721155;5075.92386114216 07:57:17 INFO - PROCESS | 11317 | |1;ext.html;554.5369616370331;594.0524862843764;604.4318340759683;604.6885853785299;612.3876123876124;42891.57108428915;44384.77807610957;44424.77787611065;44470.11059778802;48339.75830120844;42190;42581.36127958083;42620;42669.7866510667;42678.35982460258;8148.796280093001;8290.502569845828;8291.751247462586;8293.875591866097;8295.917040829574;8080.676772929076;8149.755507334759;8166.67333306667;8170.346372290202;8174.141715119887;8176.509409435424;8208.384371172157;8213.26080652741;8213.7125200618;8218.178182181793;8119.959400202991;8140.511569305831;8158.959205203995;8166.346692264605;8167.754967350989;7940.682372705085;8023.919760802434;8025.6789728410795;8028.799280017988;8030.317423019051;39743.205135897406;40039.19921601551;40079.79960100181;40102.39846402306;40116.79941600303;3508.5088087667746;3513.4378499439968;3835.3671644178676;3968.1666849961543;4017.1764788218347;29993;30460.8476957616;30599.235019124477;30618.54072188919;30811.38377232465;3493.423585108454;3535.8939231823088;3552.5914519830294;3562.7327950403565;3743.494628225182;182530;255254;256263.99999999814;256285;256636;33477.49783753246;34849.82575087108;54000.189997150075;54488.45511544834;54704;35778.46332305018;35906;35998.28003439916;36005;36019.4597081044;14433.639159021108;14565.053271537316;14571.271436428136;14576.19830909289;14578.927105364406;12166.635000949986;12253.326067066397;12264.570740024057;12266.202696824677;12271.631851044305;8264.876026859602;8329.125441828643;8379.958100209582;8425.4944703318;8435.957820210982;3283.326917981808;3292.506124081407;3304.9008529744146;3323.6177839548277;3340.348632016782;829.1238460198548;916.1937495004487;952.4285428742699;970.3741086998846;980.9705708828747;28447.207452124778;28565.285867853054;28635.42729145447;29444.852775735984;29646.258843528653;994.7761753605381;1014.8477728340808;1031.6286136990677;1063.6543123484898;1070.1545778834634;15010.849891501164;15517.844821551866;15523.689526209413;15534.45629402988;15723.921380393254;365089;469655;472313;472675;673170;53732.19401708977;54180;54333.72833135809;54435;54541.1818822718;1125.4991528769783;1200.9459574319176;1279.3347459321287;1307.6861553227156;1312.5996571045732;28498.287542810765;29579.40841183207;29890;30254;30469.23826904345;43588.78205608952;44119.77940110279;44292;44297;44345.113097737216;280114;281420;282094;282593;283332;23145.305640830127;25394.365140871625;26612.467750644493;26751.464970700865;27766.44467110687;41922;44371.98356666952;45425.111282420585;46124.30813537732;50308;38094.61905380911;38205.80897095497;38862.80568597139;39149.6085039146;39511.60488395079;38133.49660757904;38450;38657.2268554633;38819.2236155281;38859.41710874395;37608.43587346137;37695.2460950774;37917;38723.41914871223;38734.80632596819;32646;33707;33892.49161262633;34139.82930085433;34173.316533669684;25837.612435813855;26273.737262627128;26417.867910660323;26460.090447421942;26571.867140664173 07:57:17 INFO - PROCESS | 11317 | |2;jquery.html;377.9045194397068;381.57645014034415;382.80476956752057;394.2765026176965;394.30995757424506;16285.430009949654;17401.215805471125;17853.910730446347;17948.910255448704;17951;16955.237014334354;17473.301067957298;17644.206010729515;17672.20475078621;17678.734818977693;5081.1108056090125;5196.948030519703;5201.141811601081;5225.555827754645;5284.471552844723;3651.1419816343137;4904.043711476245;5921.88156236875;5930.466258036776;6013.579049466539;5861.970690146564;5959.404059594028;5970.73131709072;5975.073863551156;5975.492083172936;5725.971370143144;6000.729967151445;6024.277086749575;6027.849303767419;6030.487408570277;5196.68819870809;5255.395629502618;5292.735363231823;5293.920591191135;5302.965921645281;18028.639427211514;18056.90971545134;18062.277508899628;18638.25446982119;21287.36137915865;2073.7407824022;2566.089038391363;2574.858382788946;2579.4036562323963;2634.2360715392515;13029.153105048237;13152.079354445194;13184.14303070307;13409.499101975693;13955.511557095555;1797.63148554546;1799.136414521024;1861.1996841358211;1896.1467339697053;1910.5892233169795;67490.66254668696;69300.3069969299;69989.65005174992;70309;70310.2968970314;9636.71089867305;9793.755156121155;9804.950975245078;9825.825706917904;9828;12694.936525317315;12858.099933004787;12895.097343185887;12900.354982251038;12945.741085178432;7281.854362912712;7348.1182258129365;7402.444816638774;7573.35626471745;7623.466357355042;7398.852022959618;7400.5189662671755;7426.331630153204;7552.697892084365;7555.320021198118;3989.9601003989587;4153.979230103891;4228.76741779199;4244.342126970325;4444.688871779009;1642.8357164283475;1684.6630673865277;1732.8007279162805;1733.0901276829513;1733.8153926053012;790.4703848421572;899.0200681257461;912.6121398405651;934.7476181430976;945.6122989574379;16517.58706032359;16743.581410464834;17021.829781702025;17289.394871179447;17571.385001524886;896.3232759266842;902.5397047505819;904.7873749668822;909.7634615000015;915.2586405011962;9599.952000239955;9702.951485242529;9913.107820296207;9925.50372481373;10027.949860250652;391335;393969;395936;397970;401732;51903;55092.44907550873;73324.63337683277;81725.59137204276;84276.57861710653;918.9678361257323;940.247801758604;959.4243453927587;966.3911735606523;971.0144203633317;16053.759193612339;16112;16260.186990650656;16555.420560280334;16574.58563535875;37698;37771.244575108896;39438;40009.599904000585;40215;51274;54462.45537544732;54929;55003.34989950308;55065.72467137639;6255.218097737783;6408.942524483408;7772.222777722182;7782.455228133977;7949.205079492004;11515.53937842477;12062.095342849147;12093;12201.938990304992;12295.50817967307;10490.160787136858;10566.154707623526;10599.576016959543;10707;10737.838932415863;10145.847812282675;10248.948755256177;10324.845127323246;10384;10412.843807342744;10662.786744264917;10781.137508999418;10880.945595271973;10893.509792059534;10956.397398143179;6622.1722284714415;7581.393488520795;7602.315791578784;7666.041744781903;7704.229577042251;8636.697715579925;10717.624883129052;10725.731856703645;10910.2362834604;11075.280106793032 07:57:17 INFO - PROCESS | 11317 | |3;mootools.html;1255.9434825432854;1473.6315921019745;1512.780646806213;1678.5719641491419;1862.329561357911;6814.318568143183;7446.702131914723;7587.734429294976;7665.348445382149;7673.386129109679;7520.924790752091;7801.024871891013;7802.180771019046;8001.079875814283;8007.879881801778;1853.9258429662798;2079.313826437272;2154.967675484869;2171.4896999205134;2223.4107961390164;2190.9342719718434;2193.462601662595;2197.121151539381;2198.857074290166;2203.327984964585;2140.079765700748;2143.0784762552175;2221.2669818959785;2223.5108276179217;2224.644056950888;1803.1705415508816;1866.878652887558;1868.1966754295647;2010.0552740212077;2125.1180759984586;2148.4521447030907;2184.6395344768093;2186.2566727312633;2187.0377034105104;2187.147012665062;7839.3728501719725;7888.9605551972445;7890.408219383569;7893.486923350021;7894.407919406068;4550.613197878184;4653.581177694024;4660.976695116537;4661.627069834439;4664.766761661937;2835.277004363895;2925.8683359248885;2996.370762139953;2998.940021199564;3008.368242669042;895.2435192262528;958.5925981457852;959.2661613865398;964.2093483343662;969.8399764038925;10859.945700271526;11105.333679979227;11113.888861111367;11119.72200694981;11132.888671113265;4211.7051806373875;4360.302351623788;4364.192624364439;4369.628581570539;4378.759168245713;9582.856257156149;9592.808143837085;9596.18432433251;9604.95197524008;9619;4679.953200467951;4713.622910167179;4731.787069581877;4735.076660051257;4742.051589682077;3703.5740889798017;4124.876253712333;4265.12564924196;4269.850555230614;4337.522872484024;3604;3672.5225720656144;3687.981560092236;3835.0028992461603;3895.3377925752125;1198.394810620631;1212.0848759186758;1221.6701490597488;1224.308265829821;1240.5968060380412;760.8440269744689;875.3566128895256;887.2414085956543;913.0185051070126;922.5433410461865;5358;5435.374931882884;5490.368607610096;5619.044762390404;5683.062294721407;866.6749968761715;891.2736120062128;938.5448057692014;944.485255535721;978.2320878110648;3897.8830635080994;3963.8612648557737;3966.504186976628;3981.7013723970817;3983.8605648802154;9722.562484688206;9951.800963980824;10044.045815647502;10049.949750251348;10070.04334588213;9820.263480238867;9892.356996795184;9908.058734420218;9909.058639429242;9936.80126397468;7459.358941032964;7588.241175882367;7636.50362726421;7644.655990480442;7648.80877978055;5519.668819870821;5541.833744987657;5588.832335029955;5626.88746225065;5755.942440575541;9080.137386948229;9191.402558833654;9262.9536852318;9265.72202833916;9296.209822165192;9017.864732028893;9441.386309889835;9444.669436569962;9445.905540944777;9462.337636365388;5918.3489816121055;6099.024156135175;6104.542159337979;6598.703058362289;6682.164729408824;7044.542104763174;7117.8932316016335;7309.671064802203;7337.0828646419195;7559;6918.757843475454;7174.282571742784;7183.497155199086;7268.38218751412;7298.306660867209;6953.79138625842;6968.442524598121;6973;7063.975723520163;7074.434045276468;6594.637294948632;6603.669816509251;6607.603543787388;6612.801615951529;6752.155980502437;4669.7431641260055;4876.658633895593;4960.47914968923;5041.067402530543;5100.821471248489;4741.217699079752;4922.286268490977;4924.335214745964;4946.060248552763;5025.673331233458 07:57:17 INFO - PROCESS | 11317 | |4;prototype.html;276.4429674206473;284.7024859022321;301.4980058203092;305.9892903748368;313.1700992370219;4804.855854324367;4813.2539456384275;4841.419029716439;4846.418429788426;4871.975640121799;4539.568740969611;4628.953710462903;4682.672212945095;4764.97617511912;4781.856544303668;3819.9631293121897;3834.6740527055235;3838.1172330364034;3846.788426636534;3850.2876967760985;3839.577646458887;3871.7096217783637;3877.185790983897;3880.844766209362;3904.2777086238993;3644.7266455015847;3676.411774116142;3743.5320584926885;3783.905402364949;3824.388097904336;3755.286495565834;3773.2642134783864;3790.65884070435;3801.79090150043;3803.619638036202;3382.0868365541414;3382.2220889195623;3387.305602351512;3390.7117894978956;3411.249525104473;4410.42664453619;4665.650076244261;4687.95312046882;4692.296155576657;4712.0811441768865;4295.775703924366;4321.978390108061;4325.286327755948;4325.891852703676;4343.587359200871;5011.899762004776;5034.446210916796;5060.9493905060845;5084.135696931494;5086.77109530072;3584.652052905351;3619.6380361963857;3649.4525821126776;3653.214558869856;3678.8528458861615;5069.518395752398;5269.973650131763;5280.973595132038;5294.576433885319;5345.33183352081;3608.729345299113;3615.8610037838;3638.6543278388513;3648.3980143276062;3656.689181419609;3697.445383192489;3698.2973235085246;3701.11173318407;3728.6830619397656;3730.421784623388;4131.8967025824595;4248.893777655521;4277.508086570022;4282.6359759420175;4300.548442413564;5070.7464626768515;5095.974520127375;5108.744562771846;5111.361079865017;5129.281900533928;1226.5645695778048;1265.0891358222066;1265.3609926986996;1288.903332250085;1303.1985329022773;790.5572879187673;805.1867613710195;863.9352048596255;873.9475631462133;880.7445840706251;4420.734755914656;4421.838385554344;4425.955740442619;4444.6666500012625;4447.909482543199;5041.521055499722;5175.14610089331;5189.42916279209;5204.7099276318295;5212.504812042926;4385.451818522684;4415.889602759957;4420.889477763018;4433.82264709408;4444.888877778081;2692.2461710720636;2741.232454912628;2744.945101097967;2749.8588085944507;2750.7386798254133;4718.197906355927;4850.466448690641;4884.902301953941;4894.926576101361;4915.631327650441;5166.664166829144;5236.162214045735;5261.76322065508;5275.894482110336;5277.152996451211;4855.902881942412;4863.513648635179;4882.170031094723;4901.583365413909;4915.4347250065985;4914.70511769295;5113.15632920564;5141.562967147835;5148.918727067357;5156.917047420084;5145.87135321605;5162.664426812245;5164.225366194951;5173.965206958548;5191.896162076813;4962.139197800825;4968.478309777566;4981.2030075187795;4984.355162796341;5022.422421421437;3657.3301489913047;3711.2577484502667;3729.757565758217;3748.2503499299705;3751.1934933989323;5236.528712415901;5237.816676416307;5243.449437808975;5249.317588713443;5250.317458730493;5028.270900719448;5052.014857102829;5060;5062.746862656779;5085.898282034413;4861.295112208781;4950;4996.275540046746;5039.521245481674;5071.239314102914;4735.455422626442;4813.03739252144;4950.381202349707;4968.329275547755;4994.200927851526;5054.78685115577;5065.544101030925;5069.7718602662235;5086.771095300646;5092.465291144376;4947.183714687037;4949.624180393359;4952.975235123946;4960.652754307164;4961.6030717543235 07:57:17 INFO - PROCESS | 11317 | |5;yui.html;674.7435974329754;707.9893801592974;730.1894896664701;822.6750433578736;829.954352510612;12005.63983080508;12159.756804863908;12344.444499997498;12363.876361236385;12380.81428778569;11934.403279835995;11972.940135299334;11977.760444791098;11982.101342399312;11989.40052997351;679.3851564334273;699.6117154978984;842.065307508668;875.6541166239332;881.0616693221731;871.0766587417327;877.9122087791234;880.2473884828476;880.9471431714118;881.383031877685;926.4117285523673;927.823713494434;927.9768005799875;928.331601247101;928.7120992492315;713.8465229975554;891.7681402835309;917.7200953709116;918.8346097702411;925.7361651929201;681.0125318288452;681.7477533312706;681.8159097043771;681.9693113809891;683.1528904158807;11528.884711152949;11553.94223028888;11556.768864622745;11566.53733850645;11566.710832229262;11410.372429516374;11533.423328833525;12043.879561204363;12249.265044097294;12422.75028906346;10742;10790.946045269724;11057.612983545538;11120.833187502194;11167.106631469464;4134.813933372975;4136.420901073852;4196.223698615766;4209.936850947238;4265.104328091104;43081.853040532;43644.345334820006;45802.77098614519;46207.30689039667;46384;9372.39079459833;9443.527823608929;9649.228061755182;9669.323147379757;9692.563834627459;17820.9108954457;17864.01747903878;17873.910630446764;17944.91027544854;18002.189901454465;6389.648569328639;6508.674566271668;6585.176852893388;6642;6781.42357899584;3601.4777857210556;3634.890953271406;3669;3712.1833196697226;3744.625537446288;2666.413389054405;2760.654918135233;2762.599423083642;2773.0571605654172;2773.237359726051;484.394506866417;489.7159647404497;494.8094983431405;508.0169871299048;510.4334189050151;438.32935608519017;552.1827695011406;560.1317957166376;562.9380768115504;567.3617180671745;6978.127734033246;7085.787426377114;7115.644217789089;7297.744578939712;7382.409407247407;488.53833127694696;493.94566597674225;513.5711680746543;515.4536191636877;522.3183745212458;3368.915777105543;3518.9472157917653;3558.893233203008;3563.518924945151;3622.4566315052953;47779.28331075037;53270;54116.72941635267;54136.72931635395;55167.72416137974;48484.515154848;49235.26147107796;49778.25332620014;49803.75098124486;50800.491995080316;44486;44586.77706611511;44799.32801007987;45440.3183952241;45868;6929.653517324013;7051.224365319913;7079.115110611174;7273.563586184846;7297.16082650502;30822.229444264074;31124.533132002583;31347.84326078355;31402.68597314089;31560.526592101596;36635.63364366429;40145.59854401419;40160.799196003834;40696.79651601723;41215.381769272884;9493.145616894513;9518.714438566854;9543.76140596463;9669.419834809934;9771.9022809771;9641;9726.805463890823;9734.902650973683;10028.749281268027;10142.137918276734;9410.43537387759;9534.809303814023;9618.278629102986;9619;10024.799504010025;9434.339596228197;9479.28905332089;9509.096635819862;9847.901520984698;9887.060729230712;8911.817087366988;9580.137787598871;9580.784812137348;9778.119969202806;10047.497625118862;7810.1451574520015;7910.920890791019;7922.524648521107;7951.443398962017;8221.342292616457;8191.754247372588;8460.915390846012;8497.52525933592;8517.48895066298;8614.870776938476 07:57:17 INFO - PROCESS | 11317 | __end_tp_report 07:57:17 INFO - PROCESS | 11317 | __start_cc_report 07:57:17 INFO - PROCESS | 11317 | _x_x_mozilla_cycle_collect,1196 07:57:17 INFO - PROCESS | 11317 | __end_cc_report 07:57:17 INFO - PROCESS | 11317 | __startTimestamp1463151437846__endTimestamp 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | ------- Summary: start ------- 07:57:17 INFO - PROCESS | 11317 | Number of tests: 6 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#0] dojo.html Cycles:165 Average:4815.81 Median:4926.48 stddev:516.21 (10.5%) stddev-sans-first:489.23 07:57:17 INFO - PROCESS | 11317 | Values: 2657.4 2676.2 2709.2 2713.2 2725.3 4728.6 4755.2 4789.0 4792.5 4873.5 4797.9 4830.3 4830.7 4872.7 4879.9 4406.0 4426.8 4474.1 4536.5 4616.7 4546.0 4577.5 4594.0 4597.7 4615.1 4293.6 4344.2 4416.2 4461.0 4480.7 4426.2 4432.5 4434.3 4478.3 4485.3 4463.1 4469.0 4472.9 4474.4 4506.8 4652.5 4672.0 4707.2 4735.4 4816.3 5206.8 5248.4 5254.6 5266.3 5277.2 5243.8 5244.6 5251.2 5255.4 5284.7 4709.4 4787.9 4848.7 4848.8 4926.4 5321.6 5377.9 5390.6 5397.6 5403.0 5119.3 5125.5 5152.7 5174.7 5178.2 5071.7 5169.3 5240.1 5245.9 5338.8 5219.5 5222.8 5229.1 5238.2 5243.9 5223.0 5225.9 5233.1 5233.5 5273.8 4341.6 4368.4 4368.9 4432.5 4477.9 3843.9 3870.9 3885.5 3890.5 3891.0 4439.9 4449.1 4450.4 4451.7 4456.0 5201.0 5204.3 5256.2 5261.9 5337.7 4446.9 4492.5 4493.7 4496.0 4539.3 4748.8 4752.3 4757.9 4764.0 4811.6 4803.0 4849.6 4895.9 4911.7 4919.0 5225.4 5238.2 5238.7 5252.4 5297.8 4772.1 4917.4 4926.8 4930.0 4933.4 5076.5 5116.2 5132.8 5135.5 5161.1 5232.8 5237.5 5239.9 5243.7 5292.5 4946.6 5019.1 5093.8 5109.0 5118.4 5093.4 5094.0 5098.3 5108.5 5165.0 4926.5 4988.5 5004.4 5039.6 5047.4 4984.4 5048.3 5132.3 5160.8 5161.2 5006.1 5011.5 5031.7 5034.3 5075.9 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#1] ext.html Cycles:180 Average:49002.28 Median:21142.68 stddev:95932.24 (453.7%) stddev-sans-first:96132.39 07:57:17 INFO - PROCESS | 11317 | Values: 554.5 594.1 604.4 604.7 612.4 42891.6 44384.8 44424.8 44470.1 48339.8 42190.0 42581.4 42620.0 42669.8 42678.4 8148.8 8290.5 8291.8 8293.9 8295.9 8080.7 8149.8 8166.7 8170.3 8174.1 8176.5 8208.4 8213.3 8213.7 8218.2 8120.0 8140.5 8159.0 8166.3 8167.8 7940.7 8023.9 8025.7 8028.8 8030.3 39743.2 40039.2 40079.8 40102.4 40116.8 3508.5 3513.4 3835.4 3968.2 4017.2 29993.0 30460.8 30599.2 30618.5 30811.4 3493.4 3535.9 3552.6 3562.7 3743.5 182530.0 255254.0 256264.0 256285.0 256636.0 33477.5 34849.8 54000.2 54488.5 54704.0 35778.5 35906.0 35998.3 36005.0 36019.5 14433.6 14565.1 14571.3 14576.2 14578.9 12166.6 12253.3 12264.6 12266.2 12271.6 8264.9 8329.1 8380.0 8425.5 8436.0 3283.3 3292.5 3304.9 3323.6 3340.3 829.1 916.2 952.4 970.4 981.0 28447.2 28565.3 28635.4 29444.9 29646.3 994.8 1014.8 1031.6 1063.7 1070.2 15010.8 15517.8 15523.7 15534.5 15723.9 365089.0 469655.0 472313.0 472675.0 673170.0 53732.2 54180.0 54333.7 54435.0 54541.2 1125.5 1200.9 1279.3 1307.7 1312.6 28498.3 29579.4 29890.0 30254.0 30469.2 43588.8 44119.8 44292.0 44297.0 44345.1 280114.0 281420.0 282094.0 282593.0 283332.0 23145.3 25394.4 26612.5 26751.5 27766.4 41922.0 44372.0 45425.1 46124.3 50308.0 38094.6 38205.8 38862.8 39149.6 39511.6 38133.5 38450.0 38657.2 38819.2 38859.4 37608.4 37695.2 37917.0 38723.4 38734.8 32646.0 33707.0 33892.5 34139.8 34173.3 25837.6 26273.7 26417.9 26460.1 26571.9 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#2] jquery.html Cycles:180 Average:24608.16 Median:220973.50 stddev:65266.76 (29.5%) stddev-sans-first:65424.50 07:57:17 INFO - PROCESS | 11317 | Values: 377.9 381.6 382.8 394.3 394.3 16285.4 17401.2 17853.9 17948.9 17951.0 16955.2 17473.3 17644.2 17672.2 17678.7 5081.1 5196.9 5201.1 5225.6 5284.5 3651.1 4904.0 5921.9 5930.5 6013.6 5862.0 5959.4 5970.7 5975.1 5975.5 5726.0 6000.7 6024.3 6027.8 6030.5 5196.7 5255.4 5292.7 5293.9 5303.0 18028.6 18056.9 18062.3 18638.3 21287.4 2073.7 2566.1 2574.9 2579.4 2634.2 13029.2 13152.1 13184.1 13409.5 13955.5 1797.6 1799.1 1861.2 1896.1 1910.6 67490.7 69300.3 69989.7 70309.0 70310.3 9636.7 9793.8 9805.0 9825.8 9828.0 12694.9 12858.1 12895.1 12900.4 12945.7 7281.9 7348.1 7402.4 7573.4 7623.5 7398.9 7400.5 7426.3 7552.7 7555.3 3990.0 4154.0 4228.8 4244.3 4444.7 1642.8 1684.7 1732.8 1733.1 1733.8 790.5 899.0 912.6 934.7 945.6 16517.6 16743.6 17021.8 17289.4 17571.4 896.3 902.5 904.8 909.8 915.3 9600.0 9703.0 9913.1 9925.5 10027.9 391335.0 393969.0 395936.0 397970.0 401732.0 51903.0 55092.4 73324.6 81725.6 84276.6 919.0 940.2 959.4 966.4 971.0 16053.8 16112.0 16260.2 16555.4 16574.6 37698.0 37771.2 39438.0 40009.6 40215.0 51274.0 54462.5 54929.0 55003.3 55065.7 6255.2 6408.9 7772.2 7782.5 7949.2 11515.5 12062.1 12093.0 12201.9 12295.5 10490.2 10566.2 10599.6 10707.0 10737.8 10145.8 10248.9 10324.8 10384.0 10412.8 10662.8 10781.1 10880.9 10893.5 10956.4 6622.2 7581.4 7602.3 7666.0 7704.2 8636.7 10717.6 10725.7 10910.2 11075.3 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#3] mootools.html Cycles:180 Average:5271.76 Median:5505.02 stddev:2966.96 (53.9%) stddev-sans-first:2959.94 07:57:17 INFO - PROCESS | 11317 | Values: 1255.9 1473.6 1512.8 1678.6 1862.3 6814.3 7446.7 7587.7 7665.3 7673.4 7520.9 7801.0 7802.2 8001.1 8007.9 1853.9 2079.3 2155.0 2171.5 2223.4 2190.9 2193.5 2197.1 2198.9 2203.3 2140.1 2143.1 2221.3 2223.5 2224.6 1803.2 1866.9 1868.2 2010.1 2125.1 2148.5 2184.6 2186.3 2187.0 2187.1 7839.4 7889.0 7890.4 7893.5 7894.4 4550.6 4653.6 4661.0 4661.6 4664.8 2835.3 2925.9 2996.4 2998.9 3008.4 895.2 958.6 959.3 964.2 969.8 10859.9 11105.3 11113.9 11119.7 11132.9 4211.7 4360.3 4364.2 4369.6 4378.8 9582.9 9592.8 9596.2 9605.0 9619.0 4680.0 4713.6 4731.8 4735.1 4742.1 3703.6 4124.9 4265.1 4269.9 4337.5 3604.0 3672.5 3688.0 3835.0 3895.3 1198.4 1212.1 1221.7 1224.3 1240.6 760.8 875.4 887.2 913.0 922.5 5358.0 5435.4 5490.4 5619.0 5683.1 866.7 891.3 938.5 944.5 978.2 3897.9 3963.9 3966.5 3981.7 3983.9 9722.6 9951.8 10044.0 10049.9 10070.0 9820.3 9892.4 9908.1 9909.1 9936.8 7459.4 7588.2 7636.5 7644.7 7648.8 5519.7 5541.8 5588.8 5626.9 5755.9 9080.1 9191.4 9263.0 9265.7 9296.2 9017.9 9441.4 9444.7 9445.9 9462.3 5918.3 6099.0 6104.5 6598.7 6682.2 7044.5 7117.9 7309.7 7337.1 7559.0 6918.8 7174.3 7183.5 7268.4 7298.3 6953.8 6968.4 6973.0 7064.0 7074.4 6594.6 6603.7 6607.6 6612.8 6752.2 4669.7 4876.7 4960.5 5041.1 5100.8 4741.2 4922.3 4924.3 4946.1 5025.7 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#4] prototype.html Cycles:180 Average:4195.81 Median:4773.42 stddev:1214.68 (25.4%) stddev-sans-first:1181.93 07:57:17 INFO - PROCESS | 11317 | Values: 276.4 284.7 301.5 306.0 313.2 4804.9 4813.3 4841.4 4846.4 4872.0 4539.6 4629.0 4682.7 4765.0 4781.9 3820.0 3834.7 3838.1 3846.8 3850.3 3839.6 3871.7 3877.2 3880.8 3904.3 3644.7 3676.4 3743.5 3783.9 3824.4 3755.3 3773.3 3790.7 3801.8 3803.6 3382.1 3382.2 3387.3 3390.7 3411.2 4410.4 4665.7 4688.0 4692.3 4712.1 4295.8 4322.0 4325.3 4325.9 4343.6 5011.9 5034.4 5060.9 5084.1 5086.8 3584.7 3619.6 3649.5 3653.2 3678.9 5069.5 5270.0 5281.0 5294.6 5345.3 3608.7 3615.9 3638.7 3648.4 3656.7 3697.4 3698.3 3701.1 3728.7 3730.4 4131.9 4248.9 4277.5 4282.6 4300.5 5070.7 5096.0 5108.7 5111.4 5129.3 1226.6 1265.1 1265.4 1288.9 1303.2 790.6 805.2 863.9 873.9 880.7 4420.7 4421.8 4426.0 4444.7 4447.9 5041.5 5175.1 5189.4 5204.7 5212.5 4385.5 4415.9 4420.9 4433.8 4444.9 2692.2 2741.2 2744.9 2749.9 2750.7 4718.2 4850.5 4884.9 4894.9 4915.6 5166.7 5236.2 5261.8 5275.9 5277.2 4855.9 4863.5 4882.2 4901.6 4915.4 4914.7 5113.2 5141.6 5148.9 5156.9 5145.9 5162.7 5164.2 5174.0 5191.9 4962.1 4968.5 4981.2 4984.4 5022.4 3657.3 3711.3 3729.8 3748.3 3751.2 5236.5 5237.8 5243.4 5249.3 5250.3 5028.3 5052.0 5060.0 5062.7 5085.9 4861.3 4950.0 4996.3 5039.5 5071.2 4735.5 4813.0 4950.4 4968.3 4994.2 5054.8 5065.5 5069.8 5086.8 5092.5 4947.2 4949.6 4953.0 4960.7 4961.6 07:57:17 INFO - PROCESS | 11317 | 07:57:17 INFO - PROCESS | 11317 | [#5] yui.html Cycles:180 Average:12664.99 Median:26896.16 stddev:14964.63 (55.6%) stddev-sans-first:14979.52 07:57:17 INFO - PROCESS | 11317 | Values: 674.7 708.0 730.2 822.7 830.0 12005.6 12159.8 12344.4 12363.9 12380.8 11934.4 11972.9 11977.8 11982.1 11989.4 679.4 699.6 842.1 875.7 881.1 871.1 877.9 880.2 880.9 881.4 926.4 927.8 928.0 928.3 928.7 713.8 891.8 917.7 918.8 925.7 681.0 681.7 681.8 682.0 683.2 11528.9 11553.9 11556.8 11566.5 11566.7 11410.4 11533.4 12043.9 12249.3 12422.8 10742.0 10790.9 11057.6 11120.8 11167.1 4134.8 4136.4 4196.2 4209.9 4265.1 43081.9 43644.3 45802.8 46207.3 46384.0 9372.4 9443.5 9649.2 9669.3 9692.6 17820.9 17864.0 17873.9 17944.9 18002.2 6389.6 6508.7 6585.2 6642.0 6781.4 3601.5 3634.9 3669.0 3712.2 3744.6 2666.4 2760.7 2762.6 2773.1 2773.2 484.4 489.7 494.8 508.0 510.4 438.3 552.2 560.1 562.9 567.4 6978.1 7085.8 7115.6 7297.7 7382.4 488.5 493.9 513.6 515.5 522.3 3368.9 3518.9 3558.9 3563.5 3622.5 47779.3 53270.0 54116.7 54136.7 55167.7 48484.5 49235.3 49778.3 49803.8 50800.5 44486.0 44586.8 44799.3 45440.3 45868.0 6929.7 7051.2 7079.1 7273.6 7297.2 30822.2 31124.5 31347.8 31402.7 31560.5 36635.6 40145.6 40160.8 40696.8 41215.4 9493.1 9518.7 9543.8 9669.4 9771.9 9641.0 9726.8 9734.9 10028.7 10142.1 9410.4 9534.8 9618.3 9619.0 10024.8 9434.3 9479.3 9509.1 9847.9 9887.1 8911.8 9580.1 9580.8 9778.1 10047.5 7810.1 7910.9 7922.5 7951.4 8221.3 8191.8 8460.9 8497.5 8517.5 8614.9 07:57:17 INFO - PROCESS | 11317 | -------- Summary: end -------- 07:57:17 INFO - PROCESS | 11317 | 07:57:18 INFO - TEST-INFO | 11317: exit 0 07:57:18 INFO - TEST-OK | dromaeo_css | took 1118659ms 07:57:18 INFO - TEST-START | kraken 07:57:18 INFO - operating with platform_type : linux_ 07:57:18 INFO - Initialising browser for kraken test... 07:57:18 INFO - TEST-INFO | started process 11492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOMEWj/profile http://localhost:45392/getInfo.html) 07:57:22 INFO - PROCESS | 11492 | __metrics Screen width/height:1600/1200 07:57:22 INFO - PROCESS | 11492 | colorDepth:24 07:57:22 INFO - PROCESS | 11492 | Browser inner width/height: 1024/697 07:57:22 INFO - PROCESS | 11492 | __metrics 07:57:23 ERROR - PROCESS | 11492 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:57:24 INFO - TEST-INFO | 11492: exit 0 07:57:24 INFO - Browser initialized. 07:57:24 INFO - Running cycle 1/1 for kraken test... 07:57:24 INFO - TEST-INFO | started process 11573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOMEWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:36 INFO - PROCESS | 11573 | RSS: Main: 154398720 07:57:36 INFO - PROCESS | 11573 | 07:57:39 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45392/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:40 INFO - PROCESS | 11573 | RSS: Main: 210227200 07:57:40 INFO - PROCESS | 11573 | 07:57:43 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45392/tests/kraken/driver.html?testName=audio-dft) 07:57:43 INFO - PROCESS | 11573 | RSS: Main: 197853184 07:57:43 INFO - PROCESS | 11573 | 07:57:46 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45392/tests/kraken/driver.html?testName=audio-fft) 07:57:47 INFO - PROCESS | 11573 | RSS: Main: 267051008 07:57:47 INFO - PROCESS | 11573 | 07:57:49 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45392/tests/kraken/driver.html?testName=audio-oscillator) 07:57:50 INFO - PROCESS | 11573 | RSS: Main: 176070656 07:57:50 INFO - PROCESS | 11573 | 07:57:52 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:53 INFO - PROCESS | 11573 | RSS: Main: 180318208 07:57:53 INFO - PROCESS | 11573 | 07:57:56 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45392/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:57 INFO - PROCESS | 11573 | RSS: Main: 216432640 07:57:57 INFO - PROCESS | 11573 | 07:58:00 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45392/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:01 INFO - PROCESS | 11573 | RSS: Main: 214564864 07:58:01 INFO - PROCESS | 11573 | 07:58:04 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45392/tests/kraken/driver.html?testName=json-parse-financial) 07:58:05 INFO - PROCESS | 11573 | RSS: Main: 215146496 07:58:05 INFO - PROCESS | 11573 | 07:58:06 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:07 INFO - PROCESS | 11573 | RSS: Main: 209698816 07:58:07 INFO - PROCESS | 11573 | 07:58:09 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:10 INFO - PROCESS | 11573 | RSS: Main: 212774912 07:58:10 INFO - PROCESS | 11573 | 07:58:12 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:13 INFO - PROCESS | 11573 | RSS: Main: 216989696 07:58:13 INFO - PROCESS | 11573 | 07:58:16 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:16 INFO - PROCESS | 11573 | RSS: Main: 220450816 07:58:16 INFO - PROCESS | 11573 | 07:58:19 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:20 INFO - PROCESS | 11573 | RSS: Main: 219586560 07:58:20 INFO - PROCESS | 11573 | 07:58:21 INFO - PROCESS | 11573 | Cycle 1(1): loaded http://localhost:45392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45392/tests/kraken/driver.html?testName=ai-astar) 07:58:22 INFO - PROCESS | 11573 | RSS: Main: 266203136 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | __start_tp_report 07:58:22 INFO - PROCESS | 11573 | _x_x_mozilla_page_load 07:58:22 INFO - PROCESS | 11573 | _x_x_mozilla_page_load_details 07:58:22 INFO - PROCESS | 11573 | |i|pagename|runs| 07:58:22 INFO - PROCESS | 11573 | |0;ai-astar;112;109;113;113;113;111;112;112;115;112 07:58:22 INFO - PROCESS | 11573 | |1;audio-beat-detection;164;130;159;209;135;165;166;134;196;129 07:58:22 INFO - PROCESS | 11573 | |2;audio-dft;160;160;162;162;161;161;161;162;163;160 07:58:22 INFO - PROCESS | 11573 | |3;audio-fft;76;75;77;159;75;75;76;75;127;76 07:58:22 INFO - PROCESS | 11573 | |4;audio-oscillator;92;93;151;92;93;93;138;91;92;120 07:58:22 INFO - PROCESS | 11573 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 07:58:22 INFO - PROCESS | 11573 | |6;imaging-darkroom;145;146;146;146;146;146;145;147;146;146 07:58:22 INFO - PROCESS | 11573 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;95;96 07:58:22 INFO - PROCESS | 11573 | |8;json-parse-financial;64;65;65;64;64;64;65;64;65;65 07:58:22 INFO - PROCESS | 11573 | |9;json-stringify-tinderbox;65;64;63;63;64;63;63;63;63;64 07:58:22 INFO - PROCESS | 11573 | |10;stanford-crypto-aes;89;82;81;80;82;83;81;89;163;87 07:58:22 INFO - PROCESS | 11573 | |11;stanford-crypto-ccm;132;129;128;137;125;126;125;127;154;130 07:58:22 INFO - PROCESS | 11573 | |12;stanford-crypto-pbkdf2;171;172;165;170;169;167;171;169;164;172 07:58:22 INFO - PROCESS | 11573 | |13;stanford-crypto-sha256-iterative;66;70;68;67;67;75;66;65;65;67 07:58:22 INFO - PROCESS | 11573 | __end_tp_report 07:58:22 INFO - PROCESS | 11573 | __start_cc_report 07:58:22 INFO - PROCESS | 11573 | _x_x_mozilla_cycle_collect,2076 07:58:22 INFO - PROCESS | 11573 | __end_cc_report 07:58:22 INFO - PROCESS | 11573 | __startTimestamp1463151502236__endTimestamp 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | ------- Summary: start ------- 07:58:22 INFO - PROCESS | 11573 | Number of tests: 14 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:1.55 (1.4%) stddev-sans-first:1.64 07:58:22 INFO - PROCESS | 11573 | Values: 112.0 109.0 113.0 113.0 113.0 111.0 112.0 112.0 115.0 112.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#1] audio-beat-detection Cycles:10 Average:158.70 Median:164.50 stddev:27.73 (16.9%) stddev-sans-first:29.34 07:58:22 INFO - PROCESS | 11573 | Values: 164.0 130.0 159.0 209.0 135.0 165.0 166.0 134.0 196.0 129.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 07:58:22 INFO - PROCESS | 11573 | Values: 160.0 160.0 162.0 162.0 161.0 161.0 161.0 162.0 163.0 160.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:29.40 (38.9%) stddev-sans-first:30.80 07:58:22 INFO - PROCESS | 11573 | Values: 76.0 75.0 77.0 159.0 75.0 75.0 76.0 75.0 127.0 76.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.00 stddev:22.52 (24.5%) stddev-sans-first:23.35 07:58:22 INFO - PROCESS | 11573 | Values: 92.0 93.0 151.0 92.0 93.0 93.0 138.0 91.0 92.0 120.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:58:22 INFO - PROCESS | 11573 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 07:58:22 INFO - PROCESS | 11573 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:58:22 INFO - PROCESS | 11573 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 96.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:58:22 INFO - PROCESS | 11573 | Values: 64.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 07:58:22 INFO - PROCESS | 11573 | Values: 65.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:82.50 stddev:25.28 (30.6%) stddev-sans-first:26.79 07:58:22 INFO - PROCESS | 11573 | Values: 89.0 82.0 81.0 80.0 82.0 83.0 81.0 89.0 163.0 87.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.50 stddev:8.77 (6.8%) stddev-sans-first:9.30 07:58:22 INFO - PROCESS | 11573 | Values: 132.0 129.0 128.0 137.0 125.0 126.0 125.0 127.0 154.0 130.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.50 stddev:2.83 (1.7%) stddev-sans-first:2.91 07:58:22 INFO - PROCESS | 11573 | Values: 171.0 172.0 165.0 170.0 169.0 167.0 171.0 169.0 164.0 172.0 07:58:22 INFO - PROCESS | 11573 | 07:58:22 INFO - PROCESS | 11573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.99 (4.5%) stddev-sans-first:3.11 07:58:22 INFO - PROCESS | 11573 | Values: 66.0 70.0 68.0 67.0 67.0 75.0 66.0 65.0 65.0 67.0 07:58:22 INFO - PROCESS | 11573 | -------- Summary: end -------- 07:58:22 INFO - PROCESS | 11573 | 07:58:23 INFO - TEST-INFO | 11573: exit 0 07:58:23 INFO - TEST-OK | kraken | took 64830ms 07:58:23 INFO - SUITE-END | took 1183s 07:58:23 INFO - Completed test suite (00:19:43) 07:58:23 INFO - javascript benchmark 07:58:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.4020845309806, 2676.1703871799755, 2709.200785768197, 2713.2267303818408, 2725.250556097073, 4728.621710263179, 4755.191617425037, 4789.042191561684, 4792.4967878372745, 4873.537013983675, 4797.928031079537, 4830.347903033089, 4830.710157390559, 4872.707637541741, 4879.853604391874, 4405.977970110153, 4426.800793964279, 4474.149911516818, 4536.455625324966, 4616.676832621718, 4546.045330480603, 4577.473590537081, 4593.977030114861, 4597.678162528624, 4615.05391394765, 4293.592108749664, 4344.196323680129, 4416.205083085043, 4460.955390446086, 4480.731156130642, 4426.225410553173, 4432.490263619693, 4434.290513517822, 4478.261086920655, 4485.282354823213, 4463.129689710508, 4469.039156581351, 4472.932906006413, 4474.418325617681, 4506.842260520866, 4652.534746525354, 4671.976640116778, 4707.176244157259, 4735.431748190204, 4816.301636262758, 5206.76569554371, 5248.422673505949, 5254.632175747699, 5266.34170728659, 5277.208418737182, 5243.79024839006, 5244.554212891909, 5251.186066159751, 5255.448177941337, 5284.682919024833, 4709.434867815884, 4787.928181077286, 4848.660593758474, 4848.757562121879, 4926.384201974789, 5321.627486075938, 5377.892442151135, 5390.595705322116, 5397.568194544427, 5402.972985135049, 5119.257707632372, 5125.461826508163, 5152.742362881841, 5174.663646862942, 5178.171492561172, 5071.746412679351, 5169.276301317818, 5240.135377662719, 5245.868853278622, 5338.813141540105, 5219.530242278213, 5222.764975576109, 5229.111051121318, 5238.1618940969265, 5243.9213411798855, 5223.007628550563, 5225.895482090413, 5233.084210263265, 5233.502817232356, 5273.815416460406, 4341.60925516705, 4368.366586844953, 4368.868933931987, 4432.534583868647, 4477.865664030084, 3843.942340864889, 3870.903227419337, 3885.4560361549406, 3890.533136023695, 3891.0272431892026, 4439.933400998988, 4449.087936972913, 4450.376947227391, 4451.6883818133065, 4456.019675671347, 5201.0, 5204.34945631796, 5256.185291279781, 5261.921071183935, 5337.706426146521, 4446.933296000562, 4492.483364413069, 4493.707908985905, 4496.0, 4539.251023581138, 4748.7863046163, 4752.287156926489, 4757.9286310705365, 4764.023375208074, 4811.639127065484, 4802.975985120052, 4849.612031037508, 4895.853124406345, 4911.68074075184, 4919.016196760591, 5225.372955245395, 5238.2404551340605, 5238.68567885928, 5252.369715634149, 5297.788088476418, 4772.117158325721, 4917.434495033117, 4926.802927882988, 4930.0, 4933.407991041098, 5076.466970968143, 5116.2069879168785, 5132.79468821243, 5135.460776618401, 5161.122609156528, 5232.764525596282, 5237.450067742832, 5239.869003274948, 5243.737813109253, 5292.497212764782, 4946.62900282473, 5019.0965626187635, 5093.7707803148205, 5108.974455127701, 5118.41138269089, 5093.439721630692, 5094.0, 5098.337216161875, 5108.48915108501, 5165.0, 4926.482719314564, 4988.5260900214425, 5004.449510553909, 5039.571636410799, 5047.444781074152, 4984.37695288089, 5048.343715316985, 5132.281480592795, 5160.845174644766, 5161.225816127611, 5006.098902197639, 5011.5489605935645, 5031.698098114125, 5034.2951986721155, 5075.92386114216], "value": 4782.1487240859215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5369616370331, 594.0524862843764, 604.4318340759683, 604.6885853785299, 612.3876123876124, 42891.57108428915, 44384.77807610957, 44424.77787611065, 44470.11059778802, 48339.75830120844, 42190.0, 42581.36127958083, 42620.0, 42669.7866510667, 42678.35982460258, 8148.796280093001, 8290.502569845828, 8291.751247462586, 8293.875591866097, 8295.917040829574, 8080.676772929076, 8149.755507334759, 8166.67333306667, 8170.346372290202, 8174.141715119887, 8176.509409435424, 8208.384371172157, 8213.26080652741, 8213.7125200618, 8218.178182181793, 8119.959400202991, 8140.511569305831, 8158.959205203995, 8166.346692264605, 8167.754967350989, 7940.682372705085, 8023.919760802434, 8025.6789728410795, 8028.799280017988, 8030.317423019051, 39743.205135897406, 40039.19921601551, 40079.79960100181, 40102.39846402306, 40116.79941600303, 3508.5088087667746, 3513.4378499439968, 3835.3671644178676, 3968.1666849961543, 4017.1764788218347, 29993.0, 30460.8476957616, 30599.235019124477, 30618.54072188919, 30811.38377232465, 3493.423585108454, 3535.8939231823088, 3552.5914519830294, 3562.7327950403565, 3743.494628225182, 182530.0, 255254.0, 256263.99999999814, 256285.0, 256636.0, 33477.49783753246, 34849.82575087108, 54000.189997150075, 54488.45511544834, 54704.0, 35778.46332305018, 35906.0, 35998.28003439916, 36005.0, 36019.4597081044, 14433.639159021108, 14565.053271537316, 14571.271436428136, 14576.19830909289, 14578.927105364406, 12166.635000949986, 12253.326067066397, 12264.570740024057, 12266.202696824677, 12271.631851044305, 8264.876026859602, 8329.125441828643, 8379.958100209582, 8425.4944703318, 8435.957820210982, 3283.326917981808, 3292.506124081407, 3304.9008529744146, 3323.6177839548277, 3340.348632016782, 829.1238460198548, 916.1937495004487, 952.4285428742699, 970.3741086998846, 980.9705708828747, 28447.207452124778, 28565.285867853054, 28635.42729145447, 29444.852775735984, 29646.258843528653, 994.7761753605381, 1014.8477728340808, 1031.6286136990677, 1063.6543123484898, 1070.1545778834634, 15010.849891501164, 15517.844821551866, 15523.689526209413, 15534.45629402988, 15723.921380393254, 365089.0, 469655.0, 472313.0, 472675.0, 673170.0, 53732.19401708977, 54180.0, 54333.72833135809, 54435.0, 54541.1818822718, 1125.4991528769783, 1200.9459574319176, 1279.3347459321287, 1307.6861553227156, 1312.5996571045732, 28498.287542810765, 29579.40841183207, 29890.0, 30254.0, 30469.23826904345, 43588.78205608952, 44119.77940110279, 44292.0, 44297.0, 44345.113097737216, 280114.0, 281420.0, 282094.0, 282593.0, 283332.0, 23145.305640830127, 25394.365140871625, 26612.467750644493, 26751.464970700865, 27766.44467110687, 41922.0, 44371.98356666952, 45425.111282420585, 46124.30813537732, 50308.0, 38094.61905380911, 38205.80897095497, 38862.80568597139, 39149.6085039146, 39511.60488395079, 38133.49660757904, 38450.0, 38657.2268554633, 38819.2236155281, 38859.41710874395, 37608.43587346137, 37695.2460950774, 37917.0, 38723.41914871223, 38734.80632596819, 32646.0, 33707.0, 33892.49161262633, 34139.82930085433, 34173.316533669684, 25837.612435813855, 26273.737262627128, 26417.867910660323, 26460.090447421942, 26571.867140664173], "value": 17363.846387208025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9045194397068, 381.57645014034415, 382.80476956752057, 394.2765026176965, 394.30995757424506, 16285.430009949654, 17401.215805471125, 17853.910730446347, 17948.910255448704, 17951.0, 16955.237014334354, 17473.301067957298, 17644.206010729515, 17672.20475078621, 17678.734818977693, 5081.1108056090125, 5196.948030519703, 5201.141811601081, 5225.555827754645, 5284.471552844723, 3651.1419816343137, 4904.043711476245, 5921.88156236875, 5930.466258036776, 6013.579049466539, 5861.970690146564, 5959.404059594028, 5970.73131709072, 5975.073863551156, 5975.492083172936, 5725.971370143144, 6000.729967151445, 6024.277086749575, 6027.849303767419, 6030.487408570277, 5196.68819870809, 5255.395629502618, 5292.735363231823, 5293.920591191135, 5302.965921645281, 18028.639427211514, 18056.90971545134, 18062.277508899628, 18638.25446982119, 21287.36137915865, 2073.7407824022, 2566.089038391363, 2574.858382788946, 2579.4036562323963, 2634.2360715392515, 13029.153105048237, 13152.079354445194, 13184.14303070307, 13409.499101975693, 13955.511557095555, 1797.63148554546, 1799.136414521024, 1861.1996841358211, 1896.1467339697053, 1910.5892233169795, 67490.66254668696, 69300.3069969299, 69989.65005174992, 70309.0, 70310.2968970314, 9636.71089867305, 9793.755156121155, 9804.950975245078, 9825.825706917904, 9828.0, 12694.936525317315, 12858.099933004787, 12895.097343185887, 12900.354982251038, 12945.741085178432, 7281.854362912712, 7348.1182258129365, 7402.444816638774, 7573.35626471745, 7623.466357355042, 7398.852022959618, 7400.5189662671755, 7426.331630153204, 7552.697892084365, 7555.320021198118, 3989.9601003989587, 4153.979230103891, 4228.76741779199, 4244.342126970325, 4444.688871779009, 1642.8357164283475, 1684.6630673865277, 1732.8007279162805, 1733.0901276829513, 1733.8153926053012, 790.4703848421572, 899.0200681257461, 912.6121398405651, 934.7476181430976, 945.6122989574379, 16517.58706032359, 16743.581410464834, 17021.829781702025, 17289.394871179447, 17571.385001524886, 896.3232759266842, 902.5397047505819, 904.7873749668822, 909.7634615000015, 915.2586405011962, 9599.952000239955, 9702.951485242529, 9913.107820296207, 9925.50372481373, 10027.949860250652, 391335.0, 393969.0, 395936.0, 397970.0, 401732.0, 51903.0, 55092.44907550873, 73324.63337683277, 81725.59137204276, 84276.57861710653, 918.9678361257323, 940.247801758604, 959.4243453927587, 966.3911735606523, 971.0144203633317, 16053.759193612339, 16112.0, 16260.186990650656, 16555.420560280334, 16574.58563535875, 37698.0, 37771.244575108896, 39438.0, 40009.599904000585, 40215.0, 51274.0, 54462.45537544732, 54929.0, 55003.34989950308, 55065.72467137639, 6255.218097737783, 6408.942524483408, 7772.222777722182, 7782.455228133977, 7949.205079492004, 11515.53937842477, 12062.095342849147, 12093.0, 12201.938990304992, 12295.50817967307, 10490.160787136858, 10566.154707623526, 10599.576016959543, 10707.0, 10737.838932415863, 10145.847812282675, 10248.948755256177, 10324.845127323246, 10384.0, 10412.843807342744, 10662.786744264917, 10781.137508999418, 10880.945595271973, 10893.509792059534, 10956.397398143179, 6622.1722284714415, 7581.393488520795, 7602.315791578784, 7666.041744781903, 7704.229577042251, 8636.697715579925, 10717.624883129052, 10725.731856703645, 10910.2362834604, 11075.280106793032], "value": 8457.68095889637, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.9434825432854, 1473.6315921019745, 1512.780646806213, 1678.5719641491419, 1862.329561357911, 6814.318568143183, 7446.702131914723, 7587.734429294976, 7665.348445382149, 7673.386129109679, 7520.924790752091, 7801.024871891013, 7802.180771019046, 8001.079875814283, 8007.879881801778, 1853.9258429662798, 2079.313826437272, 2154.967675484869, 2171.4896999205134, 2223.4107961390164, 2190.9342719718434, 2193.462601662595, 2197.121151539381, 2198.857074290166, 2203.327984964585, 2140.079765700748, 2143.0784762552175, 2221.2669818959785, 2223.5108276179217, 2224.644056950888, 1803.1705415508816, 1866.878652887558, 1868.1966754295647, 2010.0552740212077, 2125.1180759984586, 2148.4521447030907, 2184.6395344768093, 2186.2566727312633, 2187.0377034105104, 2187.147012665062, 7839.3728501719725, 7888.9605551972445, 7890.408219383569, 7893.486923350021, 7894.407919406068, 4550.613197878184, 4653.581177694024, 4660.976695116537, 4661.627069834439, 4664.766761661937, 2835.277004363895, 2925.8683359248885, 2996.370762139953, 2998.940021199564, 3008.368242669042, 895.2435192262528, 958.5925981457852, 959.2661613865398, 964.2093483343662, 969.8399764038925, 10859.945700271526, 11105.333679979227, 11113.888861111367, 11119.72200694981, 11132.888671113265, 4211.7051806373875, 4360.302351623788, 4364.192624364439, 4369.628581570539, 4378.759168245713, 9582.856257156149, 9592.808143837085, 9596.18432433251, 9604.95197524008, 9619.0, 4679.953200467951, 4713.622910167179, 4731.787069581877, 4735.076660051257, 4742.051589682077, 3703.5740889798017, 4124.876253712333, 4265.12564924196, 4269.850555230614, 4337.522872484024, 3604.0, 3672.5225720656144, 3687.981560092236, 3835.0028992461603, 3895.3377925752125, 1198.394810620631, 1212.0848759186758, 1221.6701490597488, 1224.308265829821, 1240.5968060380412, 760.8440269744689, 875.3566128895256, 887.2414085956543, 913.0185051070126, 922.5433410461865, 5358.0, 5435.374931882884, 5490.368607610096, 5619.044762390404, 5683.062294721407, 866.6749968761715, 891.2736120062128, 938.5448057692014, 944.485255535721, 978.2320878110648, 3897.8830635080994, 3963.8612648557737, 3966.504186976628, 3981.7013723970817, 3983.8605648802154, 9722.562484688206, 9951.800963980824, 10044.045815647502, 10049.949750251348, 10070.04334588213, 9820.263480238867, 9892.356996795184, 9908.058734420218, 9909.058639429242, 9936.80126397468, 7459.358941032964, 7588.241175882367, 7636.50362726421, 7644.655990480442, 7648.80877978055, 5519.668819870821, 5541.833744987657, 5588.832335029955, 5626.88746225065, 5755.942440575541, 9080.137386948229, 9191.402558833654, 9262.9536852318, 9265.72202833916, 9296.209822165192, 9017.864732028893, 9441.386309889835, 9444.669436569962, 9445.905540944777, 9462.337636365388, 5918.3489816121055, 6099.024156135175, 6104.542159337979, 6598.703058362289, 6682.164729408824, 7044.542104763174, 7117.8932316016335, 7309.671064802203, 7337.0828646419195, 7559.0, 6918.757843475454, 7174.282571742784, 7183.497155199086, 7268.38218751412, 7298.306660867209, 6953.79138625842, 6968.442524598121, 6973.0, 7063.975723520163, 7074.434045276468, 6594.637294948632, 6603.669816509251, 6607.603543787388, 6612.801615951529, 6752.155980502437, 4669.7431641260055, 4876.658633895593, 4960.47914968923, 5041.067402530543, 5100.821471248489, 4741.217699079752, 4922.286268490977, 4924.335214745964, 4946.060248552763, 5025.673331233458], "value": 4239.220565916954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.4429674206473, 284.7024859022321, 301.4980058203092, 305.9892903748368, 313.1700992370219, 4804.855854324367, 4813.2539456384275, 4841.419029716439, 4846.418429788426, 4871.975640121799, 4539.568740969611, 4628.953710462903, 4682.672212945095, 4764.97617511912, 4781.856544303668, 3819.9631293121897, 3834.6740527055235, 3838.1172330364034, 3846.788426636534, 3850.2876967760985, 3839.577646458887, 3871.7096217783637, 3877.185790983897, 3880.844766209362, 3904.2777086238993, 3644.7266455015847, 3676.411774116142, 3743.5320584926885, 3783.905402364949, 3824.388097904336, 3755.286495565834, 3773.2642134783864, 3790.65884070435, 3801.79090150043, 3803.619638036202, 3382.0868365541414, 3382.2220889195623, 3387.305602351512, 3390.7117894978956, 3411.249525104473, 4410.42664453619, 4665.650076244261, 4687.95312046882, 4692.296155576657, 4712.0811441768865, 4295.775703924366, 4321.978390108061, 4325.286327755948, 4325.891852703676, 4343.587359200871, 5011.899762004776, 5034.446210916796, 5060.9493905060845, 5084.135696931494, 5086.77109530072, 3584.652052905351, 3619.6380361963857, 3649.4525821126776, 3653.214558869856, 3678.8528458861615, 5069.518395752398, 5269.973650131763, 5280.973595132038, 5294.576433885319, 5345.33183352081, 3608.729345299113, 3615.8610037838, 3638.6543278388513, 3648.3980143276062, 3656.689181419609, 3697.445383192489, 3698.2973235085246, 3701.11173318407, 3728.6830619397656, 3730.421784623388, 4131.8967025824595, 4248.893777655521, 4277.508086570022, 4282.6359759420175, 4300.548442413564, 5070.7464626768515, 5095.974520127375, 5108.744562771846, 5111.361079865017, 5129.281900533928, 1226.5645695778048, 1265.0891358222066, 1265.3609926986996, 1288.903332250085, 1303.1985329022773, 790.5572879187673, 805.1867613710195, 863.9352048596255, 873.9475631462133, 880.7445840706251, 4420.734755914656, 4421.838385554344, 4425.955740442619, 4444.6666500012625, 4447.909482543199, 5041.521055499722, 5175.14610089331, 5189.42916279209, 5204.7099276318295, 5212.504812042926, 4385.451818522684, 4415.889602759957, 4420.889477763018, 4433.82264709408, 4444.888877778081, 2692.2461710720636, 2741.232454912628, 2744.945101097967, 2749.8588085944507, 2750.7386798254133, 4718.197906355927, 4850.466448690641, 4884.902301953941, 4894.926576101361, 4915.631327650441, 5166.664166829144, 5236.162214045735, 5261.76322065508, 5275.894482110336, 5277.152996451211, 4855.902881942412, 4863.513648635179, 4882.170031094723, 4901.583365413909, 4915.4347250065985, 4914.70511769295, 5113.15632920564, 5141.562967147835, 5148.918727067357, 5156.917047420084, 5145.87135321605, 5162.664426812245, 5164.225366194951, 5173.965206958548, 5191.896162076813, 4962.139197800825, 4968.478309777566, 4981.2030075187795, 4984.355162796341, 5022.422421421437, 3657.3301489913047, 3711.2577484502667, 3729.757565758217, 3748.2503499299705, 3751.1934933989323, 5236.528712415901, 5237.816676416307, 5243.449437808975, 5249.317588713443, 5250.317458730493, 5028.270900719448, 5052.014857102829, 5060.0, 5062.746862656779, 5085.898282034413, 4861.295112208781, 4950.0, 4996.275540046746, 5039.521245481674, 5071.239314102914, 4735.455422626442, 4813.03739252144, 4950.381202349707, 4968.329275547755, 4994.200927851526, 5054.78685115577, 5065.544101030925, 5069.7718602662235, 5086.771095300646, 5092.465291144376, 4947.183714687037, 4949.624180393359, 4952.975235123946, 4960.652754307164, 4961.6030717543235], "value": 3806.4845768448527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.7435974329754, 707.9893801592974, 730.1894896664701, 822.6750433578736, 829.954352510612, 12005.63983080508, 12159.756804863908, 12344.444499997498, 12363.876361236385, 12380.81428778569, 11934.403279835995, 11972.940135299334, 11977.760444791098, 11982.101342399312, 11989.40052997351, 679.3851564334273, 699.6117154978984, 842.065307508668, 875.6541166239332, 881.0616693221731, 871.0766587417327, 877.9122087791234, 880.2473884828476, 880.9471431714118, 881.383031877685, 926.4117285523673, 927.823713494434, 927.9768005799875, 928.331601247101, 928.7120992492315, 713.8465229975554, 891.7681402835309, 917.7200953709116, 918.8346097702411, 925.7361651929201, 681.0125318288452, 681.7477533312706, 681.8159097043771, 681.9693113809891, 683.1528904158807, 11528.884711152949, 11553.94223028888, 11556.768864622745, 11566.53733850645, 11566.710832229262, 11410.372429516374, 11533.423328833525, 12043.879561204363, 12249.265044097294, 12422.75028906346, 10742.0, 10790.946045269724, 11057.612983545538, 11120.833187502194, 11167.106631469464, 4134.813933372975, 4136.420901073852, 4196.223698615766, 4209.936850947238, 4265.104328091104, 43081.853040532, 43644.345334820006, 45802.77098614519, 46207.30689039667, 46384.0, 9372.39079459833, 9443.527823608929, 9649.228061755182, 9669.323147379757, 9692.563834627459, 17820.9108954457, 17864.01747903878, 17873.910630446764, 17944.91027544854, 18002.189901454465, 6389.648569328639, 6508.674566271668, 6585.176852893388, 6642.0, 6781.42357899584, 3601.4777857210556, 3634.890953271406, 3669.0, 3712.1833196697226, 3744.625537446288, 2666.413389054405, 2760.654918135233, 2762.599423083642, 2773.0571605654172, 2773.237359726051, 484.394506866417, 489.7159647404497, 494.8094983431405, 508.0169871299048, 510.4334189050151, 438.32935608519017, 552.1827695011406, 560.1317957166376, 562.9380768115504, 567.3617180671745, 6978.127734033246, 7085.787426377114, 7115.644217789089, 7297.744578939712, 7382.409407247407, 488.53833127694696, 493.94566597674225, 513.5711680746543, 515.4536191636877, 522.3183745212458, 3368.915777105543, 3518.9472157917653, 3558.893233203008, 3563.518924945151, 3622.4566315052953, 47779.28331075037, 53270.0, 54116.72941635267, 54136.72931635395, 55167.72416137974, 48484.515154848, 49235.26147107796, 49778.25332620014, 49803.75098124486, 50800.491995080316, 44486.0, 44586.77706611511, 44799.32801007987, 45440.3183952241, 45868.0, 6929.653517324013, 7051.224365319913, 7079.115110611174, 7273.563586184846, 7297.16082650502, 30822.229444264074, 31124.533132002583, 31347.84326078355, 31402.68597314089, 31560.526592101596, 36635.63364366429, 40145.59854401419, 40160.799196003834, 40696.79651601723, 41215.381769272884, 9493.145616894513, 9518.714438566854, 9543.76140596463, 9669.419834809934, 9771.9022809771, 9641.0, 9726.805463890823, 9734.902650973683, 10028.749281268027, 10142.137918276734, 9410.43537387759, 9534.809303814023, 9618.278629102986, 9619.0, 10024.799504010025, 9434.339596228197, 9479.28905332089, 9509.096635819862, 9847.901520984698, 9887.060729230712, 8911.817087366988, 9580.137787598871, 9580.784812137348, 9778.119969202806, 10047.497625118862, 7810.1451574520015, 7910.920890791019, 7922.524648521107, 7951.443398962017, 8221.342292616457, 8191.754247372588, 8460.915390846012, 8497.52525933592, 8517.48895066298, 8614.870776938476], "value": 5788.62488337913, "unit": "score"}], "name": "dromaeo_css", "value": 6350.7600546023505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 113.0, 113.0, 113.0, 111.0, 112.0, 112.0, 115.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 159.0, 209.0, 135.0, 165.0, 166.0, 134.0, 196.0, 129.0], "value": 158.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 163.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 159.0, 75.0, 75.0, 76.0, 75.0, 127.0, 76.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 92.0, 93.0, 93.0, 138.0, 91.0, 92.0, 120.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 81.0, 80.0, 82.0, 83.0, 81.0, 89.0, 163.0, 87.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 128.0, 137.0, 125.0, 126.0, 125.0, 127.0, 154.0, 130.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 165.0, 170.0, 169.0, 167.0, 171.0, 169.0, 164.0, 172.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 67.0, 67.0, 75.0, 66.0, 65.0, 65.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1571.6, "alertThreshold": 2.0}]} 07:58:23 INFO - Return code: 0 07:58:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:58:24 ERROR - # TBPL SUCCESS # 07:58:24 INFO - Running post-action listener: _resource_record_post_action 07:58:24 INFO - ##### 07:58:24 INFO - ##### Finished run-tests step (success) 07:58:24 INFO - ##### 07:58:24 INFO - Running post-run listener: _resource_record_post_run 07:58:24 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530595840; Read time: 12; Write time: 482820 07:58:24 INFO - TinderboxPrint: CPU usage
13.1% 07:58:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:58:24 INFO - TinderboxPrint: I/O write bytes / time
530,595,840 / 482,820 07:58:24 INFO - TinderboxPrint: CPU idle
8,330.9 (86.9%) 07:58:24 INFO - TinderboxPrint: CPU user
1,211.7 (12.6%) 07:58:24 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234549248; Read time: 0; Write time: 236404 07:58:24 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295829504; Read time: 12; Write time: 246404 07:58:24 INFO - Running post-run listener: _upload_blobber_files 07:58:24 INFO - Blob upload gear active. 07:58:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:24 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 07:58:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:25 INFO - (blobuploader) - INFO - Done attempting. 07:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:26 INFO - (blobuploader) - INFO - Done attempting. 07:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:31 INFO - (blobuploader) - INFO - Done attempting. 07:58:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:31 INFO - Return code: 0 07:58:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15b038886067856f52b3b769ff676ad31605293a1983382c4057e0e353a9468e10d9dee55a4fab40ccf4a5bf3ed3479b67b8a5c336fcefcec19378602a411dbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85d2712988c172d52e6ab0837675f32b6786791ae7cffe752d302473f34e314b7556b53a4c745f231a7956257dc7a1ce6597999d1cb960dcd9aff663e365c30f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e973db262144f776519ba5074cd984e77834f693b684ab2bacbbbb8fd161278fe10eee241f817d709dc393f43490ebbd6afd75e2d8174c193849dd39313cca1"} 07:58:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:31 INFO - Contents: 07:58:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15b038886067856f52b3b769ff676ad31605293a1983382c4057e0e353a9468e10d9dee55a4fab40ccf4a5bf3ed3479b67b8a5c336fcefcec19378602a411dbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85d2712988c172d52e6ab0837675f32b6786791ae7cffe752d302473f34e314b7556b53a4c745f231a7956257dc7a1ce6597999d1cb960dcd9aff663e365c30f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e973db262144f776519ba5074cd984e77834f693b684ab2bacbbbb8fd161278fe10eee241f817d709dc393f43490ebbd6afd75e2d8174c193849dd39313cca1"} 07:58:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:31 INFO - Copying logs to upload dir... 07:58:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.649009 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-13 07:58:31.544206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 07:58:31.547850) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15b038886067856f52b3b769ff676ad31605293a1983382c4057e0e353a9468e10d9dee55a4fab40ccf4a5bf3ed3479b67b8a5c336fcefcec19378602a411dbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85d2712988c172d52e6ab0837675f32b6786791ae7cffe752d302473f34e314b7556b53a4c745f231a7956257dc7a1ce6597999d1cb960dcd9aff663e365c30f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e973db262144f776519ba5074cd984e77834f693b684ab2bacbbbb8fd161278fe10eee241f817d709dc393f43490ebbd6afd75e2d8174c193849dd39313cca1"} build_url:https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/CzWGMRW4Q4qNZzzqN1wWgA/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/Firefox-Non-PGO/sha512/15b038886067856f52b3b769ff676ad31605293a1983382c4057e0e353a9468e10d9dee55a4fab40ccf4a5bf3ed3479b67b8a5c336fcefcec19378602a411dbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85d2712988c172d52e6ab0837675f32b6786791ae7cffe752d302473f34e314b7556b53a4c745f231a7956257dc7a1ce6597999d1cb960dcd9aff663e365c30f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e973db262144f776519ba5074cd984e77834f693b684ab2bacbbbb8fd161278fe10eee241f817d709dc393f43490ebbd6afd75e2d8174c193849dd39313cca1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 07:58:31.572485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:58:31.572805) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463149649.528629-1793913508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 07:58:31.657397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 07:58:31.657907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 07:58:31.658367) ========= ========= Total master_lag: 0.54 =========