builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1464197763.78 results: success (0) buildid: 20160525053010 builduid: 50fc58abb45b4872ab99dc23d4077beb revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.779081) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.779576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.779862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.794282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.794636) ========= 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=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 10:36:04-- 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% 46.4M=0s 2016-05-25 10:36:04 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.915789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.916109) ========= 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=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014086 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:03.965876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:36:03.966238) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 --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=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 10:36:04,360 truncating revision to first 12 chars 2016-05-25 10:36:04,360 Setting DEBUG logging. 2016-05-25 10:36:04,360 attempt 1/10 2016-05-25 10:36:04,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a2ce43bcafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 10:36:05,615 unpacking tar archive at: fx-team-2a2ce43bcafb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.591180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 10:36:05.571427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:05.571839) ========= script_repo_revision: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:05.572297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:05.572606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 10:36:05.581580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-25 10:36:05.582053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:36:06 INFO - MultiFileLogger online at 20160525 10:36:06 in /builds/slave/test 10:36:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:36:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:36:06 INFO - {'append_to_log': False, 10:36:06 INFO - 'base_work_dir': '/builds/slave/test', 10:36:06 INFO - 'blob_upload_branch': 'Fx-Team', 10:36:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:36:06 INFO - 'branch': 'Fx-Team', 10:36:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:06 INFO - 'config_files': ('talos/linux_config.py',), 10:36:06 INFO - 'default_actions': ('clobber', 10:36:06 INFO - 'read-buildbot-config', 10:36:06 INFO - 'download-and-extract', 10:36:06 INFO - 'populate-webroot', 10:36:06 INFO - 'create-virtualenv', 10:36:06 INFO - 'install', 10:36:06 INFO - 'run-tests'), 10:36:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:06 INFO - 'download_minidump_stackwalk': True, 10:36:06 INFO - 'download_symbols': 'ondemand', 10:36:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:06 INFO - 'installer_path': 'installer.exe', 10:36:06 INFO - 'log_level': 'info', 10:36:06 INFO - 'log_name': 'talos', 10:36:06 INFO - 'log_to_console': True, 10:36:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:36:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:36:06 INFO - 'opt_config_files': (), 10:36:06 INFO - 'pip_index': False, 10:36:06 INFO - 'sps_profile': False, 10:36:06 INFO - 'sps_profile_interval': 0, 10:36:06 INFO - 'suite': 'dromaeojs', 10:36:06 INFO - 'system_bits': '32', 10:36:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:06 INFO - 'title': 'talos-linux64-ix-056', 10:36:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:06 INFO - 'use_talos_json': True, 10:36:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:36:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:06 INFO - 'work_dir': 'build'} 10:36:06 INFO - ##### 10:36:06 INFO - ##### Running clobber step. 10:36:06 INFO - ##### 10:36:06 INFO - Running pre-action listener: _resource_record_pre_action 10:36:06 INFO - Running main action method: clobber 10:36:06 INFO - rmtree: /builds/slave/test/build 10:36:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:06 INFO - Running post-action listener: _resource_record_post_action 10:36:06 INFO - ##### 10:36:06 INFO - ##### Finished clobber step (success) 10:36:06 INFO - ##### 10:36:06 INFO - ##### 10:36:06 INFO - ##### Running read-buildbot-config step. 10:36:06 INFO - ##### 10:36:06 INFO - Running pre-action listener: _resource_record_pre_action 10:36:06 INFO - Running main action method: read_buildbot_config 10:36:06 INFO - Using buildbot properties: 10:36:06 INFO - { 10:36:06 INFO - "project": "", 10:36:06 INFO - "product": "firefox", 10:36:06 INFO - "script_repo_revision": "production", 10:36:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:36:06 INFO - "repository": "", 10:36:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:36:06 INFO - "buildid": "20160525053010", 10:36:06 INFO - "pgo_build": "True", 10:36:06 INFO - "basedir": "/builds/slave/test", 10:36:06 INFO - "buildnumber": 127, 10:36:06 INFO - "slavename": "talos-linux64-ix-056", 10:36:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:36:06 INFO - "platform": "ubuntu64_hw", 10:36:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:36:06 INFO - "branch": "fx-team", 10:36:06 INFO - "repo_path": "integration/fx-team", 10:36:06 INFO - "revision": "2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7", 10:36:06 INFO - "stage_platform": "linux64-pgo", 10:36:06 INFO - "builduid": "50fc58abb45b4872ab99dc23d4077beb", 10:36:06 INFO - "slavebuilddir": "test" 10:36:06 INFO - } 10:36:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:36:06 INFO - Running post-action listener: _resource_record_post_action 10:36:06 INFO - ##### 10:36:06 INFO - ##### Finished read-buildbot-config step (success) 10:36:06 INFO - ##### 10:36:06 INFO - ##### 10:36:06 INFO - ##### Running download-and-extract step. 10:36:06 INFO - ##### 10:36:06 INFO - Running pre-action listener: _resource_record_pre_action 10:36:06 INFO - Running main action method: download_and_extract 10:36:06 INFO - mkdir: /builds/slave/test/build/tests 10:36: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')]} 10:36:06 INFO - https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:09 INFO - Downloaded 1361 bytes. 10:36:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:36:09 INFO - Using the following test package requirements: 10:36:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:36:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:36:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'jsshell-linux-x86_64.zip'], 10:36:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:36:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:36:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:36:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:36:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:36:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:36: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')]} 10:36:09 INFO - https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:10 INFO - Downloaded 24416736 bytes. 10:36:10 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'] 10:36:10 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 10:36:11 INFO - Return code: 0 10:36:11 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 10:36:11 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')]} 10:36:11 INFO - https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:12 INFO - Downloaded 24416736 bytes. 10:36:12 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'] 10:36:12 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 10:36:14 INFO - Return code: 0 10:36:14 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')]} 10:36:14 INFO - https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:15 INFO - Downloaded 10840359 bytes. 10:36:15 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'] 10:36:15 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 10:36:15 INFO - Return code: 0 10:36:15 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')]} 10:36:15 INFO - https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/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 10:36:16 INFO - Downloaded 58622859 bytes. 10:36:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:36:16 INFO - mkdir: /builds/slave/test/properties 10:36:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:16 INFO - Contents: 10:36:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:36:17 INFO - Running post-action listener: _resource_record_post_action 10:36:17 INFO - Running post-action listener: set_extra_try_arguments 10:36:17 INFO - ##### 10:36:17 INFO - ##### Finished download-and-extract step (success) 10:36:17 INFO - ##### 10:36:17 INFO - ##### 10:36:17 INFO - ##### Running populate-webroot step. 10:36:17 INFO - ##### 10:36:17 INFO - Running pre-action listener: _resource_record_pre_action 10:36:17 INFO - Running main action method: populate_webroot 10:36:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:17 INFO - '--tppagecycles', 10:36:17 INFO - '7'], 10:36:17 INFO - 'tests': ['tsvgm']}}, 10:36:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:36:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:36:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:36:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['damp', 'tps']}, 10:36:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'tests': ['damp', 'tps']}, 10:36:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['dromaeo_dom']}, 10:36:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['a11yr', 10:36:17 INFO - 'ts_paint', 10:36:17 INFO - 'tpaint', 10:36:17 INFO - 'sessionrestore', 10:36:17 INFO - 'sessionrestore_no_auto_restore', 10:36:17 INFO - 'tabpaint']}, 10:36:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['tsvgx', 10:36:17 INFO - 'tsvgr_opacity', 10:36:17 INFO - 'tart', 10:36:17 INFO - 'tscrollx', 10:36:17 INFO - 'cart']}, 10:36:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:36:17 INFO - 'tsvgr_opacity', 10:36:17 INFO - 'tart', 10:36:17 INFO - 'tscrollx', 10:36:17 INFO - 'cart']}, 10:36:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'talos_options': ['--disable-e10s'], 10:36:17 INFO - 'tests': ['tp5o']}, 10:36:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'tests': ['tp5o']}, 10:36:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'talos_options': ['--disable-e10s', 10:36:17 INFO - '--xperf_path', 10:36:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:17 INFO - 'tests': ['tp5n']}, 10:36:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:17 INFO - 'talos_options': ['--xperf_path', 10:36:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:17 INFO - 'tests': ['tp5n']}}, 10:36:17 INFO - 'talos.zip': {'path': '', 10:36:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:17 INFO - Running post-action listener: _resource_record_post_action 10:36:17 INFO - ##### 10:36:17 INFO - ##### Finished populate-webroot step (success) 10:36:17 INFO - ##### 10:36:17 INFO - ##### 10:36:17 INFO - ##### Running create-virtualenv step. 10:36:17 INFO - ##### 10:36:17 INFO - Running pre-action listener: _resource_record_pre_action 10:36:17 INFO - Running main action method: create_virtualenv 10:36:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:17 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 10:36:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:17 INFO - Using real prefix '/usr' 10:36:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:20 INFO - Installing pip.................done. 10:36:20 INFO - Return code: 0 10:36:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:20 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:20 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 10:36:20 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 10:36:20 INFO - Using env: {'DISPLAY': ':0', 10:36:20 INFO - 'HOME': '/home/cltbld', 10:36:20 INFO - 'LANG': 'en_US.UTF-8', 10:36:20 INFO - 'LANGUAGE': 'en_US:en', 10:36:20 INFO - 'LOGNAME': 'cltbld', 10:36:20 INFO - 'MAIL': '/var/mail/cltbld', 10:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:20 INFO - 'MOZ_NO_REMOTE': '1', 10:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:20 INFO - 'NO_EM_RESTART': '1', 10:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:20 INFO - 'PWD': '/builds/slave/test', 10:36:20 INFO - 'SHELL': '/bin/bash', 10:36:20 INFO - 'SHLVL': '1', 10:36:20 INFO - 'TERM': 'linux', 10:36:20 INFO - 'TMOUT': '86400', 10:36:20 INFO - 'USER': 'cltbld', 10:36:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:20 INFO - '_': '/tools/buildbot/bin/python'} 10:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:20 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 10:36:20 INFO - Cleaning up... 10:36:20 INFO - Return code: 0 10:36:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:20 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:20 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 10:36:20 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 10:36:20 INFO - Using env: {'DISPLAY': ':0', 10:36:20 INFO - 'HOME': '/home/cltbld', 10:36:20 INFO - 'LANG': 'en_US.UTF-8', 10:36:20 INFO - 'LANGUAGE': 'en_US:en', 10:36:20 INFO - 'LOGNAME': 'cltbld', 10:36:20 INFO - 'MAIL': '/var/mail/cltbld', 10:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:20 INFO - 'MOZ_NO_REMOTE': '1', 10:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:20 INFO - 'NO_EM_RESTART': '1', 10:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:20 INFO - 'PWD': '/builds/slave/test', 10:36:20 INFO - 'SHELL': '/bin/bash', 10:36:20 INFO - 'SHLVL': '1', 10:36:20 INFO - 'TERM': 'linux', 10:36:20 INFO - 'TMOUT': '86400', 10:36:20 INFO - 'USER': 'cltbld', 10:36:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:20 INFO - '_': '/tools/buildbot/bin/python'} 10:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:20 INFO - Downloading/unpacking psutil>=3.1.1 10:36:20 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 10:36:20 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 10:36:20 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 10:36:20 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 10:36:20 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 10:36:20 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 10:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:22 INFO - Installing collected packages: psutil 10:36:22 INFO - Running setup.py install for psutil 10:36:22 INFO - building 'psutil._psutil_linux' extension 10:36:22 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 10:36:22 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 10:36:22 INFO - building 'psutil._psutil_posix' extension 10:36:22 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 10:36:23 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 10:36:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:23 INFO - Successfully installed psutil 10:36:23 INFO - Cleaning up... 10:36:23 INFO - Return code: 0 10:36:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:36:23 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')]} 10:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 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')]} 10:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:36:23 INFO - Using env: {'DISPLAY': ':0', 10:36:23 INFO - 'HOME': '/home/cltbld', 10:36:23 INFO - 'LANG': 'en_US.UTF-8', 10:36:23 INFO - 'LANGUAGE': 'en_US:en', 10:36:23 INFO - 'LOGNAME': 'cltbld', 10:36:23 INFO - 'MAIL': '/var/mail/cltbld', 10:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:23 INFO - 'MOZ_NO_REMOTE': '1', 10:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:23 INFO - 'NO_EM_RESTART': '1', 10:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:23 INFO - 'PWD': '/builds/slave/test', 10:36:23 INFO - 'SHELL': '/bin/bash', 10:36:23 INFO - 'SHLVL': '1', 10:36:23 INFO - 'TERM': 'linux', 10:36:23 INFO - 'TMOUT': '86400', 10:36:23 INFO - 'USER': 'cltbld', 10:36:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:23 INFO - '_': '/tools/buildbot/bin/python'} 10:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:36:23 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 10:36:23 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 10:36:23 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 10:36:23 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 10:36:23 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 10:36:23 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 10:36:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:36:25 INFO - Installing collected packages: mozsystemmonitor 10:36:25 INFO - Running setup.py install for mozsystemmonitor 10:36:25 INFO - Successfully installed mozsystemmonitor 10:36:25 INFO - Cleaning up... 10:36:25 INFO - Return code: 0 10:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:25 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')]} 10:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:25 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')]} 10:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:25 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:25 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 10:36:25 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 10:36:25 INFO - Using env: {'DISPLAY': ':0', 10:36:25 INFO - 'HOME': '/home/cltbld', 10:36:25 INFO - 'LANG': 'en_US.UTF-8', 10:36:25 INFO - 'LANGUAGE': 'en_US:en', 10:36:25 INFO - 'LOGNAME': 'cltbld', 10:36:25 INFO - 'MAIL': '/var/mail/cltbld', 10:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:25 INFO - 'MOZ_NO_REMOTE': '1', 10:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:25 INFO - 'NO_EM_RESTART': '1', 10:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:25 INFO - 'PWD': '/builds/slave/test', 10:36:25 INFO - 'SHELL': '/bin/bash', 10:36:25 INFO - 'SHLVL': '1', 10:36:25 INFO - 'TERM': 'linux', 10:36:25 INFO - 'TMOUT': '86400', 10:36:25 INFO - 'USER': 'cltbld', 10:36:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:25 INFO - '_': '/tools/buildbot/bin/python'} 10:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:25 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 10:36:25 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 10:36:25 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 10:36:25 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 10:36:25 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 10:36:25 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 10:36:27 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:27 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 10:36:27 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 10:36:27 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 10:36:27 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 10:36:27 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 10:36:27 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 10:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:36:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:36:28 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 10:36:28 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 10:36:28 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 10:36:28 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 10:36:28 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 10:36:28 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 10:36:28 INFO - Downloading docopt-0.6.1.tar.gz 10:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:36:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:36:28 INFO - Running setup.py install for blobuploader 10:36:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:36:28 INFO - Running setup.py install for requests 10:36:28 INFO - Running setup.py install for docopt 10:36:28 INFO - Successfully installed blobuploader requests docopt 10:36:28 INFO - Cleaning up... 10:36:28 INFO - Return code: 0 10:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:28 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')]} 10:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:28 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')]} 10:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:28 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:28 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 10:36:28 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 10:36:28 INFO - Using env: {'DISPLAY': ':0', 10:36:28 INFO - 'HOME': '/home/cltbld', 10:36:28 INFO - 'LANG': 'en_US.UTF-8', 10:36:28 INFO - 'LANGUAGE': 'en_US:en', 10:36:28 INFO - 'LOGNAME': 'cltbld', 10:36:28 INFO - 'MAIL': '/var/mail/cltbld', 10:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:28 INFO - 'MOZ_NO_REMOTE': '1', 10:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:28 INFO - 'NO_EM_RESTART': '1', 10:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:28 INFO - 'PWD': '/builds/slave/test', 10:36:28 INFO - 'SHELL': '/bin/bash', 10:36:28 INFO - 'SHLVL': '1', 10:36:28 INFO - 'TERM': 'linux', 10:36:28 INFO - 'TMOUT': '86400', 10:36:28 INFO - 'USER': 'cltbld', 10:36:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:28 INFO - '_': '/tools/buildbot/bin/python'} 10:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:29 INFO - Running setup.py (path:/tmp/pip-H9kpSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:29 INFO - Running setup.py (path:/tmp/pip-FSNXAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:29 INFO - Running setup.py (path:/tmp/pip-diHsUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:29 INFO - Running setup.py (path:/tmp/pip-Dp0CAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:29 INFO - Running setup.py (path:/tmp/pip-RWOcpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:29 INFO - Running setup.py (path:/tmp/pip-9_zzEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:29 INFO - Running setup.py (path:/tmp/pip-TlJ4aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:29 INFO - Running setup.py (path:/tmp/pip-Na2Wun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:29 INFO - Running setup.py (path:/tmp/pip-GPCyt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:29 INFO - Running setup.py (path:/tmp/pip-dhIS5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:29 INFO - Running setup.py (path:/tmp/pip-rX7mS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:29 INFO - Running setup.py (path:/tmp/pip-NOYmX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:30 INFO - Running setup.py (path:/tmp/pip-tVB7iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:30 INFO - Running setup.py (path:/tmp/pip-6XT2wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:30 INFO - Running setup.py (path:/tmp/pip-vB26z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:30 INFO - Running setup.py (path:/tmp/pip-nLGmPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:30 INFO - Running setup.py (path:/tmp/pip-XuldgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:36:30 INFO - Running setup.py install for manifestparser 10:36:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:36:30 INFO - Running setup.py install for mozcrash 10:36:30 INFO - Running setup.py install for mozdebug 10:36:30 INFO - Running setup.py install for mozdevice 10:36:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:36:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:36:30 INFO - Running setup.py install for mozfile 10:36:30 INFO - Running setup.py install for mozhttpd 10:36:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:36:30 INFO - Running setup.py install for mozinfo 10:36:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for mozInstall 10:36:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for mozleak 10:36:31 INFO - Running setup.py install for mozlog 10:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for moznetwork 10:36:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for mozprocess 10:36:31 INFO - Running setup.py install for mozprofile 10:36:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for mozrunner 10:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:36:31 INFO - Running setup.py install for mozscreenshot 10:36:31 INFO - Running setup.py install for moztest 10:36:32 INFO - Running setup.py install for mozversion 10:36:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:36:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:36:32 INFO - Cleaning up... 10:36:32 INFO - Return code: 0 10:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:32 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:32 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 10:36:32 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 10:36:32 INFO - Using env: {'DISPLAY': ':0', 10:36:32 INFO - 'HOME': '/home/cltbld', 10:36:32 INFO - 'LANG': 'en_US.UTF-8', 10:36:32 INFO - 'LANGUAGE': 'en_US:en', 10:36:32 INFO - 'LOGNAME': 'cltbld', 10:36:32 INFO - 'MAIL': '/var/mail/cltbld', 10:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:32 INFO - 'MOZ_NO_REMOTE': '1', 10:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:32 INFO - 'NO_EM_RESTART': '1', 10:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:32 INFO - 'PWD': '/builds/slave/test', 10:36:32 INFO - 'SHELL': '/bin/bash', 10:36:32 INFO - 'SHLVL': '1', 10:36:32 INFO - 'TERM': 'linux', 10:36:32 INFO - 'TMOUT': '86400', 10:36:32 INFO - 'USER': 'cltbld', 10:36:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:32 INFO - '_': '/tools/buildbot/bin/python'} 10:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:32 INFO - Running setup.py (path:/tmp/pip-q9YdPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:32 INFO - Running setup.py (path:/tmp/pip-VxTQ2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:32 INFO - Running setup.py (path:/tmp/pip-YXUwi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:32 INFO - Running setup.py (path:/tmp/pip-jcdVZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:32 INFO - Running setup.py (path:/tmp/pip-_znPZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:32 INFO - Running setup.py (path:/tmp/pip-Pzp_fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:32 INFO - Running setup.py (path:/tmp/pip-NLQuOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:32 INFO - Running setup.py (path:/tmp/pip-wEV3Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:32 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)) 10:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:32 INFO - Running setup.py (path:/tmp/pip-DZyeg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:33 INFO - Running setup.py (path:/tmp/pip-883bic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:33 INFO - Running setup.py (path:/tmp/pip-f1EICo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:33 INFO - Running setup.py (path:/tmp/pip-_vDB8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:33 INFO - Running setup.py (path:/tmp/pip-j0yCrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:33 INFO - Running setup.py (path:/tmp/pip-MVePF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:33 INFO - Running setup.py (path:/tmp/pip-oMZOff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:33 INFO - Running setup.py (path:/tmp/pip-z4GiIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:33 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)) 10:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:33 INFO - Running setup.py (path:/tmp/pip-PuEP6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:33 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)) 10:36:33 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)) 10:36:33 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)) 10:36:33 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)) 10:36:33 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)) 10:36:33 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)) 10:36:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:36:33 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 10:36:33 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 10:36:33 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 10:36:33 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 10:36:33 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 10:36:33 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 10:36:35 INFO - Downloading blessings-1.6.tar.gz 10:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:36:35 INFO - Installing collected packages: blessings 10:36:35 INFO - Running setup.py install for blessings 10:36:35 INFO - Successfully installed blessings 10:36:35 INFO - Cleaning up... 10:36:35 INFO - Return code: 0 10:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:36 INFO - Reading from file tmpfile_stdout 10:36:36 INFO - Current package versions: 10:36:36 INFO - argparse == 1.2.1 10:36:36 INFO - blessings == 1.6 10:36:36 INFO - blobuploader == 1.2.4 10:36:36 INFO - docopt == 0.6.1 10:36:36 INFO - manifestparser == 1.1 10:36:36 INFO - mozInstall == 1.12 10:36:36 INFO - mozcrash == 0.17 10:36:36 INFO - mozdebug == 0.1 10:36:36 INFO - mozdevice == 0.48 10:36:36 INFO - mozfile == 1.2 10:36:36 INFO - mozhttpd == 0.7 10:36:36 INFO - mozinfo == 0.9 10:36:36 INFO - mozleak == 0.1 10:36:36 INFO - mozlog == 3.2 10:36:36 INFO - moznetwork == 0.27 10:36:36 INFO - mozprocess == 0.22 10:36:36 INFO - mozprofile == 0.28 10:36:36 INFO - mozrunner == 6.11 10:36:36 INFO - mozscreenshot == 0.1 10:36:36 INFO - mozsystemmonitor == 0.3 10:36:36 INFO - moztest == 0.7 10:36:36 INFO - mozversion == 1.4 10:36:36 INFO - psutil == 3.1.1 10:36:36 INFO - requests == 1.2.3 10:36:36 INFO - wsgiref == 0.1.2 10:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:36 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:36 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 10:36:36 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 10:36:36 INFO - Using env: {'DISPLAY': ':0', 10:36:36 INFO - 'HOME': '/home/cltbld', 10:36:36 INFO - 'LANG': 'en_US.UTF-8', 10:36:36 INFO - 'LANGUAGE': 'en_US:en', 10:36:36 INFO - 'LOGNAME': 'cltbld', 10:36:36 INFO - 'MAIL': '/var/mail/cltbld', 10:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:36 INFO - 'MOZ_NO_REMOTE': '1', 10:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:36 INFO - 'NO_EM_RESTART': '1', 10:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:36 INFO - 'PWD': '/builds/slave/test', 10:36:36 INFO - 'SHELL': '/bin/bash', 10:36:36 INFO - 'SHLVL': '1', 10:36:36 INFO - 'TERM': 'linux', 10:36:36 INFO - 'TMOUT': '86400', 10:36:36 INFO - 'USER': 'cltbld', 10:36:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:36 INFO - '_': '/tools/buildbot/bin/python'} 10:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 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)) 10:36:36 INFO - Cleaning up... 10:36:36 INFO - Return code: 0 10:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:36 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:36 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 10:36:36 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 10:36:36 INFO - Using env: {'DISPLAY': ':0', 10:36:36 INFO - 'HOME': '/home/cltbld', 10:36:36 INFO - 'LANG': 'en_US.UTF-8', 10:36:36 INFO - 'LANGUAGE': 'en_US:en', 10:36:36 INFO - 'LOGNAME': 'cltbld', 10:36:36 INFO - 'MAIL': '/var/mail/cltbld', 10:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:36 INFO - 'MOZ_NO_REMOTE': '1', 10:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:36 INFO - 'NO_EM_RESTART': '1', 10:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:36 INFO - 'PWD': '/builds/slave/test', 10:36:36 INFO - 'SHELL': '/bin/bash', 10:36:36 INFO - 'SHLVL': '1', 10:36:36 INFO - 'TERM': 'linux', 10:36:36 INFO - 'TMOUT': '86400', 10:36:36 INFO - 'USER': 'cltbld', 10:36:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:36 INFO - '_': '/tools/buildbot/bin/python'} 10:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:36 INFO - Downloading/unpacking jsonschema 10:36:36 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 10:36:36 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 10:36:36 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 10:36:36 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 10:36:36 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 10:36:36 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 10:36:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:36:39 INFO - Downloading/unpacking functools32 (from jsonschema) 10:36:39 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 10:36:39 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 10:36:39 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 10:36:39 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 10:36:39 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 10:36:39 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 10:36:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:36:39 INFO - warning: no files found matching '*.txt' 10:36:39 INFO - no previously-included directories found matching 'build' 10:36:39 INFO - no previously-included directories found matching 'dist' 10:36:39 INFO - no previously-included directories found matching '.git*' 10:36:39 INFO - Installing collected packages: jsonschema, functools32 10:36:39 INFO - Running setup.py install for functools32 10:36:39 INFO - warning: no files found matching '*.txt' 10:36:39 INFO - no previously-included directories found matching 'build' 10:36:39 INFO - no previously-included directories found matching 'dist' 10:36:39 INFO - no previously-included directories found matching '.git*' 10:36:39 INFO - Successfully installed jsonschema functools32 10:36:39 INFO - Cleaning up... 10:36:39 INFO - Return code: 0 10:36:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:39 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 0x7f164510cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f67770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, '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': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', '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 10:36:39 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 10:36:39 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 10:36:39 INFO - Using env: {'DISPLAY': ':0', 10:36:39 INFO - 'HOME': '/home/cltbld', 10:36:39 INFO - 'LANG': 'en_US.UTF-8', 10:36:39 INFO - 'LANGUAGE': 'en_US:en', 10:36:39 INFO - 'LOGNAME': 'cltbld', 10:36:39 INFO - 'MAIL': '/var/mail/cltbld', 10:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:39 INFO - 'MOZ_NO_REMOTE': '1', 10:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:39 INFO - 'NO_EM_RESTART': '1', 10:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:39 INFO - 'PWD': '/builds/slave/test', 10:36:39 INFO - 'SHELL': '/bin/bash', 10:36:39 INFO - 'SHLVL': '1', 10:36:39 INFO - 'TERM': 'linux', 10:36:39 INFO - 'TMOUT': '86400', 10:36:39 INFO - 'USER': 'cltbld', 10:36:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:39 INFO - '_': '/tools/buildbot/bin/python'} 10:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:40 INFO - Downloading/unpacking flake8 10:36:40 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 10:36:40 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 10:36:40 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 10:36:40 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 10:36:40 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 10:36:40 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 10:36:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:36:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:36:41 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 10:36:41 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 10:36:41 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 10:36:41 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 10:36:41 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 10:36:41 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 10:36:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:36:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:42 INFO - no previously-included directories found matching 'docs/_build' 10:36:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:36:42 INFO - Running setup.py install for pep8 10:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:42 INFO - no previously-included directories found matching 'docs/_build' 10:36:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:36:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:36:42 INFO - Cleaning up... 10:36:42 INFO - Return code: 0 10:36:42 INFO - Running post-action listener: _resource_record_post_action 10:36:42 INFO - Running post-action listener: _start_resource_monitoring 10:36:42 INFO - Starting resource monitoring. 10:36:42 INFO - ##### 10:36:42 INFO - ##### Finished create-virtualenv step (success) 10:36:42 INFO - ##### 10:36:42 INFO - ##### 10:36:42 INFO - ##### Running install step. 10:36:42 INFO - ##### 10:36:42 INFO - Running pre-action listener: _resource_record_pre_action 10:36:42 INFO - Running main action method: install 10:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:43 INFO - Reading from file tmpfile_stdout 10:36:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:36:43 INFO - Reading from file tmpfile_stdout 10:36:43 INFO - Output received: 10:36:43 INFO - Usage: mozinstall [options] installer 10:36:43 INFO - Options: 10:36:43 INFO - -h, --help show this help message and exit 10:36:43 INFO - -d DEST, --destination=DEST 10:36:43 INFO - Directory to install application into. [default: 10:36:43 INFO - "/builds/slave/test"] 10:36:43 INFO - --app=APP Application being installed. [default: firefox] 10:36:43 INFO - mkdir: /builds/slave/test/build/application 10:36:43 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'] 10:36:43 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 10:36:59 INFO - Reading from file tmpfile_stdout 10:36:59 INFO - Output received: 10:36:59 INFO - /builds/slave/test/build/application/firefox/firefox 10:36:59 INFO - Running post-action listener: _resource_record_post_action 10:36:59 INFO - ##### 10:36:59 INFO - ##### Finished install step (success) 10:36:59 INFO - ##### 10:36:59 INFO - ##### 10:36:59 INFO - ##### Running run-tests step. 10:36:59 INFO - ##### 10:36:59 INFO - Running pre-action listener: _resource_record_pre_action 10:36:59 INFO - Running main action method: run_tests 10:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:59 INFO - Python 2.7.3 10:36:59 INFO - Return code: 0 10:36:59 INFO - grabbing minidump binary from tooltool 10:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:59 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 0x1ff69c0>, '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 0x1ff78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:59 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 10:36:59 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 10:36:59 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 10:36:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:59 INFO - Return code: 0 10:36:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:36:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:36:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:37:00 INFO - Return code: 0 10:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 10:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 10:37:00 INFO - Using env: {'DISPLAY': ':0', 10:37:00 INFO - 'HOME': '/home/cltbld', 10:37:00 INFO - 'LANG': 'en_US.UTF-8', 10:37:00 INFO - 'LANGUAGE': 'en_US:en', 10:37:00 INFO - 'LOGNAME': 'cltbld', 10:37:00 INFO - 'MAIL': '/var/mail/cltbld', 10:37:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:00 INFO - 'MOZ_NO_REMOTE': '1', 10:37:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:00 INFO - 'NO_EM_RESTART': '1', 10:37:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:00 INFO - 'PWD': '/builds/slave/test', 10:37:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:00 INFO - 'SHELL': '/bin/bash', 10:37:00 INFO - 'SHLVL': '1', 10:37:00 INFO - 'TERM': 'linux', 10:37:00 INFO - 'TMOUT': '86400', 10:37:00 INFO - 'USER': 'cltbld', 10:37:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464197763.445751-857912986', 10:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:00 INFO - '_': '/tools/buildbot/bin/python'} 10:37:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 10:37:01 INFO - mozversion application_buildid: 20160525053010 10:37:01 INFO - mozversion application_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 10:37:01 INFO - mozversion application_display_name: Nightly 10:37:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:01 INFO - mozversion application_name: Firefox 10:37:01 INFO - mozversion application_remotingname: firefox 10:37:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:37:01 INFO - mozversion application_vendor: Mozilla 10:37:01 INFO - mozversion application_version: 49.0a1 10:37:01 INFO - mozversion platform_buildid: 20160525053010 10:37:01 INFO - mozversion platform_changeset: 2a2ce43bcafb42f0f5fcf4dd0f135eefdfe085b7 10:37:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:37:01 INFO - mozversion platform_version: 49.0a1 10:37:01 INFO - using testdate: 1464197821 10:37:01 INFO - actual date: 1464197821 10:37:01 INFO - starting webserver on 'localhost:45112' 10:37:01 INFO - SUITE-START | Running 2 tests 10:37:01 INFO - TEST-START | dromaeo_css 10:37:01 INFO - operating with platform_type : linux_ 10:37:01 INFO - Initialising browser for dromaeo_css test... 10:37:01 INFO - TEST-INFO | started process 23047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92isrk/profile http://localhost:45112/getInfo.html) 10:37:05 INFO - PROCESS | 23047 | __metrics Screen width/height:1600/1200 10:37:05 INFO - PROCESS | 23047 | colorDepth:24 10:37:05 INFO - PROCESS | 23047 | Browser inner width/height: 1024/697 10:37:05 INFO - PROCESS | 23047 | __metrics 10:37:06 ERROR - PROCESS | 23047 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:37:07 INFO - TEST-INFO | 23047: exit 0 10:37:07 INFO - Browser initialized. 10:37:07 INFO - Running cycle 1/1 for dromaeo_css test... 10:37:07 INFO - TEST-INFO | started process 23131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92isrk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:19 INFO - PROCESS | 23131 | RSS: Main: 153325568 10:37:19 INFO - PROCESS | 23131 | 10:38:10 INFO - PROCESS | 23131 | 1464197890106 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] 10:40:18 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45112/tests/dromaeo/cssquery-ext.html) 10:40:19 INFO - PROCESS | 23131 | RSS: Main: 244191232 10:40:19 INFO - PROCESS | 23131 | 10:43:21 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-ext.html (next: http://localhost:45112/tests/dromaeo/cssquery-jquery.html) 10:43:21 INFO - PROCESS | 23131 | RSS: Main: 241700864 10:43:21 INFO - PROCESS | 23131 | 10:46:24 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45112/tests/dromaeo/cssquery-mootools.html) 10:46:24 INFO - PROCESS | 23131 | RSS: Main: 246980608 10:46:24 INFO - PROCESS | 23131 | 10:49:26 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45112/tests/dromaeo/cssquery-prototype.html) 10:49:27 INFO - PROCESS | 23131 | RSS: Main: 241385472 10:49:27 INFO - PROCESS | 23131 | 10:52:29 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45112/tests/dromaeo/cssquery-yui.html) 10:52:30 INFO - PROCESS | 23131 | RSS: Main: 225984512 10:52:30 INFO - PROCESS | 23131 | 10:55:32 INFO - PROCESS | 23131 | Cycle 1(1): loaded http://localhost:45112/tests/dromaeo/cssquery-yui.html (next: http://localhost:45112/tests/dromaeo/cssquery-dojo.html) 10:55:33 INFO - PROCESS | 23131 | RSS: Main: 274464768 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | __start_tp_report 10:55:33 INFO - PROCESS | 23131 | _x_x_mozilla_page_load 10:55:33 INFO - PROCESS | 23131 | _x_x_mozilla_page_load_details 10:55:33 INFO - PROCESS | 23131 | |i|pagename|runs| 10:55:33 INFO - PROCESS | 23131 | |0;dojo.html;3061.234691327168;3073.200967748385;3096.349766549024;3111.92220194495;3129.5775070365507;5245.213218017299;5268.0517506848755;5351.331083614548;5359.35687717474;5373.301470808794;5289.523942845143;5293.311869456975;5346.27825243592;5367.677939323643;5432.945670543293;4771.379720636312;4850.805967761303;4864.805407783684;4865.391826021747;5049.4193167785625;4904.5340692634145;4969.4036715594;4999.400071991348;5016.172331565287;5030.798768049273;4633.582977532022;4757.690750101232;4796.136695394827;4807.879803004917;4821.397325334333;4822.6624136310475;4831.830885919011;4885.755712214411;4899.902001959977;4932.679375840559;4715.4577223619035;4897.191963326047;4911.484294149099;4920.581750551208;4951.727654978975;5256.632035757499;5336.06618841705;5340.092184328634;5400.83797486076;5420.593455490854;5816.505597024258;5828.009238429435;5845.123231515264;5857.70711464425;5878.177055212273;5637.182608521783;5704.1443783432405;5816.243888294537;5883.823485295406;5885.793997210077;5380.946190538084;5464.590155738336;5472.5621950243885;5478.123500239943;5480.671159730389;5917.46742793142;5922.644641321534;5962.463378295887;5976.491998180203;5988.131720900532;5444.564434845203;5546.389897111315;5583.330000399978;5666.575006874501;5681.801136960186;5757.424257574293;5763.394843541368;5794.971025144931;5808.535317174616;5811.070228763378;5719.971400142973;5748.166515855178;5753.827385178452;5762.250907382014;5769.048107062372;5507.834764956978;5594.944050559524;5653.858653533694;5658.886822263614;5761.164631128463;4364.236258654722;4368.344748287782;4373.387725718402;4375.16871794358;4419.734815911055;3882.9611703883165;3891.280113179071;3900.6099390060767;3935.1539419024475;3950.5456872460036;5249.737513124329;5352;5394.433584473652;5452.372977107683;5455.481729235717;5845.970770146122;5848.8537786554825;5855.063189889597;5874.882502349929;5900.0264956281735;5497.45025497447;5504.614676972654;5506.476884695948;5515.531179849758;5519;4758.357621721093;4902.632302577321;4964.255361695702;4971.229459433794;5002.774875130628;5951.4941229995065;5970.850728731816;5974.133750606138;5979.402059793986;5983;5626.578006649435;5772.480476757112;5789.3921138279875;5796.391378905323;5809.448102430262;5822.82531524055;5876.911846322223;5899.734511946886;5990.760369585168;5994.0409534474275;5588.273524441796;5631.831045068655;5640.746166422438;5643.661380317194;5644.689542075061;5721.828345149652;5759.510441612342;5791.710414479175;5802.767889284381;5806.2451881255165;5391.919121213106;5643.71781410936;5707.543396528351;5716.142578613241;5719.914201286901;5637.126245431965;5665.66006039639;5667.4615911488345;5715.542756579547;5722.484976352148;5395.81114660985;5641.576881733969;5645.943540564542;5647.915281270702;5655.547556195412;5641.887162256649;5643.689597072201;5649.435056494318;5714.828555143353;5717.285339332583;5591.4688104629995;5594.496495315441;5615.073512870494;5621.943780562142;5632.098864181711 10:55:33 INFO - PROCESS | 23131 | |1;ext.html;594.2957595249629;631.9462845658118;638.9808255831946;648.4455790299294;659.436182064335;40988.79505602471;42977.570224297786;43021.56978430215;46259.07481850361;46356.536434635644;42419.363709544305;43217;43376.78311608438;43396.566034339725;43627.3455898161;8530.999999999984;8656.091110433377;8716.041235464094;8729.694460693878;8729.956350218272;8651.178138076873;8727.60725767342;8766.211041006309;8777.253933415668;8778.780530486756;8745.737627871174;8794.12058794122;8804.427712198718;8805.16350946659;8812.955935220347;8740.21338079576;8741.25699315559;8758.781030474225;8769.649214031431;8789.604467798932;8428.367872409593;8487.40588158829;8493.447925884859;8501.914980850173;8518.48889066658;40580.59419405798;40780.1843963122;40810;40898;41002.79498602488;3100.689931006904;3564.315022108902;3882.184741204322;3896.883093507199;3971.3645816669195;31763.04710858678;31927.361452771045;32035;32085.839570801996;32575.674243257738;4178.1643671265865;4361.760103194323;4371.6721245906365;4385.539518350559;4475.5748203920575;233128;234059;234405;234920;235481;48104.5189548107;48289.27566086512;48773.75613121912;48876;48909.75545122323;58961.41038589559;59052;59100.70449647724;59164.40835591589;59222;14675.633109172142;14703.779443308358;14782.926085369505;14787.11277323364;14807.555773326818;11650.941745291218;11707;11711.824322635168;11747.060235181165;11769.352685602204;16927.407540736014;17269.913650431667;17274.309027638752;17330.39343622967;17386.652266954843;6007.8197654070445;6010.639361638316;6030.396960304022;6047.697615119227;6189.226346706661;801.3669201330999;802.7757669553977;992.6575331510618;1042.3172821801732;1063.8138325792954;29146.854265728958;29645.407091858044;29808.254793630334;30373.84813075965;30464.390712185632;1050.3435352904435;1068.636663534402;1120.294214644785;1128.4978184707727;1169.2925779903205;16077.598060048593;16309.347626095061;16502.917485412498;16510.33958641665;16896.915515422344;504583;733584;753904;753936;756376;54602.18096728552;54768.45231547634;55107.72446137824;55216.44783552193;55234.447655523734;1187.4385183483691;1213.8422005139275;1217.549506682533;1276.2725246609343;1309.3780454284138;28372.43255134927;32663.836680816443;32760.508592370657;33060.1734956628;33391;47719.61401929959;47786.28320575125;48045.75977120092;48623;48636.27045594389;375742;380718;383319;383602;383905;24282.392940176636;26487.470250594495;26677.333066673487;26880.73119268782;27448.941329400775;40867.59132408757;41104;41599.16801663889;42161.36757948695;42457.1508569833;39960;40687.38968915528;40814.59185408227;40823.38764918588;40917.59082409257;40136.59863401445;40498.797506012284;40591.79704101461;40981.59018409897;41009.38485922654;39525.80237098796;39608.40587391249;40791.79604102079;40973;41044.79477602712;33768;35789.64210357863;36038.27923441569;36185.81907090448;36457.45313820348;27675.308117296423;27820.721792781813;28116.156515304574;28167.859160704065;28179.577306340012 10:55:33 INFO - PROCESS | 23131 | |2;jquery.html;374.10402087001614;375.56809668880794;387.1328224776501;394.22928175417064;395.8673844262172;14137.505187318446;16554.7516787248;17364.21861016254;18871.622567548657;18915;16372.508824735247;16542.83457165428;16578.917105414486;16737.079460629662;16846;5451.318585176853;5546.722663866791;5585.692786896719;5588.6646801192055;5592;4010.578889216634;4590.724556526602;5453.318335208099;6130.877382452349;6197.194364732601;6180.474659653934;6196.380361963813;6204.100405441209;6217.782377616784;6238.344973777756;5403.486668766481;5693.658380497183;5693.857653558653;5747.885042299173;5761.193432919353;5366.356037275552;5536.723163841792;5541.362743284493;5549.861253468655;5561.833145005657;12687.809682854764;13019.934900325532;20147.992600369922;20965.89517052405;21440.249591264386;2236.306744909067;2300.2524179641514;2449.0448724997264;2702.824271441929;2719.496169199867;9409;9430.387024843432;9449.574769135406;9799.412035277906;9870.555824987821;1887.4715079777684;1952.8828270303827;1964.3812199157219;1973.97039044413;2015.254355888316;53759.56507236346;59395;66857;77666;77997.22002779956;9333.766655833659;10101.242406819518;10176.898231017743;10395;10650.147988160928;14016.299185040707;14127.223002734743;14207.715845683235;14215.218163001135;14223.28883555818;7409.296116868996;7513.812154696067;7551.131619863676;7575.848483030309;7706.075270967408;7131.465140114408;7164;7205.351518363373;7338.302861228175;7402.037735094511;4419.690621656453;4424.911501769947;4433.091216300651;4433.135538569948;4460.9107817844115;1753.2986805277735;1874.5407375193165;1908.2462427341122;1928.4407521818516;1949.2787668562723;844.6030365728097;933.3793027636682;958.4393130019017;961.4471678784727;998.0618218874235;17099.23053462597;17176.39882604103;17234.138293085296;17405.390811321544;17631.118444077743;922.796984663373;930.5440334236175;949.6533765175661;950.7242899559188;963.4989805301344;9302.25581953442;9657;9807.117359437541;9832.311738178401;9937.403755774676;452136;485375.7312134379;486983;487246;488587;91943.5402822995;93755.53122234481;94678.5266073679;95136.52431737936;95458;835.8286551256978;918.2149262380702;922.3082687984012;943.9575219115156;952.936891629628;15968.201589920225;16059.188874866813;16115.435959741822;16720;16887.493375198763;39971;41539.7923010383;41581.37627935523;41745;41925;54038.45961540334;55625.721871392;62269;62440.37559624527;63514;7441.776746697607;7673.309402153833;7729.1884352142215;7836.960815195887;8125.715599953974;12352.876471235173;12726.618201453972;12858.292793896051;13091.345432728516;13270.270135142273;10196.235282354002;10394.948025259826;10647.574097036031;10761.354318740587;11204.271722338022;5531.280933478622;10106.797864042532;10836.187285953743;10976.682798064283;11533.423328833693;11061.170412218955;11186;11686.357250351311;11726.589569365031;12109.757804843677;7595.468317217963;7651.1583725789005;7695.422843286664;7704.383649308154;7854.4894581851995;11162.274452160584;11273.098152147972;11491.138164637852;11621.883781162418;11931.284122952304 10:55:33 INFO - PROCESS | 23131 | |3;mootools.html;1145.3872178384565;1329.9069065165438;1401.7546929287375;1406.1633328169742;1578.7552929295955;8119.594020298983;8434.325253979674;8456.365772567051;8723.47659140452;8748.518831464267;8502;8690.17443342883;8704.695335663253;8708.12918708129;8723.302135829133;2023.1300540767463;2243.8204943604474;2287;2318.038014224095;2339.4619237575366;2336.918207862725;2345.659879317498;2346.4251258441705;2347;2349.659299401594;2290.7365652949875;2298.5517824024237;2316.895739691718;2323.1984965187066;2324.604817181075;1940.6797878350055;2191.802737753594;2210.491586934998;2256.2892688802976;2259.1415262200258;2260.954780904373;2296.78180572847;2318.188633978111;2319.617263151578;2319.814414846808;8686.478811271343;8736.301095912375;8757.168069033432;8815.206631403205;8831;5135.255387968761;5277.683338999673;5285.497877701612;5286.04851126797;5292.788288468457;3275.2958114005364;3287.8027318360973;3341.2315167511365;3425.743069269815;3451.2752322012407;1077.0898590690854;1081.864766904137;1116.112690411117;1122.0798944865214;1125.58915995661;12764.234145951179;12781.041421893395;12827.422765975554;12830.743385132246;12831;4368.213721530092;4501.504834468271;4516.051629157913;4543.409356783597;4548.499665036843;10661;10724.356538607708;10742.731431714114;10751.516181771683;10753.56985720578;5093;5176.922346164811;5181.093308671043;5185.714785686748;5199.064168449715;4200.285951388271;4708.176069187878;4805.27920811881;4836.613070954315;4909.361782968263;3794.3359912015285;3923.372260438316;3931.76409415436;3962.7424217425773;4005.2189822984237;1214.7813393589238;1219.591436868659;1231.612042206702;1232.8212409200617;1244.2596654990266;788.9900926813573;801.7554645833077;833.8624127019095;949.1315446366635;981.455292312759;5893.322267939242;5932.673702946379;5958.821235362946;5963.016102343065;6052.878942421127;901.2114399900088;916.6470908700198;945.9574319155655;964.9035096490295;1000.0599436529784;3852.768833869977;4109.856155034559;4158.91682166355;4183.790810459464;4190;11210.551577936954;11414.258073225214;11425.485853136463;11578.536858525733;11579.247348922294;11382.715432114263;11390.316581005001;11398.088152947745;11402;11427.828582571268;7763.61181940912;8056.113827478973;8087.676492940334;8124.878126828103;8231.218034286732;5980.102984552352;6080.361562035922;6161.44546990755;6186.412290832363;6238.500919926304;10073.445960472245;10448.68653940383;10529.526171322463;10540.841887371542;10693.89306106929;10512.78974420492;10708.196885233483;10716.410597417216;10736.141108711128;10756.946215268874;6902.8619427610165;7511.812204694707;7671.961640191764;7680.923190768244;7842.333401660922;8439.49363038195;8449.619767110371;8491.320694344315;8508.532030738368;8511.787205319917;7457.776266712007;7667.578283194478;7718.382529397747;7727.961360193163;7737.264959828807;7383.372413344926;7388.335049845539;7481.58851263164;7514.699412023677;7712.113106992543;6631;6684.665766711742;6722.764703235363;6724.663766811542;6748.561343512656;4718;4912.852614421573;4954.405471343462;5115.693058416507;5297.390800058042;5246.422893481637;5279.344949822849;5284.418713941386;5354.919676204782;5424.5660347172925 10:55:33 INFO - PROCESS | 23131 | |4;prototype.html;322.8740791091473;325.41587849809594;330.5867665418227;331.68324250340925;333.25849983786077;5216.5565926896215;5255.842324730264;5284.207368894663;5334.466553344663;5335.599830012745;5163.922541161885;5232.686038837673;5234.30433326837;5241.663375839165;5246.449122842104;3948.9012774680646;3989.4015897615445;4124.711270211086;4154.31453810121;4159.854405095823;4116.682661548306;4154.43915071466;4158.08522125132;4165.520965089008;4179;3955.71439282233;4073.775942323171;4090.877273681794;4110.869510884516;4120.629143377096;3917.941230881539;4033.657139143176;4079.551249362568;4093.16090201508;4109.157622687342;3573.2317551726505;3596.2088340565033;3612.259486805199;3618.8106195751457;3626.1478552540134;5023.799048038074;5024.572911302544;5029.5724863386295;5062.215356619729;5066.898662026776;4484.609770971009;4630.8147674093;4653.789450011252;4655.556777399017;4673.95326046742;5418.539424148952;5430.8370748877205;5436.510714035756;5451.754671039813;5481.972590137024;3914.3950980098025;3940.783256920868;3944.6055394460614;3952.980235098806;3971.1660551284267;5551.1673249012565;5603.571089372224;5604.355499117572;5662.348829884533;5701.828945131652;3981.2634662586934;3998.6401223889407;4018.6383225509844;4021.356582946773;4031.657309128698;4042.333015052542;4059.9594004060173;4082.652974497201;4087.3051581230666;4106.425100485934;4405.515393306734;4637.1421287062;4665.996810685719;4676.719396836201;4679.625629949596;5483;5501.889962200734;5521.668699878021;5525.502704756591;5549.889002219933;1370.2737549098993;1402.4670625162373;1404.9578512644637;1410.7601707709714;1414.801927730098;895.552223888056;899.6986009686829;927.6474939522938;940.9106134917172;947.1522986926662;5234.246527413359;5267.841964741064;5278.97360513195;5280.577553795687;5310.6813591184655;5563.193336966117;5579.358373787067;5581.413951535031;5634.661920284796;5639.097744360883;5076.314697515788;5245.186996015624;5311.814086506954;5318.680879147263;5322.14845624706;2972.7621790256726;2987.4025194961096;3001.1446737680094;3002.174402039413;3005.5792189093545;5539.947409992089;5753.4534219249945;5760.683162426107;5761.654300741969;5789.363170051291;5664.279078131117;5669;5684.8010319638615;5714.514266287412;5717.885642287214;5739.282589676291;5748.885022299531;5761.802199779163;5806.622569532967;5834.124881267844;5210.192420174879;5554.833484968202;5569.303837020372;5571.4428557143965;5605.49550540437;5512.751926163252;5520.647441376888;5524.685188886636;5526.281583394133;5570.192322113352;5708.57185711065;5808.39011903744;5836.402800753794;5841.707914604338;5865.912011319749;3753.887383378503;3950.861719839792;4012.5586185520156;4030.5087117766616;4054.108096218827;5640.477071190838;5654.095344744821;5682.147677848356;5702.45826646468;5722.5135863450405;5318.867028324323;5549.722513874371;5551.417101204315;5553.583481238842;5574.944250557604;5480.780768769205;5481.123020316731;5496.7526461308535;5499.285092937893;5506.752196151263;5233.685978841282;5325.440828712929;5384.461553844741;5399.461153571214;5431.452036169672;5539.750711217925;5567.749451274622;5604.243427137284;5610.242617246783;5622.437756224344;5404.59465540094;5449.1826226066405;5465.207544906046;5480.890382192413;5493.335732169815 10:55:33 INFO - PROCESS | 23131 | |5;yui.html;652.8498445357568;717.5443593318244;744.3896005275676;744.9553026818392;754.7886591754311;13458.1925084495;13850.307484625766;14206.147631142112;14280.857191428096;14291.356888939996;12263.570775022876;12324.507019719224;12355.567555135573;12356.691082722937;12362.752744945119;566.4562020460353;577.7602295047571;581.1428143488363;581.2995340614549;582.5427039773779;691.7060249394012;698.6367089113658;703.7607213547393;704.9577025378494;705.2277755857353;613.6563524426314;613.7054213977293;615.3477314047125;615.8337248942782;616.100493279812;637.5314144104079;644.40392636811;646.8124243969244;648.2253706820352;661.963592002442;453.66202179376245;459.04518601309195;459.9880263420455;460.6729222252205;467.6445901115177;12689.809652855214;12705.301208433533;12709.618711438672;12730.80903786444;12735.23588584688;12061.396930153458;12071.879281207164;12319.753604927851;12660.68348291291;13144.474221031147;10353.223508236912;10390.584376624925;10459.529321180566;10491.16070714341;10647.414392208426;3725.6833169180654;3739.8691045813266;3744.606816284278;3794.6774524165203;3850.5956874528333;56737.43262567404;57386;58473.12290315649;60057;60288;9591.184749296248;9755.073268039525;9762.267829912786;9982.850257246148;10016.176059431937;15737.213139342986;15747.44883929057;15785.158671439021;16650.75023874643;17144.742828857576;7933.3653307736395;7972.2824945754;8131;8216.794580135544;8545.74362769118;4610.654200934943;4723.858284251478;4729.55069268419;4850.902981940412;4912.38595175603;3047.2534229113567;3169.1918560767317;3197.600299962505;3249.8212598306845;3259.08745551246;569.6724383479516;601.1433706967641;608.8630058236861;610.185402487675;616.8149555133532;534.2067030459764;540.7485519233496;615.9045347971072;663.3896814930275;665.3878431842717;9036.728898133066;9207.013349272736;9384.155426011692;9404.529773511296;9654.179394751385;664.817175276793;668.1014036121409;686.6669665212368;694.9583025018516;743.1973468653841;4172.499300083949;4291.420658211164;4298.505671847715;4396.868093957187;4432.401625780542;71266.64366678237;73346.26653733502;74623;75498.24501755022;75774.24225757782;46338;61220;63754.362456374845;65924;67853.32146678568;55452.72273638606;56800.43199568034;57652.71173644189;58316;58757.70621146867;9009.414388064755;9092.944905870565;9161.816763664823;9201.30990175726;9239.353245272767;36531;36701.26597468089;37269.440958386185;37663.246735065695;37766.62233377631;45977;46263;49096.509034910625;50624.240636389746;51087.2336914954;11288.972951026744;11420.771584568096;11648.301101933912;11886.227395219283;12073.75852482963;13067.542636007694;13439.395227214603;13529.255890926093;13711.382987765774;14107;10735.302205356627;11146.331220126818;11892.940535297268;12423.458365820317;12426.440810163745;10185.388876667424;10245;10315.638952636622;10549.156067514734;10960.123190144928;11683.474243659226;11752.177347585586;12104.273743575413;12147.088968327587;12157.939210303892;9890.208783297176;10051.849222261526;10067.496625168858;10164.796704066026;10387.53256103462;10075.647352342632;10222.182225422097;10229.59081636756;10419.479026048819;10563.912015419073 10:55:33 INFO - PROCESS | 23131 | __end_tp_report 10:55:33 INFO - PROCESS | 23131 | __start_cc_report 10:55:33 INFO - PROCESS | 23131 | _x_x_mozilla_cycle_collect,956 10:55:33 INFO - PROCESS | 23131 | __end_cc_report 10:55:33 INFO - PROCESS | 23131 | __startTimestamp1464198933183__endTimestamp 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | ------- Summary: start ------- 10:55:33 INFO - PROCESS | 23131 | Number of tests: 6 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#0] dojo.html Cycles:165 Average:5348.75 Median:5591.47 stddev:622.07 (11.1%) stddev-sans-first:597.53 10:55:33 INFO - PROCESS | 23131 | Values: 3061.2 3073.2 3096.3 3111.9 3129.6 5245.2 5268.1 5351.3 5359.4 5373.3 5289.5 5293.3 5346.3 5367.7 5432.9 4771.4 4850.8 4864.8 4865.4 5049.4 4904.5 4969.4 4999.4 5016.2 5030.8 4633.6 4757.7 4796.1 4807.9 4821.4 4822.7 4831.8 4885.8 4899.9 4932.7 4715.5 4897.2 4911.5 4920.6 4951.7 5256.6 5336.1 5340.1 5400.8 5420.6 5816.5 5828.0 5845.1 5857.7 5878.2 5637.2 5704.1 5816.2 5883.8 5885.8 5380.9 5464.6 5472.6 5478.1 5480.7 5917.5 5922.6 5962.5 5976.5 5988.1 5444.6 5546.4 5583.3 5666.6 5681.8 5757.4 5763.4 5795.0 5808.5 5811.1 5720.0 5748.2 5753.8 5762.3 5769.0 5507.8 5594.9 5653.9 5658.9 5761.2 4364.2 4368.3 4373.4 4375.2 4419.7 3883.0 3891.3 3900.6 3935.2 3950.5 5249.7 5352.0 5394.4 5452.4 5455.5 5846.0 5848.9 5855.1 5874.9 5900.0 5497.5 5504.6 5506.5 5515.5 5519.0 4758.4 4902.6 4964.3 4971.2 5002.8 5951.5 5970.9 5974.1 5979.4 5983.0 5626.6 5772.5 5789.4 5796.4 5809.4 5822.8 5876.9 5899.7 5990.8 5994.0 5588.3 5631.8 5640.7 5643.7 5644.7 5721.8 5759.5 5791.7 5802.8 5806.2 5391.9 5643.7 5707.5 5716.1 5719.9 5637.1 5665.7 5667.5 5715.5 5722.5 5395.8 5641.6 5645.9 5647.9 5655.5 5641.9 5643.7 5649.4 5714.8 5717.3 5591.5 5594.5 5615.1 5621.9 5632.1 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#1] ext.html Cycles:180 Average:59001.93 Median:40882.80 stddev:130092.21 (318.2%) stddev-sans-first:130383.24 10:55:33 INFO - PROCESS | 23131 | Values: 594.3 631.9 639.0 648.4 659.4 40988.8 42977.6 43021.6 46259.1 46356.5 42419.4 43217.0 43376.8 43396.6 43627.3 8531.0 8656.1 8716.0 8729.7 8730.0 8651.2 8727.6 8766.2 8777.3 8778.8 8745.7 8794.1 8804.4 8805.2 8813.0 8740.2 8741.3 8758.8 8769.6 8789.6 8428.4 8487.4 8493.4 8501.9 8518.5 40580.6 40780.2 40810.0 40898.0 41002.8 3100.7 3564.3 3882.2 3896.9 3971.4 31763.0 31927.4 32035.0 32085.8 32575.7 4178.2 4361.8 4371.7 4385.5 4475.6 233128.0 234059.0 234405.0 234920.0 235481.0 48104.5 48289.3 48773.8 48876.0 48909.8 58961.4 59052.0 59100.7 59164.4 59222.0 14675.6 14703.8 14782.9 14787.1 14807.6 11650.9 11707.0 11711.8 11747.1 11769.4 16927.4 17269.9 17274.3 17330.4 17386.7 6007.8 6010.6 6030.4 6047.7 6189.2 801.4 802.8 992.7 1042.3 1063.8 29146.9 29645.4 29808.3 30373.8 30464.4 1050.3 1068.6 1120.3 1128.5 1169.3 16077.6 16309.3 16502.9 16510.3 16896.9 504583.0 733584.0 753904.0 753936.0 756376.0 54602.2 54768.5 55107.7 55216.4 55234.4 1187.4 1213.8 1217.5 1276.3 1309.4 28372.4 32663.8 32760.5 33060.2 33391.0 47719.6 47786.3 48045.8 48623.0 48636.3 375742.0 380718.0 383319.0 383602.0 383905.0 24282.4 26487.5 26677.3 26880.7 27448.9 40867.6 41104.0 41599.2 42161.4 42457.2 39960.0 40687.4 40814.6 40823.4 40917.6 40136.6 40498.8 40591.8 40981.6 41009.4 39525.8 39608.4 40791.8 40973.0 41044.8 33768.0 35789.6 36038.3 36185.8 36457.5 27675.3 27820.7 28116.2 28167.9 28179.6 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#2] jquery.html Cycles:180 Average:27771.27 Median:244983.23 stddev:79219.89 (32.3%) stddev-sans-first:79415.42 10:55:33 INFO - PROCESS | 23131 | Values: 374.1 375.6 387.1 394.2 395.9 14137.5 16554.8 17364.2 18871.6 18915.0 16372.5 16542.8 16578.9 16737.1 16846.0 5451.3 5546.7 5585.7 5588.7 5592.0 4010.6 4590.7 5453.3 6130.9 6197.2 6180.5 6196.4 6204.1 6217.8 6238.3 5403.5 5693.7 5693.9 5747.9 5761.2 5366.4 5536.7 5541.4 5549.9 5561.8 12687.8 13019.9 20148.0 20965.9 21440.2 2236.3 2300.3 2449.0 2702.8 2719.5 9409.0 9430.4 9449.6 9799.4 9870.6 1887.5 1952.9 1964.4 1974.0 2015.3 53759.6 59395.0 66857.0 77666.0 77997.2 9333.8 10101.2 10176.9 10395.0 10650.1 14016.3 14127.2 14207.7 14215.2 14223.3 7409.3 7513.8 7551.1 7575.8 7706.1 7131.5 7164.0 7205.4 7338.3 7402.0 4419.7 4424.9 4433.1 4433.1 4460.9 1753.3 1874.5 1908.2 1928.4 1949.3 844.6 933.4 958.4 961.4 998.1 17099.2 17176.4 17234.1 17405.4 17631.1 922.8 930.5 949.7 950.7 963.5 9302.3 9657.0 9807.1 9832.3 9937.4 452136.0 485375.7 486983.0 487246.0 488587.0 91943.5 93755.5 94678.5 95136.5 95458.0 835.8 918.2 922.3 944.0 952.9 15968.2 16059.2 16115.4 16720.0 16887.5 39971.0 41539.8 41581.4 41745.0 41925.0 54038.5 55625.7 62269.0 62440.4 63514.0 7441.8 7673.3 7729.2 7837.0 8125.7 12352.9 12726.6 12858.3 13091.3 13270.3 10196.2 10394.9 10647.6 10761.4 11204.3 5531.3 10106.8 10836.2 10976.7 11533.4 11061.2 11186.0 11686.4 11726.6 12109.8 7595.5 7651.2 7695.4 7704.4 7854.5 11162.3 11273.1 11491.1 11621.9 11931.3 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#3] mootools.html Cycles:180 Average:5823.68 Median:4545.95 stddev:3420.47 (75.2%) stddev-sans-first:3412.00 10:55:33 INFO - PROCESS | 23131 | Values: 1145.4 1329.9 1401.8 1406.2 1578.8 8119.6 8434.3 8456.4 8723.5 8748.5 8502.0 8690.2 8704.7 8708.1 8723.3 2023.1 2243.8 2287.0 2318.0 2339.5 2336.9 2345.7 2346.4 2347.0 2349.7 2290.7 2298.6 2316.9 2323.2 2324.6 1940.7 2191.8 2210.5 2256.3 2259.1 2261.0 2296.8 2318.2 2319.6 2319.8 8686.5 8736.3 8757.2 8815.2 8831.0 5135.3 5277.7 5285.5 5286.0 5292.8 3275.3 3287.8 3341.2 3425.7 3451.3 1077.1 1081.9 1116.1 1122.1 1125.6 12764.2 12781.0 12827.4 12830.7 12831.0 4368.2 4501.5 4516.1 4543.4 4548.5 10661.0 10724.4 10742.7 10751.5 10753.6 5093.0 5176.9 5181.1 5185.7 5199.1 4200.3 4708.2 4805.3 4836.6 4909.4 3794.3 3923.4 3931.8 3962.7 4005.2 1214.8 1219.6 1231.6 1232.8 1244.3 789.0 801.8 833.9 949.1 981.5 5893.3 5932.7 5958.8 5963.0 6052.9 901.2 916.6 946.0 964.9 1000.1 3852.8 4109.9 4158.9 4183.8 4190.0 11210.6 11414.3 11425.5 11578.5 11579.2 11382.7 11390.3 11398.1 11402.0 11427.8 7763.6 8056.1 8087.7 8124.9 8231.2 5980.1 6080.4 6161.4 6186.4 6238.5 10073.4 10448.7 10529.5 10540.8 10693.9 10512.8 10708.2 10716.4 10736.1 10756.9 6902.9 7511.8 7672.0 7680.9 7842.3 8439.5 8449.6 8491.3 8508.5 8511.8 7457.8 7667.6 7718.4 7728.0 7737.3 7383.4 7388.3 7481.6 7514.7 7712.1 6631.0 6684.7 6722.8 6724.7 6748.6 4718.0 4912.9 4954.4 5115.7 5297.4 5246.4 5279.3 5284.4 5354.9 5424.6 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#4] prototype.html Cycles:180 Average:4616.84 Median:5297.44 stddev:1355.73 (25.6%) stddev-sans-first:1320.67 10:55:33 INFO - PROCESS | 23131 | Values: 322.9 325.4 330.6 331.7 333.3 5216.6 5255.8 5284.2 5334.5 5335.6 5163.9 5232.7 5234.3 5241.7 5246.4 3948.9 3989.4 4124.7 4154.3 4159.9 4116.7 4154.4 4158.1 4165.5 4179.0 3955.7 4073.8 4090.9 4110.9 4120.6 3917.9 4033.7 4079.6 4093.2 4109.2 3573.2 3596.2 3612.3 3618.8 3626.1 5023.8 5024.6 5029.6 5062.2 5066.9 4484.6 4630.8 4653.8 4655.6 4674.0 5418.5 5430.8 5436.5 5451.8 5482.0 3914.4 3940.8 3944.6 3953.0 3971.2 5551.2 5603.6 5604.4 5662.3 5701.8 3981.3 3998.6 4018.6 4021.4 4031.7 4042.3 4060.0 4082.7 4087.3 4106.4 4405.5 4637.1 4666.0 4676.7 4679.6 5483.0 5501.9 5521.7 5525.5 5549.9 1370.3 1402.5 1405.0 1410.8 1414.8 895.6 899.7 927.6 940.9 947.2 5234.2 5267.8 5279.0 5280.6 5310.7 5563.2 5579.4 5581.4 5634.7 5639.1 5076.3 5245.2 5311.8 5318.7 5322.1 2972.8 2987.4 3001.1 3002.2 3005.6 5539.9 5753.5 5760.7 5761.7 5789.4 5664.3 5669.0 5684.8 5714.5 5717.9 5739.3 5748.9 5761.8 5806.6 5834.1 5210.2 5554.8 5569.3 5571.4 5605.5 5512.8 5520.6 5524.7 5526.3 5570.2 5708.6 5808.4 5836.4 5841.7 5865.9 3753.9 3950.9 4012.6 4030.5 4054.1 5640.5 5654.1 5682.1 5702.5 5722.5 5318.9 5549.7 5551.4 5553.6 5574.9 5480.8 5481.1 5496.8 5499.3 5506.8 5233.7 5325.4 5384.5 5399.5 5431.5 5539.8 5567.7 5604.2 5610.2 5622.4 5404.6 5449.2 5465.2 5480.9 5493.3 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - PROCESS | 23131 | [#5] yui.html Cycles:180 Average:15361.43 Median:25436.83 stddev:19506.80 (76.7%) stddev-sans-first:19530.25 10:55:33 INFO - PROCESS | 23131 | Values: 652.8 717.5 744.4 745.0 754.8 13458.2 13850.3 14206.1 14280.9 14291.4 12263.6 12324.5 12355.6 12356.7 12362.8 566.5 577.8 581.1 581.3 582.5 691.7 698.6 703.8 705.0 705.2 613.7 613.7 615.3 615.8 616.1 637.5 644.4 646.8 648.2 662.0 453.7 459.0 460.0 460.7 467.6 12689.8 12705.3 12709.6 12730.8 12735.2 12061.4 12071.9 12319.8 12660.7 13144.5 10353.2 10390.6 10459.5 10491.2 10647.4 3725.7 3739.9 3744.6 3794.7 3850.6 56737.4 57386.0 58473.1 60057.0 60288.0 9591.2 9755.1 9762.3 9982.9 10016.2 15737.2 15747.4 15785.2 16650.8 17144.7 7933.4 7972.3 8131.0 8216.8 8545.7 4610.7 4723.9 4729.6 4850.9 4912.4 3047.3 3169.2 3197.6 3249.8 3259.1 569.7 601.1 608.9 610.2 616.8 534.2 540.7 615.9 663.4 665.4 9036.7 9207.0 9384.2 9404.5 9654.2 664.8 668.1 686.7 695.0 743.2 4172.5 4291.4 4298.5 4396.9 4432.4 71266.6 73346.3 74623.0 75498.2 75774.2 46338.0 61220.0 63754.4 65924.0 67853.3 55452.7 56800.4 57652.7 58316.0 58757.7 9009.4 9092.9 9161.8 9201.3 9239.4 36531.0 36701.3 37269.4 37663.2 37766.6 45977.0 46263.0 49096.5 50624.2 51087.2 11289.0 11420.8 11648.3 11886.2 12073.8 13067.5 13439.4 13529.3 13711.4 14107.0 10735.3 11146.3 11892.9 12423.5 12426.4 10185.4 10245.0 10315.6 10549.2 10960.1 11683.5 11752.2 12104.3 12147.1 12157.9 9890.2 10051.8 10067.5 10164.8 10387.5 10075.6 10222.2 10229.6 10419.5 10563.9 10:55:33 INFO - PROCESS | 23131 | -------- Summary: end -------- 10:55:33 INFO - PROCESS | 23131 | 10:55:33 INFO - TEST-INFO | 23131: exit 0 10:55:33 INFO - TEST-OK | dromaeo_css | took 1112778ms 10:55:33 INFO - TEST-START | kraken 10:55:33 INFO - operating with platform_type : linux_ 10:55:33 INFO - Initialising browser for kraken test... 10:55:33 INFO - TEST-INFO | started process 23306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU4eDes/profile http://localhost:45112/getInfo.html) 10:55:37 INFO - PROCESS | 23306 | __metrics Screen width/height:1600/1200 10:55:37 INFO - PROCESS | 23306 | colorDepth:24 10:55:37 INFO - PROCESS | 23306 | Browser inner width/height: 1024/697 10:55:37 INFO - PROCESS | 23306 | __metrics 10:55:38 ERROR - PROCESS | 23306 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:55:39 INFO - TEST-INFO | 23306: exit 0 10:55:39 INFO - Browser initialized. 10:55:39 INFO - Running cycle 1/1 for kraken test... 10:55:39 INFO - TEST-INFO | started process 23387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU4eDes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:51 INFO - PROCESS | 23387 | RSS: Main: 153477120 10:55:51 INFO - PROCESS | 23387 | 10:55:54 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45112/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:55 INFO - PROCESS | 23387 | RSS: Main: 209457152 10:55:55 INFO - PROCESS | 23387 | 10:55:57 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45112/tests/kraken/driver.html?testName=audio-dft) 10:55:58 INFO - PROCESS | 23387 | RSS: Main: 196452352 10:55:58 INFO - PROCESS | 23387 | 10:56:01 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45112/tests/kraken/driver.html?testName=audio-fft) 10:56:02 INFO - PROCESS | 23387 | RSS: Main: 265986048 10:56:02 INFO - PROCESS | 23387 | 10:56:04 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45112/tests/kraken/driver.html?testName=audio-oscillator) 10:56:04 INFO - PROCESS | 23387 | RSS: Main: 174886912 10:56:04 INFO - PROCESS | 23387 | 10:56:07 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:07 INFO - PROCESS | 23387 | RSS: Main: 179269632 10:56:07 INFO - PROCESS | 23387 | 10:56:10 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45112/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:11 INFO - PROCESS | 23387 | RSS: Main: 215195648 10:56:11 INFO - PROCESS | 23387 | 10:56:14 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45112/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:15 INFO - PROCESS | 23387 | RSS: Main: 215887872 10:56:15 INFO - PROCESS | 23387 | 10:56:18 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45112/tests/kraken/driver.html?testName=json-parse-financial) 10:56:18 INFO - PROCESS | 23387 | RSS: Main: 216735744 10:56:18 INFO - PROCESS | 23387 | 10:56:20 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:20 INFO - PROCESS | 23387 | RSS: Main: 208736256 10:56:20 INFO - PROCESS | 23387 | 10:56:22 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:56:23 INFO - PROCESS | 23387 | RSS: Main: 205807616 10:56:23 INFO - PROCESS | 23387 | 10:56:25 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:56:26 INFO - PROCESS | 23387 | RSS: Main: 216174592 10:56:26 INFO - PROCESS | 23387 | 10:56:28 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:29 INFO - PROCESS | 23387 | RSS: Main: 224481280 10:56:29 INFO - PROCESS | 23387 | 10:56:31 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:56:32 INFO - PROCESS | 23387 | RSS: Main: 220430336 10:56:32 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | Cycle 1(1): loaded http://localhost:45112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45112/tests/kraken/driver.html?testName=ai-astar) 10:56:34 INFO - PROCESS | 23387 | RSS: Main: 266145792 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | __start_tp_report 10:56:34 INFO - PROCESS | 23387 | _x_x_mozilla_page_load 10:56:34 INFO - PROCESS | 23387 | _x_x_mozilla_page_load_details 10:56:34 INFO - PROCESS | 23387 | |i|pagename|runs| 10:56:34 INFO - PROCESS | 23387 | |0;ai-astar;112;107;113;110;110;111;114;111;111;111 10:56:34 INFO - PROCESS | 23387 | |1;audio-beat-detection;159;125;127;180;129;139;157;126;158;125 10:56:34 INFO - PROCESS | 23387 | |2;audio-dft;161;161;161;162;162;162;163;161;163;162 10:56:34 INFO - PROCESS | 23387 | |3;audio-fft;76;76;77;111;76;76;75;75;98;76 10:56:34 INFO - PROCESS | 23387 | |4;audio-oscillator;84;84;131;83;85;84;122;84;85;134 10:56:34 INFO - PROCESS | 23387 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;116 10:56:34 INFO - PROCESS | 23387 | |6;imaging-darkroom;146;147;146;146;148;146;146;146;146;146 10:56:34 INFO - PROCESS | 23387 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 10:56:34 INFO - PROCESS | 23387 | |8;json-parse-financial;57;56;56;56;56;58;55;81;54;54 10:56:34 INFO - PROCESS | 23387 | |9;json-stringify-tinderbox;61;62;64;62;63;63;62;63;62;63 10:56:34 INFO - PROCESS | 23387 | |10;stanford-crypto-aes;80;80;81;80;80;81;80;81;82;81 10:56:34 INFO - PROCESS | 23387 | |11;stanford-crypto-ccm;125;122;135;117;118;121;120;120;162;124 10:56:34 INFO - PROCESS | 23387 | |12;stanford-crypto-pbkdf2;163;162;160;160;158;171;161;161;163;158 10:56:34 INFO - PROCESS | 23387 | |13;stanford-crypto-sha256-iterative;63;62;63;66;65;68;64;64;61;62 10:56:34 INFO - PROCESS | 23387 | __end_tp_report 10:56:34 INFO - PROCESS | 23387 | __start_cc_report 10:56:34 INFO - PROCESS | 23387 | _x_x_mozilla_cycle_collect,1641 10:56:34 INFO - PROCESS | 23387 | __end_cc_report 10:56:34 INFO - PROCESS | 23387 | __startTimestamp1464198994375__endTimestamp 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | ------- Summary: start ------- 10:56:34 INFO - PROCESS | 23387 | Number of tests: 14 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:1.96 10:56:34 INFO - PROCESS | 23387 | Values: 112.0 107.0 113.0 110.0 110.0 111.0 114.0 111.0 111.0 111.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.00 stddev:19.57 (13.2%) stddev-sans-first:19.83 10:56:34 INFO - PROCESS | 23387 | Values: 159.0 125.0 127.0 180.0 129.0 139.0 157.0 126.0 158.0 125.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:56:34 INFO - PROCESS | 23387 | Values: 161.0 161.0 161.0 162.0 162.0 162.0 163.0 161.0 163.0 162.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.47 (16.4%) stddev-sans-first:13.06 10:56:34 INFO - PROCESS | 23387 | Values: 76.0 76.0 77.0 111.0 76.0 76.0 75.0 75.0 98.0 76.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:84.00 stddev:21.87 (26.0%) stddev-sans-first:22.64 10:56:34 INFO - PROCESS | 23387 | Values: 84.0 84.0 131.0 83.0 85.0 84.0 122.0 84.0 85.0 134.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:56:34 INFO - PROCESS | 23387 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:56:34 INFO - PROCESS | 23387 | Values: 146.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 146.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:56:34 INFO - PROCESS | 23387 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:56.00 stddev:8.07 (14.4%) stddev-sans-first:8.55 10:56:34 INFO - PROCESS | 23387 | Values: 57.0 56.0 56.0 56.0 56.0 58.0 55.0 81.0 54.0 54.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 10:56:34 INFO - PROCESS | 23387 | Values: 61.0 62.0 64.0 62.0 63.0 63.0 62.0 63.0 62.0 63.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 10:56:34 INFO - PROCESS | 23387 | Values: 80.0 80.0 81.0 80.0 80.0 81.0 80.0 81.0 82.0 81.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:123.00 stddev:13.49 (11.0%) stddev-sans-first:14.30 10:56:34 INFO - PROCESS | 23387 | Values: 125.0 122.0 135.0 117.0 118.0 121.0 120.0 120.0 162.0 124.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.50 stddev:3.71 (2.3%) stddev-sans-first:3.91 10:56:34 INFO - PROCESS | 23387 | Values: 163.0 162.0 160.0 160.0 158.0 171.0 161.0 161.0 163.0 158.0 10:56:34 INFO - PROCESS | 23387 | 10:56:34 INFO - PROCESS | 23387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:2.10 (3.3%) stddev-sans-first:2.20 10:56:34 INFO - PROCESS | 23387 | Values: 63.0 62.0 63.0 66.0 65.0 68.0 64.0 64.0 61.0 62.0 10:56:34 INFO - PROCESS | 23387 | -------- Summary: end -------- 10:56:34 INFO - PROCESS | 23387 | 10:56:35 INFO - TEST-INFO | 23387: exit 0 10:56:35 INFO - TEST-OK | kraken | took 61593ms 10:56:35 INFO - SUITE-END | took 1174s 10:56:35 INFO - Completed test suite (00:19:34) 10:56:35 INFO - javascript benchmark 10:56:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.234691327168, 3073.200967748385, 3096.349766549024, 3111.92220194495, 3129.5775070365507, 5245.213218017299, 5268.0517506848755, 5351.331083614548, 5359.35687717474, 5373.301470808794, 5289.523942845143, 5293.311869456975, 5346.27825243592, 5367.677939323643, 5432.945670543293, 4771.379720636312, 4850.805967761303, 4864.805407783684, 4865.391826021747, 5049.4193167785625, 4904.5340692634145, 4969.4036715594, 4999.400071991348, 5016.172331565287, 5030.798768049273, 4633.582977532022, 4757.690750101232, 4796.136695394827, 4807.879803004917, 4821.397325334333, 4822.6624136310475, 4831.830885919011, 4885.755712214411, 4899.902001959977, 4932.679375840559, 4715.4577223619035, 4897.191963326047, 4911.484294149099, 4920.581750551208, 4951.727654978975, 5256.632035757499, 5336.06618841705, 5340.092184328634, 5400.83797486076, 5420.593455490854, 5816.505597024258, 5828.009238429435, 5845.123231515264, 5857.70711464425, 5878.177055212273, 5637.182608521783, 5704.1443783432405, 5816.243888294537, 5883.823485295406, 5885.793997210077, 5380.946190538084, 5464.590155738336, 5472.5621950243885, 5478.123500239943, 5480.671159730389, 5917.46742793142, 5922.644641321534, 5962.463378295887, 5976.491998180203, 5988.131720900532, 5444.564434845203, 5546.389897111315, 5583.330000399978, 5666.575006874501, 5681.801136960186, 5757.424257574293, 5763.394843541368, 5794.971025144931, 5808.535317174616, 5811.070228763378, 5719.971400142973, 5748.166515855178, 5753.827385178452, 5762.250907382014, 5769.048107062372, 5507.834764956978, 5594.944050559524, 5653.858653533694, 5658.886822263614, 5761.164631128463, 4364.236258654722, 4368.344748287782, 4373.387725718402, 4375.16871794358, 4419.734815911055, 3882.9611703883165, 3891.280113179071, 3900.6099390060767, 3935.1539419024475, 3950.5456872460036, 5249.737513124329, 5352.0, 5394.433584473652, 5452.372977107683, 5455.481729235717, 5845.970770146122, 5848.8537786554825, 5855.063189889597, 5874.882502349929, 5900.0264956281735, 5497.45025497447, 5504.614676972654, 5506.476884695948, 5515.531179849758, 5519.0, 4758.357621721093, 4902.632302577321, 4964.255361695702, 4971.229459433794, 5002.774875130628, 5951.4941229995065, 5970.850728731816, 5974.133750606138, 5979.402059793986, 5983.0, 5626.578006649435, 5772.480476757112, 5789.3921138279875, 5796.391378905323, 5809.448102430262, 5822.82531524055, 5876.911846322223, 5899.734511946886, 5990.760369585168, 5994.0409534474275, 5588.273524441796, 5631.831045068655, 5640.746166422438, 5643.661380317194, 5644.689542075061, 5721.828345149652, 5759.510441612342, 5791.710414479175, 5802.767889284381, 5806.2451881255165, 5391.919121213106, 5643.71781410936, 5707.543396528351, 5716.142578613241, 5719.914201286901, 5637.126245431965, 5665.66006039639, 5667.4615911488345, 5715.542756579547, 5722.484976352148, 5395.81114660985, 5641.576881733969, 5645.943540564542, 5647.915281270702, 5655.547556195412, 5641.887162256649, 5643.689597072201, 5649.435056494318, 5714.828555143353, 5717.285339332583, 5591.4688104629995, 5594.496495315441, 5615.073512870494, 5621.943780562142, 5632.098864181711], "value": 5305.8697163038005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.2957595249629, 631.9462845658118, 638.9808255831946, 648.4455790299294, 659.436182064335, 40988.79505602471, 42977.570224297786, 43021.56978430215, 46259.07481850361, 46356.536434635644, 42419.363709544305, 43217.0, 43376.78311608438, 43396.566034339725, 43627.3455898161, 8530.999999999984, 8656.091110433377, 8716.041235464094, 8729.694460693878, 8729.956350218272, 8651.178138076873, 8727.60725767342, 8766.211041006309, 8777.253933415668, 8778.780530486756, 8745.737627871174, 8794.12058794122, 8804.427712198718, 8805.16350946659, 8812.955935220347, 8740.21338079576, 8741.25699315559, 8758.781030474225, 8769.649214031431, 8789.604467798932, 8428.367872409593, 8487.40588158829, 8493.447925884859, 8501.914980850173, 8518.48889066658, 40580.59419405798, 40780.1843963122, 40810.0, 40898.0, 41002.79498602488, 3100.689931006904, 3564.315022108902, 3882.184741204322, 3896.883093507199, 3971.3645816669195, 31763.04710858678, 31927.361452771045, 32035.0, 32085.839570801996, 32575.674243257738, 4178.1643671265865, 4361.760103194323, 4371.6721245906365, 4385.539518350559, 4475.5748203920575, 233128.0, 234059.0, 234405.0, 234920.0, 235481.0, 48104.5189548107, 48289.27566086512, 48773.75613121912, 48876.0, 48909.75545122323, 58961.41038589559, 59052.0, 59100.70449647724, 59164.40835591589, 59222.0, 14675.633109172142, 14703.779443308358, 14782.926085369505, 14787.11277323364, 14807.555773326818, 11650.941745291218, 11707.0, 11711.824322635168, 11747.060235181165, 11769.352685602204, 16927.407540736014, 17269.913650431667, 17274.309027638752, 17330.39343622967, 17386.652266954843, 6007.8197654070445, 6010.639361638316, 6030.396960304022, 6047.697615119227, 6189.226346706661, 801.3669201330999, 802.7757669553977, 992.6575331510618, 1042.3172821801732, 1063.8138325792954, 29146.854265728958, 29645.407091858044, 29808.254793630334, 30373.84813075965, 30464.390712185632, 1050.3435352904435, 1068.636663534402, 1120.294214644785, 1128.4978184707727, 1169.2925779903205, 16077.598060048593, 16309.347626095061, 16502.917485412498, 16510.33958641665, 16896.915515422344, 504583.0, 733584.0, 753904.0, 753936.0, 756376.0, 54602.18096728552, 54768.45231547634, 55107.72446137824, 55216.44783552193, 55234.447655523734, 1187.4385183483691, 1213.8422005139275, 1217.549506682533, 1276.2725246609343, 1309.3780454284138, 28372.43255134927, 32663.836680816443, 32760.508592370657, 33060.1734956628, 33391.0, 47719.61401929959, 47786.28320575125, 48045.75977120092, 48623.0, 48636.27045594389, 375742.0, 380718.0, 383319.0, 383602.0, 383905.0, 24282.392940176636, 26487.470250594495, 26677.333066673487, 26880.73119268782, 27448.941329400775, 40867.59132408757, 41104.0, 41599.16801663889, 42161.36757948695, 42457.1508569833, 39960.0, 40687.38968915528, 40814.59185408227, 40823.38764918588, 40917.59082409257, 40136.59863401445, 40498.797506012284, 40591.79704101461, 40981.59018409897, 41009.38485922654, 39525.80237098796, 39608.40587391249, 40791.79604102079, 40973.0, 41044.79477602712, 33768.0, 35789.64210357863, 36038.27923441569, 36185.81907090448, 36457.45313820348, 27675.308117296423, 27820.721792781813, 28116.156515304574, 28167.859160704065, 28179.577306340012], "value": 19209.924383754573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.10402087001614, 375.56809668880794, 387.1328224776501, 394.22928175417064, 395.8673844262172, 14137.505187318446, 16554.7516787248, 17364.21861016254, 18871.622567548657, 18915.0, 16372.508824735247, 16542.83457165428, 16578.917105414486, 16737.079460629662, 16846.0, 5451.318585176853, 5546.722663866791, 5585.692786896719, 5588.6646801192055, 5592.0, 4010.578889216634, 4590.724556526602, 5453.318335208099, 6130.877382452349, 6197.194364732601, 6180.474659653934, 6196.380361963813, 6204.100405441209, 6217.782377616784, 6238.344973777756, 5403.486668766481, 5693.658380497183, 5693.857653558653, 5747.885042299173, 5761.193432919353, 5366.356037275552, 5536.723163841792, 5541.362743284493, 5549.861253468655, 5561.833145005657, 12687.809682854764, 13019.934900325532, 20147.992600369922, 20965.89517052405, 21440.249591264386, 2236.306744909067, 2300.2524179641514, 2449.0448724997264, 2702.824271441929, 2719.496169199867, 9409.0, 9430.387024843432, 9449.574769135406, 9799.412035277906, 9870.555824987821, 1887.4715079777684, 1952.8828270303827, 1964.3812199157219, 1973.97039044413, 2015.254355888316, 53759.56507236346, 59395.0, 66857.0, 77666.0, 77997.22002779956, 9333.766655833659, 10101.242406819518, 10176.898231017743, 10395.0, 10650.147988160928, 14016.299185040707, 14127.223002734743, 14207.715845683235, 14215.218163001135, 14223.28883555818, 7409.296116868996, 7513.812154696067, 7551.131619863676, 7575.848483030309, 7706.075270967408, 7131.465140114408, 7164.0, 7205.351518363373, 7338.302861228175, 7402.037735094511, 4419.690621656453, 4424.911501769947, 4433.091216300651, 4433.135538569948, 4460.9107817844115, 1753.2986805277735, 1874.5407375193165, 1908.2462427341122, 1928.4407521818516, 1949.2787668562723, 844.6030365728097, 933.3793027636682, 958.4393130019017, 961.4471678784727, 998.0618218874235, 17099.23053462597, 17176.39882604103, 17234.138293085296, 17405.390811321544, 17631.118444077743, 922.796984663373, 930.5440334236175, 949.6533765175661, 950.7242899559188, 963.4989805301344, 9302.25581953442, 9657.0, 9807.117359437541, 9832.311738178401, 9937.403755774676, 452136.0, 485375.7312134379, 486983.0, 487246.0, 488587.0, 91943.5402822995, 93755.53122234481, 94678.5266073679, 95136.52431737936, 95458.0, 835.8286551256978, 918.2149262380702, 922.3082687984012, 943.9575219115156, 952.936891629628, 15968.201589920225, 16059.188874866813, 16115.435959741822, 16720.0, 16887.493375198763, 39971.0, 41539.7923010383, 41581.37627935523, 41745.0, 41925.0, 54038.45961540334, 55625.721871392, 62269.0, 62440.37559624527, 63514.0, 7441.776746697607, 7673.309402153833, 7729.1884352142215, 7836.960815195887, 8125.715599953974, 12352.876471235173, 12726.618201453972, 12858.292793896051, 13091.345432728516, 13270.270135142273, 10196.235282354002, 10394.948025259826, 10647.574097036031, 10761.354318740587, 11204.271722338022, 5531.280933478622, 10106.797864042532, 10836.187285953743, 10976.682798064283, 11533.423328833693, 11061.170412218955, 11186.0, 11686.357250351311, 11726.589569365031, 12109.757804843677, 7595.468317217963, 7651.1583725789005, 7695.422843286664, 7704.383649308154, 7854.4894581851995, 11162.274452160584, 11273.098152147972, 11491.138164637852, 11621.883781162418, 11931.284122952304], "value": 8675.173655473702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1145.3872178384565, 1329.9069065165438, 1401.7546929287375, 1406.1633328169742, 1578.7552929295955, 8119.594020298983, 8434.325253979674, 8456.365772567051, 8723.47659140452, 8748.518831464267, 8502.0, 8690.17443342883, 8704.695335663253, 8708.12918708129, 8723.302135829133, 2023.1300540767463, 2243.8204943604474, 2287.0, 2318.038014224095, 2339.4619237575366, 2336.918207862725, 2345.659879317498, 2346.4251258441705, 2347.0, 2349.659299401594, 2290.7365652949875, 2298.5517824024237, 2316.895739691718, 2323.1984965187066, 2324.604817181075, 1940.6797878350055, 2191.802737753594, 2210.491586934998, 2256.2892688802976, 2259.1415262200258, 2260.954780904373, 2296.78180572847, 2318.188633978111, 2319.617263151578, 2319.814414846808, 8686.478811271343, 8736.301095912375, 8757.168069033432, 8815.206631403205, 8831.0, 5135.255387968761, 5277.683338999673, 5285.497877701612, 5286.04851126797, 5292.788288468457, 3275.2958114005364, 3287.8027318360973, 3341.2315167511365, 3425.743069269815, 3451.2752322012407, 1077.0898590690854, 1081.864766904137, 1116.112690411117, 1122.0798944865214, 1125.58915995661, 12764.234145951179, 12781.041421893395, 12827.422765975554, 12830.743385132246, 12831.0, 4368.213721530092, 4501.504834468271, 4516.051629157913, 4543.409356783597, 4548.499665036843, 10661.0, 10724.356538607708, 10742.731431714114, 10751.516181771683, 10753.56985720578, 5093.0, 5176.922346164811, 5181.093308671043, 5185.714785686748, 5199.064168449715, 4200.285951388271, 4708.176069187878, 4805.27920811881, 4836.613070954315, 4909.361782968263, 3794.3359912015285, 3923.372260438316, 3931.76409415436, 3962.7424217425773, 4005.2189822984237, 1214.7813393589238, 1219.591436868659, 1231.612042206702, 1232.8212409200617, 1244.2596654990266, 788.9900926813573, 801.7554645833077, 833.8624127019095, 949.1315446366635, 981.455292312759, 5893.322267939242, 5932.673702946379, 5958.821235362946, 5963.016102343065, 6052.878942421127, 901.2114399900088, 916.6470908700198, 945.9574319155655, 964.9035096490295, 1000.0599436529784, 3852.768833869977, 4109.856155034559, 4158.91682166355, 4183.790810459464, 4190.0, 11210.551577936954, 11414.258073225214, 11425.485853136463, 11578.536858525733, 11579.247348922294, 11382.715432114263, 11390.316581005001, 11398.088152947745, 11402.0, 11427.828582571268, 7763.61181940912, 8056.113827478973, 8087.676492940334, 8124.878126828103, 8231.218034286732, 5980.102984552352, 6080.361562035922, 6161.44546990755, 6186.412290832363, 6238.500919926304, 10073.445960472245, 10448.68653940383, 10529.526171322463, 10540.841887371542, 10693.89306106929, 10512.78974420492, 10708.196885233483, 10716.410597417216, 10736.141108711128, 10756.946215268874, 6902.8619427610165, 7511.812204694707, 7671.961640191764, 7680.923190768244, 7842.333401660922, 8439.49363038195, 8449.619767110371, 8491.320694344315, 8508.532030738368, 8511.787205319917, 7457.776266712007, 7667.578283194478, 7718.382529397747, 7727.961360193163, 7737.264959828807, 7383.372413344926, 7388.335049845539, 7481.58851263164, 7514.699412023677, 7712.113106992543, 6631.0, 6684.665766711742, 6722.764703235363, 6724.663766811542, 6748.561343512656, 4718.0, 4912.852614421573, 4954.405471343462, 5115.693058416507, 5297.390800058042, 5246.422893481637, 5279.344949822849, 5284.418713941386, 5354.919676204782, 5424.5660347172925], "value": 4599.008878009631, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8740791091473, 325.41587849809594, 330.5867665418227, 331.68324250340925, 333.25849983786077, 5216.5565926896215, 5255.842324730264, 5284.207368894663, 5334.466553344663, 5335.599830012745, 5163.922541161885, 5232.686038837673, 5234.30433326837, 5241.663375839165, 5246.449122842104, 3948.9012774680646, 3989.4015897615445, 4124.711270211086, 4154.31453810121, 4159.854405095823, 4116.682661548306, 4154.43915071466, 4158.08522125132, 4165.520965089008, 4179.0, 3955.71439282233, 4073.775942323171, 4090.877273681794, 4110.869510884516, 4120.629143377096, 3917.941230881539, 4033.657139143176, 4079.551249362568, 4093.16090201508, 4109.157622687342, 3573.2317551726505, 3596.2088340565033, 3612.259486805199, 3618.8106195751457, 3626.1478552540134, 5023.799048038074, 5024.572911302544, 5029.5724863386295, 5062.215356619729, 5066.898662026776, 4484.609770971009, 4630.8147674093, 4653.789450011252, 4655.556777399017, 4673.95326046742, 5418.539424148952, 5430.8370748877205, 5436.510714035756, 5451.754671039813, 5481.972590137024, 3914.3950980098025, 3940.783256920868, 3944.6055394460614, 3952.980235098806, 3971.1660551284267, 5551.1673249012565, 5603.571089372224, 5604.355499117572, 5662.348829884533, 5701.828945131652, 3981.2634662586934, 3998.6401223889407, 4018.6383225509844, 4021.356582946773, 4031.657309128698, 4042.333015052542, 4059.9594004060173, 4082.652974497201, 4087.3051581230666, 4106.425100485934, 4405.515393306734, 4637.1421287062, 4665.996810685719, 4676.719396836201, 4679.625629949596, 5483.0, 5501.889962200734, 5521.668699878021, 5525.502704756591, 5549.889002219933, 1370.2737549098993, 1402.4670625162373, 1404.9578512644637, 1410.7601707709714, 1414.801927730098, 895.552223888056, 899.6986009686829, 927.6474939522938, 940.9106134917172, 947.1522986926662, 5234.246527413359, 5267.841964741064, 5278.97360513195, 5280.577553795687, 5310.6813591184655, 5563.193336966117, 5579.358373787067, 5581.413951535031, 5634.661920284796, 5639.097744360883, 5076.314697515788, 5245.186996015624, 5311.814086506954, 5318.680879147263, 5322.14845624706, 2972.7621790256726, 2987.4025194961096, 3001.1446737680094, 3002.174402039413, 3005.5792189093545, 5539.947409992089, 5753.4534219249945, 5760.683162426107, 5761.654300741969, 5789.363170051291, 5664.279078131117, 5669.0, 5684.8010319638615, 5714.514266287412, 5717.885642287214, 5739.282589676291, 5748.885022299531, 5761.802199779163, 5806.622569532967, 5834.124881267844, 5210.192420174879, 5554.833484968202, 5569.303837020372, 5571.4428557143965, 5605.49550540437, 5512.751926163252, 5520.647441376888, 5524.685188886636, 5526.281583394133, 5570.192322113352, 5708.57185711065, 5808.39011903744, 5836.402800753794, 5841.707914604338, 5865.912011319749, 3753.887383378503, 3950.861719839792, 4012.5586185520156, 4030.5087117766616, 4054.108096218827, 5640.477071190838, 5654.095344744821, 5682.147677848356, 5702.45826646468, 5722.5135863450405, 5318.867028324323, 5549.722513874371, 5551.417101204315, 5553.583481238842, 5574.944250557604, 5480.780768769205, 5481.123020316731, 5496.7526461308535, 5499.285092937893, 5506.752196151263, 5233.685978841282, 5325.440828712929, 5384.461553844741, 5399.461153571214, 5431.452036169672, 5539.750711217925, 5567.749451274622, 5604.243427137284, 5610.242617246783, 5622.437756224344, 5404.59465540094, 5449.1826226066405, 5465.207544906046, 5480.890382192413, 5493.335732169815], "value": 4183.768385331642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.8498445357568, 717.5443593318244, 744.3896005275676, 744.9553026818392, 754.7886591754311, 13458.1925084495, 13850.307484625766, 14206.147631142112, 14280.857191428096, 14291.356888939996, 12263.570775022876, 12324.507019719224, 12355.567555135573, 12356.691082722937, 12362.752744945119, 566.4562020460353, 577.7602295047571, 581.1428143488363, 581.2995340614549, 582.5427039773779, 691.7060249394012, 698.6367089113658, 703.7607213547393, 704.9577025378494, 705.2277755857353, 613.6563524426314, 613.7054213977293, 615.3477314047125, 615.8337248942782, 616.100493279812, 637.5314144104079, 644.40392636811, 646.8124243969244, 648.2253706820352, 661.963592002442, 453.66202179376245, 459.04518601309195, 459.9880263420455, 460.6729222252205, 467.6445901115177, 12689.809652855214, 12705.301208433533, 12709.618711438672, 12730.80903786444, 12735.23588584688, 12061.396930153458, 12071.879281207164, 12319.753604927851, 12660.68348291291, 13144.474221031147, 10353.223508236912, 10390.584376624925, 10459.529321180566, 10491.16070714341, 10647.414392208426, 3725.6833169180654, 3739.8691045813266, 3744.606816284278, 3794.6774524165203, 3850.5956874528333, 56737.43262567404, 57386.0, 58473.12290315649, 60057.0, 60288.0, 9591.184749296248, 9755.073268039525, 9762.267829912786, 9982.850257246148, 10016.176059431937, 15737.213139342986, 15747.44883929057, 15785.158671439021, 16650.75023874643, 17144.742828857576, 7933.3653307736395, 7972.2824945754, 8131.0, 8216.794580135544, 8545.74362769118, 4610.654200934943, 4723.858284251478, 4729.55069268419, 4850.902981940412, 4912.38595175603, 3047.2534229113567, 3169.1918560767317, 3197.600299962505, 3249.8212598306845, 3259.08745551246, 569.6724383479516, 601.1433706967641, 608.8630058236861, 610.185402487675, 616.8149555133532, 534.2067030459764, 540.7485519233496, 615.9045347971072, 663.3896814930275, 665.3878431842717, 9036.728898133066, 9207.013349272736, 9384.155426011692, 9404.529773511296, 9654.179394751385, 664.817175276793, 668.1014036121409, 686.6669665212368, 694.9583025018516, 743.1973468653841, 4172.499300083949, 4291.420658211164, 4298.505671847715, 4396.868093957187, 4432.401625780542, 71266.64366678237, 73346.26653733502, 74623.0, 75498.24501755022, 75774.24225757782, 46338.0, 61220.0, 63754.362456374845, 65924.0, 67853.32146678568, 55452.72273638606, 56800.43199568034, 57652.71173644189, 58316.0, 58757.70621146867, 9009.414388064755, 9092.944905870565, 9161.816763664823, 9201.30990175726, 9239.353245272767, 36531.0, 36701.26597468089, 37269.440958386185, 37663.246735065695, 37766.62233377631, 45977.0, 46263.0, 49096.509034910625, 50624.240636389746, 51087.2336914954, 11288.972951026744, 11420.771584568096, 11648.301101933912, 11886.227395219283, 12073.75852482963, 13067.542636007694, 13439.395227214603, 13529.255890926093, 13711.382987765774, 14107.0, 10735.302205356627, 11146.331220126818, 11892.940535297268, 12423.458365820317, 12426.440810163745, 10185.388876667424, 10245.0, 10315.638952636622, 10549.156067514734, 10960.123190144928, 11683.474243659226, 11752.177347585586, 12104.273743575413, 12147.088968327587, 12157.939210303892, 9890.208783297176, 10051.849222261526, 10067.496625168858, 10164.796704066026, 10387.53256103462, 10075.647352342632, 10222.182225422097, 10229.59081636756, 10419.479026048819, 10563.912015419073], "value": 6330.724712464451, "unit": "score"}], "name": "dromaeo_css", "value": 6897.868085537106, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 110.0, 110.0, 111.0, 114.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 127.0, 180.0, 129.0, 139.0, 157.0, 126.0, 158.0, 125.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 111.0, 76.0, 76.0, 75.0, 75.0, 98.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 131.0, 83.0, 85.0, 84.0, 122.0, 84.0, 85.0, 134.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 58.0, 55.0, 81.0, 54.0, 54.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 80.0, 80.0, 81.0, 80.0, 81.0, 82.0, 81.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 135.0, 117.0, 118.0, 121.0, 120.0, 120.0, 162.0, 124.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 160.0, 158.0, 171.0, 161.0, 161.0, 163.0, 158.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 66.0, 65.0, 68.0, 64.0, 64.0, 61.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1506.0, "alertThreshold": 2.0}]} 10:56:35 INFO - Return code: 0 10:56:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:56:35 ERROR - # TBPL SUCCESS # 10:56:35 INFO - Running post-action listener: _resource_record_post_action 10:56:35 INFO - ##### 10:56:35 INFO - ##### Finished run-tests step (success) 10:56:35 INFO - ##### 10:56:35 INFO - Running post-run listener: _resource_record_post_run 10:56:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 538296320; Read time: 608; Write time: 550964 10:56:35 INFO - TinderboxPrint: CPU usage
13.1% 10:56:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 608 10:56:35 INFO - TinderboxPrint: I/O write bytes / time
538,296,320 / 550,964 10:56:35 INFO - TinderboxPrint: CPU idle
8,261.1 (86.8%) 10:56:35 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 10:56:35 INFO - TinderboxPrint: Swap in / out
0 / 0 10:56:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 253460480; Read time: 320; Write time: 321252 10:56:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284835840; Read time: 288; Write time: 229712 10:56:36 INFO - Running post-run listener: _upload_blobber_files 10:56:36 INFO - Blob upload gear active. 10:56:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:56:36 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 10:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:56:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:41 INFO - (blobuploader) - INFO - Done attempting. 10:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:42 INFO - (blobuploader) - INFO - Done attempting. 10:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:43 INFO - (blobuploader) - INFO - Done attempting. 10:56:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:56:43 INFO - Return code: 0 10:56:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:56:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:56:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4221cf87cfc1d5385a6c4fd88f8299fa13bf5430bd846a1ef445b73429f8856beddd570e53245dd49eba1b7497d9f900fb0086a4c8bb6580ce521ab2142cccd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dad97b0c75a61a504dfeebdc0f60f6f9e80bc3d36d3bead7d074c9b92541619730b00b381535dcc97b5ade39d4f2f4737849702a064a19bfc8e6f6b7929a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b1282a5803c489fb8bfb6f48a011b4a4d3b213e520bc00732d0a9c4eccf201dfede4f5d03f9f1a65cfa9ba70584881fe02b3ef74880d9de4810499f714deba1"} 10:56:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:56:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:56:43 INFO - Contents: 10:56:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4221cf87cfc1d5385a6c4fd88f8299fa13bf5430bd846a1ef445b73429f8856beddd570e53245dd49eba1b7497d9f900fb0086a4c8bb6580ce521ab2142cccd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dad97b0c75a61a504dfeebdc0f60f6f9e80bc3d36d3bead7d074c9b92541619730b00b381535dcc97b5ade39d4f2f4737849702a064a19bfc8e6f6b7929a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b1282a5803c489fb8bfb6f48a011b4a4d3b213e520bc00732d0a9c4eccf201dfede4f5d03f9f1a65cfa9ba70584881fe02b3ef74880d9de4810499f714deba1"} 10:56:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:56:43 INFO - Copying logs to upload dir... 10:56:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:56:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.162694 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-25 10:56:42.741046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:56:42.744948) ========= 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=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4221cf87cfc1d5385a6c4fd88f8299fa13bf5430bd846a1ef445b73429f8856beddd570e53245dd49eba1b7497d9f900fb0086a4c8bb6580ce521ab2142cccd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dad97b0c75a61a504dfeebdc0f60f6f9e80bc3d36d3bead7d074c9b92541619730b00b381535dcc97b5ade39d4f2f4737849702a064a19bfc8e6f6b7929a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b1282a5803c489fb8bfb6f48a011b4a4d3b213e520bc00732d0a9c4eccf201dfede4f5d03f9f1a65cfa9ba70584881fe02b3ef74880d9de4810499f714deba1"} build_url:https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/DzpRMgOIRl6gZRUWRQ9QPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4221cf87cfc1d5385a6c4fd88f8299fa13bf5430bd846a1ef445b73429f8856beddd570e53245dd49eba1b7497d9f900fb0086a4c8bb6580ce521ab2142cccd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4dad97b0c75a61a504dfeebdc0f60f6f9e80bc3d36d3bead7d074c9b92541619730b00b381535dcc97b5ade39d4f2f4737849702a064a19bfc8e6f6b7929a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b1282a5803c489fb8bfb6f48a011b4a4d3b213e520bc00732d0a9c4eccf201dfede4f5d03f9f1a65cfa9ba70584881fe02b3ef74880d9de4810499f714deba1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:56:42.770875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:56:42.771222) ========= 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=52faae308a556c440401f8e5000001e8-1464197763.445751-857912986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:56:42.854290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:56:42.854681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:56:42.855002) ========= ========= Total master_lag: 0.15 =========