builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1461331728.17 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.174215) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.174680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.174977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.188791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.189095) ========= 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=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:28:48-- 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% 112M=0s 2016-04-22 06:28:48 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.332298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.332621) ========= 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=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020611 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.381558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:48.381884) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --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=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:28:48,512 truncating revision to first 12 chars 2016-04-22 06:28:48,512 Setting DEBUG logging. 2016-04-22 06:28:48,512 attempt 1/10 2016-04-22 06:28:48,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:28:49,063 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:49.219829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:49.220196) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:49.220664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:49.220952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:28:49.228936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-22 06:28:49.229306) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:28:49 INFO - MultiFileLogger online at 20160422 06:28:49 in /builds/slave/test 06:28:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:28:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:49 INFO - {'append_to_log': False, 06:28:49 INFO - 'base_work_dir': '/builds/slave/test', 06:28:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:28:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:49 INFO - 'branch': 'Fx-Team-Non-PGO', 06:28:49 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:49 INFO - 'config_files': ('talos/linux_config.py',), 06:28:49 INFO - 'default_actions': ('clobber', 06:28:49 INFO - 'read-buildbot-config', 06:28:49 INFO - 'download-and-extract', 06:28:49 INFO - 'populate-webroot', 06:28:49 INFO - 'create-virtualenv', 06:28:49 INFO - 'install', 06:28:49 INFO - 'run-tests'), 06:28:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:49 INFO - 'download_minidump_stackwalk': True, 06:28:49 INFO - 'download_symbols': 'ondemand', 06:28:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:49 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:49 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:49 INFO - 'installer_path': 'installer.exe', 06:28:49 INFO - 'log_level': 'info', 06:28:49 INFO - 'log_name': 'talos', 06:28:49 INFO - 'log_to_console': True, 06:28:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:28:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:28:49 INFO - 'opt_config_files': (), 06:28:49 INFO - 'pip_index': False, 06:28:49 INFO - 'sps_profile': False, 06:28:49 INFO - 'sps_profile_interval': 0, 06:28:49 INFO - 'suite': 'dromaeojs', 06:28:49 INFO - 'system_bits': '32', 06:28:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:49 INFO - 'title': 'talos-linux64-ix-009', 06:28:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:49 INFO - 'use_talos_json': True, 06:28:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:49 INFO - 'work_dir': 'build'} 06:28:49 INFO - ##### 06:28:49 INFO - ##### Running clobber step. 06:28:49 INFO - ##### 06:28:49 INFO - Running pre-action listener: _resource_record_pre_action 06:28:49 INFO - Running main action method: clobber 06:28:49 INFO - rmtree: /builds/slave/test/build 06:28:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:49 INFO - Running post-action listener: _resource_record_post_action 06:28:49 INFO - ##### 06:28:49 INFO - ##### Running read-buildbot-config step. 06:28:49 INFO - ##### 06:28:49 INFO - Running pre-action listener: _resource_record_pre_action 06:28:49 INFO - Running main action method: read_buildbot_config 06:28:49 INFO - Using buildbot properties: 06:28:49 INFO - { 06:28:49 INFO - "project": "", 06:28:49 INFO - "product": "firefox", 06:28:49 INFO - "script_repo_revision": "production", 06:28:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:28:49 INFO - "repository": "", 06:28:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:28:49 INFO - "buildid": "20160419211331", 06:28:49 INFO - "pgo_build": "False", 06:28:49 INFO - "basedir": "/builds/slave/test", 06:28:49 INFO - "buildnumber": 2865, 06:28:49 INFO - "slavename": "talos-linux64-ix-009", 06:28:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:28:49 INFO - "platform": "ubuntu64_hw", 06:28:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:28:49 INFO - "branch": "fx-team", 06:28:49 INFO - "repo_path": "integration/fx-team", 06:28:49 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 06:28:49 INFO - "stage_platform": "linux64", 06:28:49 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 06:28:49 INFO - "slavebuilddir": "test" 06:28:49 INFO - } 06:28:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:28:49 INFO - Running post-action listener: _resource_record_post_action 06:28:49 INFO - ##### 06:28:49 INFO - ##### Running download-and-extract step. 06:28:49 INFO - ##### 06:28:49 INFO - Running pre-action listener: _resource_record_pre_action 06:28:49 INFO - Running main action method: download_and_extract 06:28:49 INFO - mkdir: /builds/slave/test/build/tests 06:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:49 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:28:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:28:50 INFO - Downloaded 1361 bytes. 06:28:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:28:50 INFO - Using the following test package requirements: 06:28:50 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:28:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'jsshell-linux-x86_64.zip'], 06:28:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:28:50 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:28:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:50 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:50 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:51 INFO - Downloaded 22267191 bytes. 06:28:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:28:52 INFO - Return code: 0 06:28:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:52 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:53 INFO - Downloaded 22267191 bytes. 06:28:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:28:55 INFO - Return code: 0 06:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:55 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:28:56 INFO - Downloaded 10845952 bytes. 06:28:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:28:56 INFO - Return code: 0 06:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:56 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:28:58 INFO - Downloaded 54508588 bytes. 06:28:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:58 INFO - mkdir: /builds/slave/test/properties 06:28:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:58 INFO - Contents: 06:28:58 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:28:58 INFO - Running post-action listener: _resource_record_post_action 06:28:58 INFO - Running post-action listener: set_extra_try_arguments 06:28:58 INFO - ##### 06:28:58 INFO - ##### Running populate-webroot step. 06:28:58 INFO - ##### 06:28:58 INFO - Running pre-action listener: _resource_record_pre_action 06:28:58 INFO - Running main action method: populate_webroot 06:28:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:58 INFO - '--tppagecycles', 06:28:58 INFO - '7'], 06:28:58 INFO - 'tests': ['tsvgm']}}, 06:28:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['damp', 'tps']}, 06:28:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'tests': ['damp', 'tps']}, 06:28:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['dromaeo_dom']}, 06:28:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['a11yr', 06:28:58 INFO - 'ts_paint', 06:28:58 INFO - 'tpaint', 06:28:58 INFO - 'sessionrestore', 06:28:58 INFO - 'sessionrestore_no_auto_restore', 06:28:58 INFO - 'tabpaint']}, 06:28:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['tsvgx', 06:28:58 INFO - 'tsvgr_opacity', 06:28:58 INFO - 'tart', 06:28:58 INFO - 'tscrollx', 06:28:58 INFO - 'cart']}, 06:28:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:58 INFO - 'tsvgr_opacity', 06:28:58 INFO - 'tart', 06:28:58 INFO - 'tscrollx', 06:28:58 INFO - 'cart']}, 06:28:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'talos_options': ['--disable-e10s'], 06:28:58 INFO - 'tests': ['tp5o']}, 06:28:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'tests': ['tp5o']}, 06:28:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'talos_options': ['--disable-e10s', 06:28:58 INFO - '--xperf_path', 06:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:58 INFO - 'tests': ['tp5n']}, 06:28:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:58 INFO - 'talos_options': ['--xperf_path', 06:28:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:58 INFO - 'tests': ['tp5n']}}, 06:28:58 INFO - 'talos.zip': {'path': '', 06:28:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:58 INFO - Running post-action listener: _resource_record_post_action 06:28:58 INFO - ##### 06:28:58 INFO - ##### Running create-virtualenv step. 06:28:58 INFO - ##### 06:28:58 INFO - Running pre-action listener: _resource_record_pre_action 06:28:58 INFO - Running main action method: create_virtualenv 06:28:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:28:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:58 INFO - Using real prefix '/usr' 06:28:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:01 INFO - Installing pip.................done. 06:29:01 INFO - Return code: 0 06:29:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:29:01 INFO - Using env: {'DISPLAY': ':0', 06:29:01 INFO - 'HOME': '/home/cltbld', 06:29:01 INFO - 'LANG': 'en_US.UTF-8', 06:29:01 INFO - 'LANGUAGE': 'en_US:en', 06:29:01 INFO - 'LOGNAME': 'cltbld', 06:29:01 INFO - 'MAIL': '/var/mail/cltbld', 06:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:01 INFO - 'MOZ_NO_REMOTE': '1', 06:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:01 INFO - 'NO_EM_RESTART': '1', 06:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:01 INFO - 'PWD': '/builds/slave/test', 06:29:01 INFO - 'SHELL': '/bin/bash', 06:29:01 INFO - 'SHLVL': '1', 06:29:01 INFO - 'TERM': 'linux', 06:29:01 INFO - 'TMOUT': '86400', 06:29:01 INFO - 'USER': 'cltbld', 06:29:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:01 INFO - '_': '/tools/buildbot/bin/python'} 06:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:29:01 INFO - Cleaning up... 06:29:01 INFO - Return code: 0 06:29:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:29:01 INFO - Using env: {'DISPLAY': ':0', 06:29:01 INFO - 'HOME': '/home/cltbld', 06:29:01 INFO - 'LANG': 'en_US.UTF-8', 06:29:01 INFO - 'LANGUAGE': 'en_US:en', 06:29:01 INFO - 'LOGNAME': 'cltbld', 06:29:01 INFO - 'MAIL': '/var/mail/cltbld', 06:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:01 INFO - 'MOZ_NO_REMOTE': '1', 06:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:01 INFO - 'NO_EM_RESTART': '1', 06:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:01 INFO - 'PWD': '/builds/slave/test', 06:29:01 INFO - 'SHELL': '/bin/bash', 06:29:01 INFO - 'SHLVL': '1', 06:29:01 INFO - 'TERM': 'linux', 06:29:01 INFO - 'TMOUT': '86400', 06:29:01 INFO - 'USER': 'cltbld', 06:29:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:01 INFO - '_': '/tools/buildbot/bin/python'} 06:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:01 INFO - Downloading/unpacking psutil>=0.7.1 06:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:03 INFO - Installing collected packages: psutil 06:29:03 INFO - Running setup.py install for psutil 06:29:04 INFO - building 'psutil._psutil_linux' extension 06:29:04 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 06:29:04 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 06:29:04 INFO - building 'psutil._psutil_posix' extension 06:29:04 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 06:29:04 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 06:29:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:04 INFO - Successfully installed psutil 06:29:04 INFO - Cleaning up... 06:29:04 INFO - Return code: 0 06:29:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:29:04 INFO - Using env: {'DISPLAY': ':0', 06:29:04 INFO - 'HOME': '/home/cltbld', 06:29:04 INFO - 'LANG': 'en_US.UTF-8', 06:29:04 INFO - 'LANGUAGE': 'en_US:en', 06:29:04 INFO - 'LOGNAME': 'cltbld', 06:29:04 INFO - 'MAIL': '/var/mail/cltbld', 06:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:04 INFO - 'MOZ_NO_REMOTE': '1', 06:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:04 INFO - 'NO_EM_RESTART': '1', 06:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:04 INFO - 'PWD': '/builds/slave/test', 06:29:04 INFO - 'SHELL': '/bin/bash', 06:29:04 INFO - 'SHLVL': '1', 06:29:04 INFO - 'TERM': 'linux', 06:29:04 INFO - 'TMOUT': '86400', 06:29:04 INFO - 'USER': 'cltbld', 06:29:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:04 INFO - '_': '/tools/buildbot/bin/python'} 06:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:29:06 INFO - Installing collected packages: mozsystemmonitor 06:29:06 INFO - Running setup.py install for mozsystemmonitor 06:29:06 INFO - Successfully installed mozsystemmonitor 06:29:06 INFO - Cleaning up... 06:29:06 INFO - Return code: 0 06:29:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:29:06 INFO - Using env: {'DISPLAY': ':0', 06:29:06 INFO - 'HOME': '/home/cltbld', 06:29:06 INFO - 'LANG': 'en_US.UTF-8', 06:29:06 INFO - 'LANGUAGE': 'en_US:en', 06:29:06 INFO - 'LOGNAME': 'cltbld', 06:29:06 INFO - 'MAIL': '/var/mail/cltbld', 06:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:06 INFO - 'MOZ_NO_REMOTE': '1', 06:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:06 INFO - 'NO_EM_RESTART': '1', 06:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:06 INFO - 'PWD': '/builds/slave/test', 06:29:06 INFO - 'SHELL': '/bin/bash', 06:29:06 INFO - 'SHLVL': '1', 06:29:06 INFO - 'TERM': 'linux', 06:29:06 INFO - 'TMOUT': '86400', 06:29:06 INFO - 'USER': 'cltbld', 06:29:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:06 INFO - '_': '/tools/buildbot/bin/python'} 06:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:09 INFO - Downloading docopt-0.6.1.tar.gz 06:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:09 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:09 INFO - Running setup.py install for blobuploader 06:29:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:09 INFO - Running setup.py install for requests 06:29:09 INFO - Running setup.py install for docopt 06:29:10 INFO - Successfully installed blobuploader requests docopt 06:29:10 INFO - Cleaning up... 06:29:10 INFO - Return code: 0 06:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:10 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 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:10 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 06:29:10 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 06:29:10 INFO - Using env: {'DISPLAY': ':0', 06:29:10 INFO - 'HOME': '/home/cltbld', 06:29:10 INFO - 'LANG': 'en_US.UTF-8', 06:29:10 INFO - 'LANGUAGE': 'en_US:en', 06:29:10 INFO - 'LOGNAME': 'cltbld', 06:29:10 INFO - 'MAIL': '/var/mail/cltbld', 06:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:10 INFO - 'MOZ_NO_REMOTE': '1', 06:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:10 INFO - 'NO_EM_RESTART': '1', 06:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:10 INFO - 'PWD': '/builds/slave/test', 06:29:10 INFO - 'SHELL': '/bin/bash', 06:29:10 INFO - 'SHLVL': '1', 06:29:10 INFO - 'TERM': 'linux', 06:29:10 INFO - 'TMOUT': '86400', 06:29:10 INFO - 'USER': 'cltbld', 06:29:10 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:10 INFO - '_': '/tools/buildbot/bin/python'} 06:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:10 INFO - Running setup.py (path:/tmp/pip-Jtb8Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:10 INFO - Running setup.py (path:/tmp/pip-AD6doO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:10 INFO - Running setup.py (path:/tmp/pip-ZQ6glH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:10 INFO - Running setup.py (path:/tmp/pip-ndBJ65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:10 INFO - Running setup.py (path:/tmp/pip-hdyZVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:10 INFO - Running setup.py (path:/tmp/pip-YQeony-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:10 INFO - Running setup.py (path:/tmp/pip-434pLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:10 INFO - Running setup.py (path:/tmp/pip-PIuMcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:10 INFO - Running setup.py (path:/tmp/pip-xCTAtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:11 INFO - Running setup.py (path:/tmp/pip-bJoTJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:11 INFO - Running setup.py (path:/tmp/pip-0AaSfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:11 INFO - Running setup.py (path:/tmp/pip-EgOSbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:11 INFO - Running setup.py (path:/tmp/pip-EOeJjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:11 INFO - Running setup.py (path:/tmp/pip-XQ1w3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:11 INFO - Running setup.py (path:/tmp/pip-fZSdSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:11 INFO - Running setup.py (path:/tmp/pip-88rh3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:11 INFO - Running setup.py (path:/tmp/pip-HCxWc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:11 INFO - Running setup.py install for manifestparser 06:29:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:11 INFO - Running setup.py install for mozcrash 06:29:11 INFO - Running setup.py install for mozdebug 06:29:11 INFO - Running setup.py install for mozdevice 06:29:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozfile 06:29:12 INFO - Running setup.py install for mozhttpd 06:29:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozinfo 06:29:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozInstall 06:29:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozleak 06:29:12 INFO - Running setup.py install for mozlog 06:29:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for moznetwork 06:29:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozprocess 06:29:12 INFO - Running setup.py install for mozprofile 06:29:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:12 INFO - Running setup.py install for mozrunner 06:29:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:13 INFO - Running setup.py install for mozscreenshot 06:29:13 INFO - Running setup.py install for moztest 06:29:13 INFO - Running setup.py install for mozversion 06:29:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:13 INFO - Cleaning up... 06:29:13 INFO - Return code: 0 06:29:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:13 INFO - Using env: {'DISPLAY': ':0', 06:29:13 INFO - 'HOME': '/home/cltbld', 06:29:13 INFO - 'LANG': 'en_US.UTF-8', 06:29:13 INFO - 'LANGUAGE': 'en_US:en', 06:29:13 INFO - 'LOGNAME': 'cltbld', 06:29:13 INFO - 'MAIL': '/var/mail/cltbld', 06:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:13 INFO - 'MOZ_NO_REMOTE': '1', 06:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:13 INFO - 'NO_EM_RESTART': '1', 06:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:13 INFO - 'PWD': '/builds/slave/test', 06:29:13 INFO - 'SHELL': '/bin/bash', 06:29:13 INFO - 'SHLVL': '1', 06:29:13 INFO - 'TERM': 'linux', 06:29:13 INFO - 'TMOUT': '86400', 06:29:13 INFO - 'USER': 'cltbld', 06:29:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:13 INFO - '_': '/tools/buildbot/bin/python'} 06:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:13 INFO - Running setup.py (path:/tmp/pip-nEakY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:13 INFO - Running setup.py (path:/tmp/pip-Blxq5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:13 INFO - Running setup.py (path:/tmp/pip-aVYTdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:13 INFO - Running setup.py (path:/tmp/pip-CmSUfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:13 INFO - Running setup.py (path:/tmp/pip-U0PVuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:13 INFO - Running setup.py (path:/tmp/pip-Bv06LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:14 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)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:14 INFO - Running setup.py (path:/tmp/pip-GR62r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:14 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)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:14 INFO - Running setup.py (path:/tmp/pip-RpBKtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:14 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)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:14 INFO - Running setup.py (path:/tmp/pip-r0BS9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:14 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)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:14 INFO - Running setup.py (path:/tmp/pip-30Addz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:14 INFO - Running setup.py (path:/tmp/pip-t9yKE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:14 INFO - Running setup.py (path:/tmp/pip-XPOBWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:14 INFO - Running setup.py (path:/tmp/pip-BeuMN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:14 INFO - Running setup.py (path:/tmp/pip-fDxEVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:14 INFO - Running setup.py (path:/tmp/pip-CCmWDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:14 INFO - Running setup.py (path:/tmp/pip-cLqWMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:14 INFO - Running setup.py (path:/tmp/pip-fKTyNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:16 INFO - Downloading blessings-1.6.tar.gz 06:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:16 INFO - Installing collected packages: blessings 06:29:16 INFO - Running setup.py install for blessings 06:29:16 INFO - Successfully installed blessings 06:29:16 INFO - Cleaning up... 06:29:17 INFO - Return code: 0 06:29:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:17 INFO - Reading from file tmpfile_stdout 06:29:17 INFO - Current package versions: 06:29:17 INFO - argparse == 1.2.1 06:29:17 INFO - blessings == 1.6 06:29:17 INFO - blobuploader == 1.2.4 06:29:17 INFO - docopt == 0.6.1 06:29:17 INFO - manifestparser == 1.1 06:29:17 INFO - mozInstall == 1.12 06:29:17 INFO - mozcrash == 0.17 06:29:17 INFO - mozdebug == 0.1 06:29:17 INFO - mozdevice == 0.48 06:29:17 INFO - mozfile == 1.2 06:29:17 INFO - mozhttpd == 0.7 06:29:17 INFO - mozinfo == 0.9 06:29:17 INFO - mozleak == 0.1 06:29:17 INFO - mozlog == 3.1 06:29:17 INFO - moznetwork == 0.27 06:29:17 INFO - mozprocess == 0.22 06:29:17 INFO - mozprofile == 0.28 06:29:17 INFO - mozrunner == 6.11 06:29:17 INFO - mozscreenshot == 0.1 06:29:17 INFO - mozsystemmonitor == 0.0 06:29:17 INFO - moztest == 0.7 06:29:17 INFO - mozversion == 1.4 06:29:17 INFO - psutil == 3.1.1 06:29:17 INFO - requests == 1.2.3 06:29:17 INFO - wsgiref == 0.1.2 06:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:17 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 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:17 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 06:29:17 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 06:29:17 INFO - Using env: {'DISPLAY': ':0', 06:29:17 INFO - 'HOME': '/home/cltbld', 06:29:17 INFO - 'LANG': 'en_US.UTF-8', 06:29:17 INFO - 'LANGUAGE': 'en_US:en', 06:29:17 INFO - 'LOGNAME': 'cltbld', 06:29:17 INFO - 'MAIL': '/var/mail/cltbld', 06:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:17 INFO - 'MOZ_NO_REMOTE': '1', 06:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:17 INFO - 'NO_EM_RESTART': '1', 06:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:17 INFO - 'PWD': '/builds/slave/test', 06:29:17 INFO - 'SHELL': '/bin/bash', 06:29:17 INFO - 'SHLVL': '1', 06:29:17 INFO - 'TERM': 'linux', 06:29:17 INFO - 'TMOUT': '86400', 06:29:17 INFO - 'USER': 'cltbld', 06:29:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:17 INFO - '_': '/tools/buildbot/bin/python'} 06:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:17 INFO - Cleaning up... 06:29:17 INFO - Return code: 0 06:29:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:29:17 INFO - Using env: {'DISPLAY': ':0', 06:29:17 INFO - 'HOME': '/home/cltbld', 06:29:17 INFO - 'LANG': 'en_US.UTF-8', 06:29:17 INFO - 'LANGUAGE': 'en_US:en', 06:29:17 INFO - 'LOGNAME': 'cltbld', 06:29:17 INFO - 'MAIL': '/var/mail/cltbld', 06:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:17 INFO - 'MOZ_NO_REMOTE': '1', 06:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:17 INFO - 'NO_EM_RESTART': '1', 06:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:17 INFO - 'PWD': '/builds/slave/test', 06:29:17 INFO - 'SHELL': '/bin/bash', 06:29:17 INFO - 'SHLVL': '1', 06:29:17 INFO - 'TERM': 'linux', 06:29:17 INFO - 'TMOUT': '86400', 06:29:17 INFO - 'USER': 'cltbld', 06:29:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:17 INFO - '_': '/tools/buildbot/bin/python'} 06:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:17 INFO - Downloading/unpacking jsonschema 06:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:29:19 INFO - Downloading/unpacking functools32 (from jsonschema) 06:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:29:19 INFO - warning: no files found matching '*.txt' 06:29:19 INFO - no previously-included directories found matching 'build' 06:29:19 INFO - no previously-included directories found matching 'dist' 06:29:19 INFO - no previously-included directories found matching '.git*' 06:29:19 INFO - Installing collected packages: jsonschema, functools32 06:29:19 INFO - Running setup.py install for functools32 06:29:19 INFO - warning: no files found matching '*.txt' 06:29:19 INFO - no previously-included directories found matching 'build' 06:29:19 INFO - no previously-included directories found matching 'dist' 06:29:19 INFO - no previously-included directories found matching '.git*' 06:29:19 INFO - Successfully installed jsonschema functools32 06:29:19 INFO - Cleaning up... 06:29:20 INFO - Return code: 0 06:29:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e502bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', '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 06:29: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', 'flake8'] in /builds/slave/test/build 06:29: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 flake8 06:29:20 INFO - Using env: {'DISPLAY': ':0', 06:29:20 INFO - 'HOME': '/home/cltbld', 06:29:20 INFO - 'LANG': 'en_US.UTF-8', 06:29:20 INFO - 'LANGUAGE': 'en_US:en', 06:29:20 INFO - 'LOGNAME': 'cltbld', 06:29:20 INFO - 'MAIL': '/var/mail/cltbld', 06:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:20 INFO - 'MOZ_NO_REMOTE': '1', 06:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:20 INFO - 'NO_EM_RESTART': '1', 06:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:20 INFO - 'PWD': '/builds/slave/test', 06:29:20 INFO - 'SHELL': '/bin/bash', 06:29:20 INFO - 'SHLVL': '1', 06:29:20 INFO - 'TERM': 'linux', 06:29:20 INFO - 'TMOUT': '86400', 06:29:20 INFO - 'USER': 'cltbld', 06:29:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:20 INFO - '_': '/tools/buildbot/bin/python'} 06:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:20 INFO - Downloading/unpacking flake8 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:29:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:29:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:29:22 INFO - no previously-included directories found matching 'docs/_build' 06:29:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:29:22 INFO - Running setup.py install for pep8 06:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:29:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:29:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:29:22 INFO - no previously-included directories found matching 'docs/_build' 06:29:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:29:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:29:22 INFO - Cleaning up... 06:29:23 INFO - Return code: 0 06:29:23 INFO - Running post-action listener: _resource_record_post_action 06:29:23 INFO - Running post-action listener: _start_resource_monitoring 06:29:23 INFO - Starting resource monitoring. 06:29:23 INFO - ##### 06:29:23 INFO - ##### Running install step. 06:29:23 INFO - ##### 06:29:23 INFO - Running pre-action listener: _resource_record_pre_action 06:29:23 INFO - Running main action method: install 06:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:23 INFO - Reading from file tmpfile_stdout 06:29:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:29:23 INFO - Reading from file tmpfile_stdout 06:29:23 INFO - Output received: 06:29:23 INFO - Usage: mozinstall [options] installer 06:29:23 INFO - Options: 06:29:23 INFO - -h, --help show this help message and exit 06:29:23 INFO - -d DEST, --destination=DEST 06:29:23 INFO - Directory to install application into. [default: 06:29:23 INFO - "/builds/slave/test"] 06:29:23 INFO - --app=APP Application being installed. [default: firefox] 06:29:23 INFO - mkdir: /builds/slave/test/build/application 06:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:29:39 INFO - Reading from file tmpfile_stdout 06:29:39 INFO - Output received: 06:29:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:29:39 INFO - Running post-action listener: _resource_record_post_action 06:29:39 INFO - ##### 06:29:39 INFO - ##### Running run-tests step. 06:29:39 INFO - ##### 06:29:39 INFO - Running pre-action listener: _resource_record_pre_action 06:29:39 INFO - Running main action method: run_tests 06:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:39 INFO - Python 2.7.3 06:29:39 INFO - Return code: 0 06:29:39 INFO - grabbing minidump binary from tooltool 06:29: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')]} 06:29:39 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66410>, '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 0x2a67310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:39 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 06:29:39 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 06:29:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:39 INFO - Return code: 0 06:29:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:29:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:29:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:29:40 INFO - Return code: 0 06:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 06:29:40 INFO - Using env: {'DISPLAY': ':0', 06:29:40 INFO - 'HOME': '/home/cltbld', 06:29:40 INFO - 'LANG': 'en_US.UTF-8', 06:29:40 INFO - 'LANGUAGE': 'en_US:en', 06:29:40 INFO - 'LOGNAME': 'cltbld', 06:29:40 INFO - 'MAIL': '/var/mail/cltbld', 06:29:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:40 INFO - 'MOZ_NO_REMOTE': '1', 06:29:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:40 INFO - 'NO_EM_RESTART': '1', 06:29:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:40 INFO - 'PWD': '/builds/slave/test', 06:29:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:40 INFO - 'SHELL': '/bin/bash', 06:29:40 INFO - 'SHLVL': '1', 06:29:40 INFO - 'TERM': 'linux', 06:29:40 INFO - 'TMOUT': '86400', 06:29:40 INFO - 'USER': 'cltbld', 06:29:40 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082', 06:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:40 INFO - '_': '/tools/buildbot/bin/python'} 06:29:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:29:40 INFO - mozversion application_buildid: 20160419211331 06:29:40 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:29:40 INFO - mozversion application_display_name: Nightly 06:29:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:40 INFO - mozversion application_name: Firefox 06:29:40 INFO - mozversion application_remotingname: firefox 06:29:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:29:40 INFO - mozversion application_vendor: Mozilla 06:29:40 INFO - mozversion application_version: 48.0a1 06:29:40 INFO - mozversion platform_buildid: 20160419211331 06:29:40 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:29:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:29:40 INFO - mozversion platform_version: 48.0a1 06:29:40 INFO - using testdate: 1461331780 06:29:40 INFO - actual date: 1461331780 06:29:40 INFO - starting webserver on 'localhost:47915' 06:29:40 INFO - SUITE-START | Running 2 tests 06:29:40 INFO - TEST-START | dromaeo_css 06:29:40 INFO - operating with platform_type : linux_ 06:29:40 INFO - Initialising browser for dromaeo_css test... 06:29:40 INFO - TEST-INFO | started process 25076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEL9Kq2/profile http://localhost:47915/getInfo.html) 06:29:45 INFO - PROCESS | 25076 | __metrics Screen width/height:1600/1200 06:29:45 INFO - PROCESS | 25076 | colorDepth:24 06:29:45 INFO - PROCESS | 25076 | Browser inner width/height: 1024/697 06:29:45 INFO - PROCESS | 25076 | __metrics 06:29:46 ERROR - PROCESS | 25076 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:29:47 INFO - TEST-INFO | 25076: exit 0 06:29:47 INFO - Browser initialized. 06:29:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:47 INFO - TEST-INFO | started process 25159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEL9Kq2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:59 INFO - PROCESS | 25159 | RSS: Main: 155258880 06:29:59 INFO - PROCESS | 25159 | 06:30:50 INFO - PROCESS | 25159 | 1461331850536 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] 06:33:01 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47915/tests/dromaeo/cssquery-ext.html) 06:33:03 INFO - PROCESS | 25159 | RSS: Main: 260075520 06:33:03 INFO - PROCESS | 25159 | 06:36:05 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-ext.html (next: http://localhost:47915/tests/dromaeo/cssquery-jquery.html) 06:36:06 INFO - PROCESS | 25159 | RSS: Main: 238022656 06:36:06 INFO - PROCESS | 25159 | 06:39:08 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47915/tests/dromaeo/cssquery-mootools.html) 06:39:09 INFO - PROCESS | 25159 | RSS: Main: 249233408 06:39:09 INFO - PROCESS | 25159 | 06:42:11 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47915/tests/dromaeo/cssquery-prototype.html) 06:42:11 INFO - PROCESS | 25159 | RSS: Main: 229728256 06:42:11 INFO - PROCESS | 25159 | 06:45:14 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47915/tests/dromaeo/cssquery-yui.html) 06:45:15 INFO - PROCESS | 25159 | RSS: Main: 219275264 06:45:15 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-yui.html (next: http://localhost:47915/tests/dromaeo/cssquery-dojo.html) 06:48:18 INFO - PROCESS | 25159 | RSS: Main: 276434944 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | __start_tp_report 06:48:18 INFO - PROCESS | 25159 | _x_x_mozilla_page_load 06:48:18 INFO - PROCESS | 25159 | _x_x_mozilla_page_load_details 06:48:18 INFO - PROCESS | 25159 | |i|pagename|runs| 06:48:18 INFO - PROCESS | 25159 | |0;dojo.html;2565.2945440004;2604.2187343796854;2613.6602241708574;2619.083320837707;2640.8547529885855;4401.911961760763;4494.168578812922;4540.977295113524;4578.748168850716;4597.103564804868;4508.729476231429;4570.931436028454;4619;4654.557817007388;4665.206914824479;4251.957480425195;4275.380069889879;4293.720908140961;4319.481662200525;4361.214981303364;4230.19626271009;4281.529031806499;4338.934915976263;4384.89037774055;4389.122175564884;4128.669706423479;4203.222403855266;4305.246581848195;4342.544032876534;4343.630791382736;4180.644645205161;4183.602557757008;4223.514295855985;4235.894102647459;4252.192083504125;4218.093109981338;4233;4233.788310584489;4247.214265360918;4277.059047009653;4333.046729719456;4460.553944605514;4476.171908196961;4490.124425736983;4525.818967241306;4903.53416425439;4932.630052746023;4939.728314942677;4955.776990035421;4982.975085124587;4929.531694489017;4933.70397776131;4948.678335908155;4954.9009019819405;4962.702237865704;4474.530174331649;4578.107269082497;4616.3537104805355;4619.330197121432;4656.3946686930485;4921.581665558396;4935.827246046371;4947.183714687037;4948.6783359082265;4986.825461108844;4759.095771803415;4760.7619619018915;4770.666053376231;4779.522047795263;4803.03939212159;4730.905381892343;4839.7096174229655;4892.094962431962;4902.896848209124;4919.680220785637;4852.757362131879;4877.829275975324;4890.926636100461;4894.241392584155;4920.483349248278;4868.853934381974;4871.244957031666;4878.487758785347;4882.536159064884;4898.804047838118;4031.657309128757;4096.139810639799;4146.295129827937;4192.643625291885;4230.767307798039;3643.143861192618;3651.415773476231;3683.9815800920824;3696.445533170046;3726.9440958385644;4247.51153617338;4250.553691862372;4255.063885945087;4259.424977628042;4298.247806633826;4747.8575642730775;4917.409910810726;4929.06347793918;4938.506149385033;4996.775145118479;4255.3829694694095;4276.465441819772;4278.358246263023;4297.59172878576;4323.286657701444;4453.710508816916;4476.082403107355;4478.664100192498;4485.349624304523;4521.954780452219;4488.730676159375;4657.976710116428;4726.929096063493;4728.219843725816;4736.265878788793;4916;4927.852164435073;4940.357753492023;4946.950530494649;4964.032013757283;4684.672072954861;4697.459792123813;4704.059188162313;4709.623230141512;4761.809527618856;4670.042641258602;4849.636277279289;4883.8290659826735;4921.2864134700985;4933.33399991011;4872.537108974641;4873.4639189689815;4882.852529655599;4886.951130488792;4946.530079642428;4561.3614094027525;4721.00858819638;4766.356541866804;4768.833090841804;4813.831515896927;4737.9052418952115;4776.116418462596;4780.95219047805;4798.352222450064;4827.975860120677;4640.837570685145;4670.906581868411;4671.906561868812;4673.976630116827;4723.763811809327;4593.242115050979;4738.526147385234;4772.379590653193;4808.831690890802;4817.397825271841;4608.35483032369;4620.168369693488;4623.3758442609815;4653.930191047205;4668.0197158597075 06:48:18 INFO - PROCESS | 25159 | |1;ext.html;572.3075079154223;592.8191901470053;604.1843511259797;620.633826042635;629.8645791154901;34292.314153716914;35332.82333588329;35363;35404.93785186445;35467;36328;36916.63083369172;37010;37035.629643703556;37127;7581.772546823604;7798.571078590704;7804.024496937883;7805.141434442206;7809.180036096213;7575.886361704579;7689.961550192241;7698.461107722462;7846.607669616525;7868.4098692598;7850.3327217186325;7928.445008849383;7928.643211055516;7929;7934.166912474194;7852;7867.409944254204;7909.209079092102;7910.248526389983;7912.64393102306;7854.8429031419055;7944.205579442068;7945.841083178304;7948.682052717884;7952;37372.25255494875;37549.62450375489;37867.43198852019;37876.29556669956;37893.621063789564;3283.770136090475;3439.6216416194197;3742.101895545077;3756.643118903727;3835.4055121456217;28242.717572824215;28779.56830647542;29190;29206.561901571495;29596.408071838443;3326;3360.462326027824;3380.3070370573973;3393.52490651309;3435.12404336895;223816;291117;297347;297922.5103874488;299309;32798.836005819816;51043.744781275855;51383.74308128435;51423.48576514262;51579.74210129;33472.66527334744;33805.66194338025;33810.95701386887;33816.32367352688;33818.830905845316;12254.75490490203;12444.19112757686;12447.190932589352;12450.937745311216;12455.75088498225;9773.07155820196;9820.067093626094;9831.115199632068;9833.901660983442;9838.311318207656;8046.114927357986;8124.065732440727;8133.918660813434;8202.548859812649;8212.137725538852;3195.4248235317864;3233.288676491168;3242.7243684286627;3252.658470860573;3263.102646772109;935.6491315756591;976.3857817549093;984.3159004491953;990.0891180114169;994.9303548751518;27656.170314890587;27770;28419.57370639442;28585.57121643177;28712.138635840958;952.9761755956157;1014.7564584499814;1052.3843551522293;1079.4225089577196;1114.0808832713044;14436.639084022983;15053.473128440452;15130;15300.234988250542;15412.922935385252;353715;359928;361026;361027;361027;47252;48108.518914810404;48109.5189048105;48147.518524815;48166.75916620394;1057.3444464432102;1123.455124264731;1127.6842484104463;1229.2194456520174;1259.2444533279959;24526.63210051815;26762.866185668947;27129.58942803337;27269.181924542296;27616.309592260353;37796.24407511889;38018.42972355472;38235;38294.234115316984;38326.61673383231;218678;219330;220472;220988;221175;22398.552028959657;22467.88766056159;22761.203357882394;22779.202727904445;25713.614295785203;35569.46645800264;35752.106197344234;35913.1021724459;36073;36325.09187270234;31941.36117277688;32822.67177328196;34327.65672343245;34686.826565867006;35830;33604.663953360156;33683.15792105217;33892.32215355728;34120.829395853856;34338.48492272568;31168;33954.15114622055;36971.26057478889;38647.6135238644;38775;28668.283292917844;31061.8446907764;31222.531662025543;31544.211394715316;31559.684403156592;23599.29202123939;24049.639255411534;24207.394815129057;24649.507009860063;24673.87663061673 06:48:18 INFO - PROCESS | 25159 | |2;jquery.html;376.13676612175055;377.6902939589537;382.7225261685277;387.4923849756819;391.8706826747174;15872.682546349066;16063;17102.401415950444;17112.657746845085;17146.228419721097;16936.89910155839;17606.38377656782;17671.823281767178;17899.821001789976;17904.28382864684;5593.300837395325;5736.827895163131;5758.510526605243;5777.451142141511;5779.682117483537;3989.98005009976;4994.97502512487;6690.464762818963;6727.428168605675;6735.461163106964;6564.803055908306;6639.73441062357;6720.764773232938;6729.932700673004;6759.966200169017;6679.265280819106;6850.4862135340045;6889.414399775975;6891.104156459678;6905.896411553831;3853.8843834685003;4078.3066878630702;4119.8970025749295;6124.203853499017;6583.407493325623;22054.779452205592;22149.335519934426;22961.77038229613;23124.0750369985;23329.3001209964;2055.095757866534;2168.533765240465;2298.643710224918;2474.5793215153467;2805.1864959161817;14058;14397;14427;14495.27523623825;14876.256187190596;1902.248611798332;1913.9425817225506;1950.5903760210372;1969.0351727653347;1987.3441764217773;79492.21267188116;81920;82117.58941205316;82996;83499.58250208771;16175.595610109605;16184.352625895068;16544.338226471045;16784.664306714043;17275.568110797078;29879;29936.550951735742;30219.848900755795;30261.848690756404;30328.696713033027;8003.119656837744;8344.290735287446;8380.832383352299;8435.662573497115;8538.06081331053;6694.129763130762;6694.564853284521;6786.997835638498;6838.350356716203;6844.110265665432;8343.290820280223;8464.407491475538;8489.235968762841;8535.95732021336;8597.097304782908;3292.8188949607525;3297.3075654112904;3314.983425082859;3354.6078377473564;3405.676460736226;910.7677542226689;911.3028533172129;916.7891384981492;926.1479438916214;974.512743628186;16160.515184544482;16356.427525036805;16456.094914779802;16781.328746850235;16816.663666726843;855.5551113420986;863.7797361672859;884.9292056635454;896.1173244354305;904.3353135445442;9150.679726209552;9364.25085993119;9702.692937781798;9717.56270967794;9738.561764720605;380439;393163;393299;394635;396531;77608;79837.20162798413;79910.6004469974;80195;80355.19644803595;924.3483344242293;929.312308891429;934.3973137326251;953.8473844184897;958.4776296918196;14797.119339506751;14921.104733716013;15191.088534687955;15274.312655930733;15276.388944442098;23708.407289817893;34150.31699366048;34435;34452;34514.30971380508;43752.34371484494;45616.54383456123;46030.76984615056;46191.76904115458;47117.52882471131;7515.774526764206;7807.570583617956;7814.140444550982;7825.256600622932;8064.072631647436;10849.67450976472;11411.828822567502;12273.815892761437;12516.31160286193;12548.121631486074;10472.371657700562;10617.097546708615;10841.457927103456;10997;11095.50070246857;10597;10599.682009539727;10636.734081648021;10785.298955567863;10858;10792.298500597437;10999.670009899715;11059.170562208028;11116;11132.387718675227;7707.499012564165;7875.527468351917;7904.486208396436;8075.192480751878;8090.7168249111;9163.725088247364;10487.52806123711;10520.685449201164;10609.151267898704;10767.946160269463 06:48:18 INFO - PROCESS | 25159 | |3;mootools.html;1242.689327668083;1401.2573336131854;1451.8765904898082;1560.336856835845;1795.434438151982;7532.924670753291;7852.214778522145;7872.173421790708;7874;7875.212478752122;7651.273129052745;7774.950381698483;7799.167195709018;7804.375649948005;7826.178251283619;1847.7782666080022;2201.416624594484;2218.7004754358118;2242.450599603091;2269.035659844568;2203.327984964585;2226.997850967063;2230.609643312422;2230.9107635694554;2231.7768223177713;2170.6526955687095;2215.191455118886;2224.7663995280504;2234.318532847481;2241.652543855705;1866.2721538599958;2181.9236326728646;2229.6209644360497;2239.7760223977634;2241.3388050525136;2143.346279384787;2165.675148727688;2175.8476906616543;2175.8912054397215;2186.8906554672203;7453.85092298151;7504.924950750477;7529.8117547061765;7531.322181003736;7544.283293087148;4574.428196475441;4697.6241900647865;4703.905921881543;4706.987997580537;4726.621870250372;2914.825110493356;2963.096255642028;3026.6821983691616;3029.6515900671484;3053.2366908272934;971.4462756228952;1702.7445883117632;1743.2155530011419;1747.6417334446407;1756.9472915812546;10336;10443.79112417755;10479.318844275098;10492.055714985689;10505.159587233004;3972.523297204354;4055.8377664893073;4163.791810409528;4203.0543127796;4208.558101399371;8333.33333333332;8346.081930987586;8390.664373424994;8399.496030238206;8591.914080859111;4050.23045621331;4723.669343145947;4734.431868175841;4739.052189562101;4739.146953548395;3848.365019771706;3879.1271963807917;3879.7284190106984;4236.322188449895;4400.031992961543;3491.982540087334;3543.6987856032524;3618.751530721949;3692.6861216796337;3713.591504934455;1106.8671759388924;1107.5071593140974;1107.972300692473;1113;1124.2692250037542;867.0592407238091;879.5162660536679;882.0473888200728;887.0198430733946;888.4891187567175;5283.362157731116;5313.335833020872;5447.264619276347;5499.587530935196;5583.944160558423;392.33107551624414;413.1695292462173;416.67499350506654;420.05487652781244;424.0649368143237;3755.1738617504107;3802.334591446486;3811.9809400953372;3865.7680539167177;3867.4972253607416;9420.528973551294;9745.074217949283;9778.706638800848;9852.261080418997;9929.2056635469;9162.129597688208;9625.085616866387;9651.71044868641;9655.662051828152;9672.322937394314;7178.712851485987;7212.134543854666;7285.162206346232;7295;7367.742129025565;5354.598405119709;5590.329160500766;5638.85902852432;5705.686187259575;5811.360750317546;8456.83086338282;8686.609102590524;8828.470291782514;8837.293016558788;8940.642374304955;8971.910280897107;9029.683961061332;9149.77125571866;9270.490123043297;9278.211352034883;6185.876282474415;6873.278305778022;7042.718291268497;7104.289571042855;7183.820404489929;7737.5744334062165;7739.496932699357;7797.454178207471;7808.453408261367;7818.140004599376;6938.653067346713;7078.858422831618;7081.114860642419;7186.60473673932;7207;6980.232174460907;7017.403520700797;7021.05215795861;7033.964830175816;7112.50212485121;6471.611703297817;6508.414242717989;6584.242812076673;6614.867702646016;6624.436922861611;4667.883302917454;4868.245421959602;4882.829100981448;4889.071076495455;4938.506149385033;4677.625789936729;4691.695039822401;4806.303086052572;4883.902321953612;4910.705357678407 06:48:18 INFO - PROCESS | 25159 | |4;prototype.html;313.2575795364984;319.9152224660465;324.8164786895405;328.25649902969764;328.32529152591445;4959.132151873426;4971.925421118686;5006.674566153202;5011.548960593545;5042.974785126078;4657.115148121863;4723.598494128003;4873.731944743037;4968.229924361721;4971.130052240862;3928.7839168845703;3957.56466788653;3959.3071212537907;3964.801759912007;3969.702272329572;3951.9527325258828;3958.129211573449;3960.9009774755573;3960.9603903961024;3967.801609919507;3689.4650275710005;3825.8469661213658;3928.3321835287925;3929.8231579578987;3932.744371615836;3909.8465952544066;3928.3125453045604;3939.72421930465;3942.4086387042175;3950.9012274693077;3477.7739446935866;3484.6341134181052;3512.139525816166;3518.8240587970754;3518.9120271993147;4656.371389862359;4681.789319480597;4740.525947405266;4743.430788305425;4772.713637181745;4444.888877778049;4450.198964186445;4459.910801783979;4471.552844715535;4474.127545128701;5152.639315247934;5161.458046905096;5175.585953123741;5178.870528236786;5204.245384419238;3495.91260218494;3782.2435512897255;3788.981055094707;3798.3542797724176;3800.1639639279592;5351.224072509464;5387.356856158909;5426.403095659474;5434.722840132566;5445.564354851603;3763.2661630981697;3767.7362584618813;3768.510093687803;3774.3772277573894;3784.6026167252594;3829.9808500957315;3839.8080095995088;3841.0781412461365;3841.1357444574746;3846.8461261549783;4144.48193975753;4364.650827933758;4372.868813935587;4380.8685739427865;4384.430024096847;5165.483451654804;5180.197069454241;5195.740212989335;5220.504052115043;5227.18978558324;1224.4877576193394;1278.367208231931;1321.6960099177243;1330.1154732103237;1347.6832944258092;880.471716969813;888.3293113699116;896.2964073202505;900.6487469886749;903.503073309677;4535.160995215896;4542.795574199169;4546.408966834357;4569.748663823521;4575.359449677047;5302.125149350314;5306.071437498499;5317.096093664087;5319.898640037163;5335.599830012765;4437.64498840092;4552.499225085238;4561.817527298937;4567.634589232854;4572.725636461823;2820.5346117890726;2822.7600653944232;2828.179827849942;2832.2494538947194;2838.8438635874813;4891.63573216002;5019.874503137377;5022.472640372781;5024.723640199824;5032.43994361749;5284.7093409862055;5385.219143224211;5410.675359478444;5413.891722165614;5421.186821976735;4991.750412479361;4992.176290911959;4992.775325110306;5019.799208031711;5020.071286811952;5116.620771341344;5273.6044796639635;5278.155495120763;5285;5288.656237344714;5299.429776558289;5327.254184414108;5327.9733601331745;5328.49379308965;5333.173358129496;5130.7178105204575;5147.639665223398;5151.253068305;5151.4590967949325;5161.638685291993;3544;3781.9810900945317;3813.447050177653;3818.427235914635;3821;5317.548008419173;5325.653832500875;5325.973370133124;5326.280952071421;5326.493983071602;5134.12719837621;5143.562797162133;5163.302954101148;5168.870778230575;5185.810726403311;4971.613625459727;5118.616103792156;5136.97431512855;5152.896942061213;5182.144946083854;4812.133815913169;5012.548870601663;5022.447530771686;5069.555176774602;5084.26278189653;5089.643724939367;5146.356705411824;5148.922766158586;5228.895422091613;5230.529252367305;5104.387473503203;5119.820806271762;5132.948670513247;5153.793848246029;5157.484251574812 06:48:18 INFO - PROCESS | 25159 | |5;yui.html;649.1496140056524;651.4462706699303;670.7048898484667;687.3195536418943;716.802879208218;10939.726506837333;10952.123830093593;11132.833007504894;11368.317900925951;11527.769444611113;10784.46077696116;10797.46012699364;10805.83791243132;10822.24244302899;10824.18818588605;642.7814543055383;813.0446725098016;819.6516480495795;824.6206744897324;825.3850881093564;796.760971708488;820.9384296177781;826.1944604011071;826.4834478450969;828.7016673997356;852.1138016462871;859.5916939453772;859.8151397449548;860.3977215948829;864.5893200729666;669.6618207805027;835.6532039203723;854.2824027816632;855.9101294364065;859.072202021815;620.1720702861685;620.9596376235576;621.0559948877681;621.071498110328;623.7349126621214;11334.829977550344;11371;11390.658280251606;11390.829137562943;11406.31562106268;11914.940425297818;12299;12420.937895310555;12460.875391246153;12584.68538286541;9134.223590994774;9151.313651476166;9575.329726919119;9633.325667203299;9723.902760972442;2898.2899189698446;2922.167182353019;2967.7032296770367;3147.401993621205;3457.8271086445575;43921.34117988233;48479.27281090787;48491;48524.51475485235;48642.75678621584;9763.853542196874;9922.80154396908;10035.548400322003;10073.69778906634;10089.848652270222;16652.83347166537;16792.58018549546;16797.580060498585;16804.075775832447;16810.495685129466;5943.58394912352;5986.5809393342915;6014.458698717136;6109.358517355614;6138.219916224334;3442.535257740223;3444.0873168610337;3455.3434847378917;3466.7399945004227;3476.8261586920553;2738.4659991301905;2822.2662107852107;2825.9152225433268;2831.844248566307;2832.7025662305573;504.3418339067552;516.377764793423;518.2226660009985;518.3313525552071;522.3548917087394;519.3430310657022;580.2051189869906;581.2211636407235;590.8552404660885;609.4849851875158;7448.590327532038;7595.240475952361;7618.733344333033;7747.457677962489;7845.137034926153;465.9394278743742;561.1386521689187;562.460038363176;578.2251782611321;596.7195418153461;3584.354816133069;3631.219287853124;3662.230931504361;3696.2792255510453;3733.160038991205;45234.77382613066;46533.76733116313;46883;55762;56490.435095649336;42141.78929105335;42910;44175.77912110483;44306.55693443089;45158.77420612942;39811;40532.59467405347;40814.183716325504;41115.58884411177;41171.38242926358;7809.492382995087;7885.881711774213;7893.210678932061;7919.604019799102;8028;25523.87238063798;25754.613680795177;26688.733112668626;26840.59739103954;26871.731282687706;28136.15591532257;34070.48894266637;35727.64272357243;35830;36277.81861090783;10013;10150.289479736348;10168.389896606228;10213.693589192337;10513.842292365467;11290.548378064785;11334.659960201207;11370.658880233606;11419.195898704209;11709.473073711533;9931.65239216624;9967.202623790225;10958.397288149228;11097.667069987914;11236.606718765132;10120.949395252977;10169.89830101719;10380;10641.733956650836;10694.73263168427;10227.43749093807;10461.476926153815;10735;11169;11502.597409090642;9772.218222542322;9866.16137628281;9985.650502232387;10098.343607665478;10200.540975655966;9467.763305917408;9494.620215191315;9563.426194428357;9781.559829807533;9800.558974846292 06:48:18 INFO - PROCESS | 25159 | __end_tp_report 06:48:18 INFO - PROCESS | 25159 | __start_cc_report 06:48:18 INFO - PROCESS | 25159 | _x_x_mozilla_cycle_collect,1089 06:48:18 INFO - PROCESS | 25159 | __end_cc_report 06:48:18 INFO - PROCESS | 25159 | __startTimestamp1461332898252__endTimestamp 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | ------- Summary: start ------- 06:48:18 INFO - PROCESS | 25159 | Number of tests: 6 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#0] dojo.html Cycles:165 Average:4537.91 Median:4657.98 stddev:457.31 (9.8%) stddev-sans-first:431.73 06:48:18 INFO - PROCESS | 25159 | Values: 2565.3 2604.2 2613.7 2619.1 2640.9 4401.9 4494.2 4541.0 4578.7 4597.1 4508.7 4570.9 4619.0 4654.6 4665.2 4252.0 4275.4 4293.7 4319.5 4361.2 4230.2 4281.5 4338.9 4384.9 4389.1 4128.7 4203.2 4305.2 4342.5 4343.6 4180.6 4183.6 4223.5 4235.9 4252.2 4218.1 4233.0 4233.8 4247.2 4277.1 4333.0 4460.6 4476.2 4490.1 4525.8 4903.5 4932.6 4939.7 4955.8 4983.0 4929.5 4933.7 4948.7 4954.9 4962.7 4474.5 4578.1 4616.4 4619.3 4656.4 4921.6 4935.8 4947.2 4948.7 4986.8 4759.1 4760.8 4770.7 4779.5 4803.0 4730.9 4839.7 4892.1 4902.9 4919.7 4852.8 4877.8 4890.9 4894.2 4920.5 4868.9 4871.2 4878.5 4882.5 4898.8 4031.7 4096.1 4146.3 4192.6 4230.8 3643.1 3651.4 3684.0 3696.4 3726.9 4247.5 4250.6 4255.1 4259.4 4298.2 4747.9 4917.4 4929.1 4938.5 4996.8 4255.4 4276.5 4278.4 4297.6 4323.3 4453.7 4476.1 4478.7 4485.3 4522.0 4488.7 4658.0 4726.9 4728.2 4736.3 4916.0 4927.9 4940.4 4947.0 4964.0 4684.7 4697.5 4704.1 4709.6 4761.8 4670.0 4849.6 4883.8 4921.3 4933.3 4872.5 4873.5 4882.9 4887.0 4946.5 4561.4 4721.0 4766.4 4768.8 4813.8 4737.9 4776.1 4781.0 4798.4 4828.0 4640.8 4670.9 4671.9 4674.0 4723.8 4593.2 4738.5 4772.4 4808.8 4817.4 4608.4 4620.2 4623.4 4653.9 4668.0 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#1] ext.html Cycles:180 Average:42754.10 Median:194539.00 stddev:77235.76 (39.7%) stddev-sans-first:77387.49 06:48:18 INFO - PROCESS | 25159 | Values: 572.3 592.8 604.2 620.6 629.9 34292.3 35332.8 35363.0 35404.9 35467.0 36328.0 36916.6 37010.0 37035.6 37127.0 7581.8 7798.6 7804.0 7805.1 7809.2 7575.9 7690.0 7698.5 7846.6 7868.4 7850.3 7928.4 7928.6 7929.0 7934.2 7852.0 7867.4 7909.2 7910.2 7912.6 7854.8 7944.2 7945.8 7948.7 7952.0 37372.3 37549.6 37867.4 37876.3 37893.6 3283.8 3439.6 3742.1 3756.6 3835.4 28242.7 28779.6 29190.0 29206.6 29596.4 3326.0 3360.5 3380.3 3393.5 3435.1 223816.0 291117.0 297347.0 297922.5 299309.0 32798.8 51043.7 51383.7 51423.5 51579.7 33472.7 33805.7 33811.0 33816.3 33818.8 12254.8 12444.2 12447.2 12450.9 12455.8 9773.1 9820.1 9831.1 9833.9 9838.3 8046.1 8124.1 8133.9 8202.5 8212.1 3195.4 3233.3 3242.7 3252.7 3263.1 935.6 976.4 984.3 990.1 994.9 27656.2 27770.0 28419.6 28585.6 28712.1 953.0 1014.8 1052.4 1079.4 1114.1 14436.6 15053.5 15130.0 15300.2 15412.9 353715.0 359928.0 361026.0 361027.0 361027.0 47252.0 48108.5 48109.5 48147.5 48166.8 1057.3 1123.5 1127.7 1229.2 1259.2 24526.6 26762.9 27129.6 27269.2 27616.3 37796.2 38018.4 38235.0 38294.2 38326.6 218678.0 219330.0 220472.0 220988.0 221175.0 22398.6 22467.9 22761.2 22779.2 25713.6 35569.5 35752.1 35913.1 36073.0 36325.1 31941.4 32822.7 34327.7 34686.8 35830.0 33604.7 33683.2 33892.3 34120.8 34338.5 31168.0 33954.2 36971.3 38647.6 38775.0 28668.3 31061.8 31222.5 31544.2 31559.7 23599.3 24049.6 24207.4 24649.5 24673.9 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#2] jquery.html Cycles:180 Average:25704.98 Median:196777.44 stddev:64736.17 (32.9%) stddev-sans-first:64889.84 06:48:18 INFO - PROCESS | 25159 | Values: 376.1 377.7 382.7 387.5 391.9 15872.7 16063.0 17102.4 17112.7 17146.2 16936.9 17606.4 17671.8 17899.8 17904.3 5593.3 5736.8 5758.5 5777.5 5779.7 3990.0 4995.0 6690.5 6727.4 6735.5 6564.8 6639.7 6720.8 6729.9 6760.0 6679.3 6850.5 6889.4 6891.1 6905.9 3853.9 4078.3 4119.9 6124.2 6583.4 22054.8 22149.3 22961.8 23124.1 23329.3 2055.1 2168.5 2298.6 2474.6 2805.2 14058.0 14397.0 14427.0 14495.3 14876.3 1902.2 1913.9 1950.6 1969.0 1987.3 79492.2 81920.0 82117.6 82996.0 83499.6 16175.6 16184.4 16544.3 16784.7 17275.6 29879.0 29936.6 30219.8 30261.8 30328.7 8003.1 8344.3 8380.8 8435.7 8538.1 6694.1 6694.6 6787.0 6838.4 6844.1 8343.3 8464.4 8489.2 8536.0 8597.1 3292.8 3297.3 3315.0 3354.6 3405.7 910.8 911.3 916.8 926.1 974.5 16160.5 16356.4 16456.1 16781.3 16816.7 855.6 863.8 884.9 896.1 904.3 9150.7 9364.3 9702.7 9717.6 9738.6 380439.0 393163.0 393299.0 394635.0 396531.0 77608.0 79837.2 79910.6 80195.0 80355.2 924.3 929.3 934.4 953.8 958.5 14797.1 14921.1 15191.1 15274.3 15276.4 23708.4 34150.3 34435.0 34452.0 34514.3 43752.3 45616.5 46030.8 46191.8 47117.5 7515.8 7807.6 7814.1 7825.3 8064.1 10849.7 11411.8 12273.8 12516.3 12548.1 10472.4 10617.1 10841.5 10997.0 11095.5 10597.0 10599.7 10636.7 10785.3 10858.0 10792.3 10999.7 11059.2 11116.0 11132.4 7707.5 7875.5 7904.5 8075.2 8090.7 9163.7 10487.5 10520.7 10609.2 10767.9 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#3] mootools.html Cycles:180 Average:5186.76 Median:4886.49 stddev:2851.59 (58.4%) stddev-sans-first:2844.18 06:48:18 INFO - PROCESS | 25159 | Values: 1242.7 1401.3 1451.9 1560.3 1795.4 7532.9 7852.2 7872.2 7874.0 7875.2 7651.3 7775.0 7799.2 7804.4 7826.2 1847.8 2201.4 2218.7 2242.5 2269.0 2203.3 2227.0 2230.6 2230.9 2231.8 2170.7 2215.2 2224.8 2234.3 2241.7 1866.3 2181.9 2229.6 2239.8 2241.3 2143.3 2165.7 2175.8 2175.9 2186.9 7453.9 7504.9 7529.8 7531.3 7544.3 4574.4 4697.6 4703.9 4707.0 4726.6 2914.8 2963.1 3026.7 3029.7 3053.2 971.4 1702.7 1743.2 1747.6 1756.9 10336.0 10443.8 10479.3 10492.1 10505.2 3972.5 4055.8 4163.8 4203.1 4208.6 8333.3 8346.1 8390.7 8399.5 8591.9 4050.2 4723.7 4734.4 4739.1 4739.1 3848.4 3879.1 3879.7 4236.3 4400.0 3492.0 3543.7 3618.8 3692.7 3713.6 1106.9 1107.5 1108.0 1113.0 1124.3 867.1 879.5 882.0 887.0 888.5 5283.4 5313.3 5447.3 5499.6 5583.9 392.3 413.2 416.7 420.1 424.1 3755.2 3802.3 3812.0 3865.8 3867.5 9420.5 9745.1 9778.7 9852.3 9929.2 9162.1 9625.1 9651.7 9655.7 9672.3 7178.7 7212.1 7285.2 7295.0 7367.7 5354.6 5590.3 5638.9 5705.7 5811.4 8456.8 8686.6 8828.5 8837.3 8940.6 8971.9 9029.7 9149.8 9270.5 9278.2 6185.9 6873.3 7042.7 7104.3 7183.8 7737.6 7739.5 7797.5 7808.5 7818.1 6938.7 7078.9 7081.1 7186.6 7207.0 6980.2 7017.4 7021.1 7034.0 7112.5 6471.6 6508.4 6584.2 6614.9 6624.4 4667.9 4868.2 4882.8 4889.1 4938.5 4677.6 4691.7 4806.3 4883.9 4910.7 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#4] prototype.html Cycles:180 Average:4311.09 Median:4963.68 stddev:1240.90 (25.0%) stddev-sans-first:1207.55 06:48:18 INFO - PROCESS | 25159 | Values: 313.3 319.9 324.8 328.3 328.3 4959.1 4971.9 5006.7 5011.5 5043.0 4657.1 4723.6 4873.7 4968.2 4971.1 3928.8 3957.6 3959.3 3964.8 3969.7 3952.0 3958.1 3960.9 3961.0 3967.8 3689.5 3825.8 3928.3 3929.8 3932.7 3909.8 3928.3 3939.7 3942.4 3950.9 3477.8 3484.6 3512.1 3518.8 3518.9 4656.4 4681.8 4740.5 4743.4 4772.7 4444.9 4450.2 4459.9 4471.6 4474.1 5152.6 5161.5 5175.6 5178.9 5204.2 3495.9 3782.2 3789.0 3798.4 3800.2 5351.2 5387.4 5426.4 5434.7 5445.6 3763.3 3767.7 3768.5 3774.4 3784.6 3830.0 3839.8 3841.1 3841.1 3846.8 4144.5 4364.7 4372.9 4380.9 4384.4 5165.5 5180.2 5195.7 5220.5 5227.2 1224.5 1278.4 1321.7 1330.1 1347.7 880.5 888.3 896.3 900.6 903.5 4535.2 4542.8 4546.4 4569.7 4575.4 5302.1 5306.1 5317.1 5319.9 5335.6 4437.6 4552.5 4561.8 4567.6 4572.7 2820.5 2822.8 2828.2 2832.2 2838.8 4891.6 5019.9 5022.5 5024.7 5032.4 5284.7 5385.2 5410.7 5413.9 5421.2 4991.8 4992.2 4992.8 5019.8 5020.1 5116.6 5273.6 5278.2 5285.0 5288.7 5299.4 5327.3 5328.0 5328.5 5333.2 5130.7 5147.6 5151.3 5151.5 5161.6 3544.0 3782.0 3813.4 3818.4 3821.0 5317.5 5325.7 5326.0 5326.3 5326.5 5134.1 5143.6 5163.3 5168.9 5185.8 4971.6 5118.6 5137.0 5152.9 5182.1 4812.1 5012.5 5022.4 5069.6 5084.3 5089.6 5146.4 5148.9 5228.9 5230.5 5104.4 5119.8 5132.9 5153.8 5157.5 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - PROCESS | 25159 | [#5] yui.html Cycles:180 Average:12177.48 Median:44048.56 stddev:13851.02 (31.4%) stddev-sans-first:13862.82 06:48:18 INFO - PROCESS | 25159 | Values: 649.1 651.4 670.7 687.3 716.8 10939.7 10952.1 11132.8 11368.3 11527.8 10784.5 10797.5 10805.8 10822.2 10824.2 642.8 813.0 819.7 824.6 825.4 796.8 820.9 826.2 826.5 828.7 852.1 859.6 859.8 860.4 864.6 669.7 835.7 854.3 855.9 859.1 620.2 621.0 621.1 621.1 623.7 11334.8 11371.0 11390.7 11390.8 11406.3 11914.9 12299.0 12420.9 12460.9 12584.7 9134.2 9151.3 9575.3 9633.3 9723.9 2898.3 2922.2 2967.7 3147.4 3457.8 43921.3 48479.3 48491.0 48524.5 48642.8 9763.9 9922.8 10035.5 10073.7 10089.8 16652.8 16792.6 16797.6 16804.1 16810.5 5943.6 5986.6 6014.5 6109.4 6138.2 3442.5 3444.1 3455.3 3466.7 3476.8 2738.5 2822.3 2825.9 2831.8 2832.7 504.3 516.4 518.2 518.3 522.4 519.3 580.2 581.2 590.9 609.5 7448.6 7595.2 7618.7 7747.5 7845.1 465.9 561.1 562.5 578.2 596.7 3584.4 3631.2 3662.2 3696.3 3733.2 45234.8 46533.8 46883.0 55762.0 56490.4 42141.8 42910.0 44175.8 44306.6 45158.8 39811.0 40532.6 40814.2 41115.6 41171.4 7809.5 7885.9 7893.2 7919.6 8028.0 25523.9 25754.6 26688.7 26840.6 26871.7 28136.2 34070.5 35727.6 35830.0 36277.8 10013.0 10150.3 10168.4 10213.7 10513.8 11290.5 11334.7 11370.7 11419.2 11709.5 9931.7 9967.2 10958.4 11097.7 11236.6 10120.9 10169.9 10380.0 10641.7 10694.7 10227.4 10461.5 10735.0 11169.0 11502.6 9772.2 9866.2 9985.7 10098.3 10200.5 9467.8 9494.6 9563.4 9781.6 9800.6 06:48:18 INFO - PROCESS | 25159 | -------- Summary: end -------- 06:48:18 INFO - PROCESS | 25159 | 06:48:18 INFO - TEST-INFO | 25159: exit 0 06:48:19 INFO - TEST-OK | dromaeo_css | took 1118302ms 06:48:19 INFO - TEST-START | kraken 06:48:19 INFO - operating with platform_type : linux_ 06:48:19 INFO - Initialising browser for kraken test... 06:48:19 INFO - TEST-INFO | started process 25333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpklhiUY/profile http://localhost:47915/getInfo.html) 06:48:23 INFO - PROCESS | 25333 | __metrics Screen width/height:1600/1200 06:48:23 INFO - PROCESS | 25333 | colorDepth:24 06:48:23 INFO - PROCESS | 25333 | Browser inner width/height: 1024/697 06:48:23 INFO - PROCESS | 25333 | __metrics 06:48:24 ERROR - PROCESS | 25333 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:25 INFO - TEST-INFO | 25333: exit 0 06:48:25 INFO - Browser initialized. 06:48:25 INFO - Running cycle 1/1 for kraken test... 06:48:25 INFO - TEST-INFO | started process 25416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpklhiUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:37 INFO - PROCESS | 25416 | RSS: Main: 155095040 06:48:37 INFO - PROCESS | 25416 | 06:48:39 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:40 INFO - PROCESS | 25416 | RSS: Main: 209776640 06:48:40 INFO - PROCESS | 25416 | 06:48:43 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-dft) 06:48:44 INFO - PROCESS | 25416 | RSS: Main: 194977792 06:48:44 INFO - PROCESS | 25416 | 06:48:47 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-fft) 06:48:48 INFO - PROCESS | 25416 | RSS: Main: 266076160 06:48:48 INFO - PROCESS | 25416 | 06:48:50 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-oscillator) 06:48:50 INFO - PROCESS | 25416 | RSS: Main: 173985792 06:48:50 INFO - PROCESS | 25416 | 06:48:52 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:53 INFO - PROCESS | 25416 | RSS: Main: 178917376 06:48:53 INFO - PROCESS | 25416 | 06:48:56 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:57 INFO - PROCESS | 25416 | RSS: Main: 214286336 06:48:57 INFO - PROCESS | 25416 | 06:49:00 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:01 INFO - PROCESS | 25416 | RSS: Main: 212193280 06:49:01 INFO - PROCESS | 25416 | 06:49:04 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47915/tests/kraken/driver.html?testName=json-parse-financial) 06:49:04 INFO - PROCESS | 25416 | RSS: Main: 213495808 06:49:04 INFO - PROCESS | 25416 | 06:49:06 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:07 INFO - PROCESS | 25416 | RSS: Main: 199168000 06:49:07 INFO - PROCESS | 25416 | 06:49:09 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:09 INFO - PROCESS | 25416 | RSS: Main: 204378112 06:49:09 INFO - PROCESS | 25416 | 06:49:11 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:12 INFO - PROCESS | 25416 | RSS: Main: 219672576 06:49:12 INFO - PROCESS | 25416 | 06:49:15 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:15 INFO - PROCESS | 25416 | RSS: Main: 222826496 06:49:15 INFO - PROCESS | 25416 | 06:49:18 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:19 INFO - PROCESS | 25416 | RSS: Main: 216174592 06:49:19 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47915/tests/kraken/driver.html?testName=ai-astar) 06:49:21 INFO - PROCESS | 25416 | RSS: Main: 280092672 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | __start_tp_report 06:49:21 INFO - PROCESS | 25416 | _x_x_mozilla_page_load 06:49:21 INFO - PROCESS | 25416 | _x_x_mozilla_page_load_details 06:49:21 INFO - PROCESS | 25416 | |i|pagename|runs| 06:49:21 INFO - PROCESS | 25416 | |0;ai-astar;112;113;106;112;113;112;103;112;111;112 06:49:21 INFO - PROCESS | 25416 | |1;audio-beat-detection;161;144;155;192;133;155;176;136;199;141 06:49:21 INFO - PROCESS | 25416 | |2;audio-dft;162;163;162;162;163;162;161;161;160;161 06:49:21 INFO - PROCESS | 25416 | |3;audio-fft;74;74;105;116;73;73;72;122;107;75 06:49:21 INFO - PROCESS | 25416 | |4;audio-oscillator;93;94;148;94;94;96;154;94;93;154 06:49:21 INFO - PROCESS | 25416 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 06:49:21 INFO - PROCESS | 25416 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;147;147 06:49:21 INFO - PROCESS | 25416 | |7;imaging-desaturate;94;94;94;95;95;94;94;94;95;95 06:49:21 INFO - PROCESS | 25416 | |8;json-parse-financial;65;65;65;63;65;64;64;82;64;62 06:49:21 INFO - PROCESS | 25416 | |9;json-stringify-tinderbox;64;65;64;64;65;65;64;64;65;65 06:49:21 INFO - PROCESS | 25416 | |10;stanford-crypto-aes;78;79;77;86;79;80;80;80;80;80 06:49:21 INFO - PROCESS | 25416 | |11;stanford-crypto-ccm;131;139;139;134;129;130;131;133;162;134 06:49:21 INFO - PROCESS | 25416 | |12;stanford-crypto-pbkdf2;172;170;168;171;173;171;174;171;172;170 06:49:21 INFO - PROCESS | 25416 | |13;stanford-crypto-sha256-iterative;74;72;76;73;72;71;72;74;70;69 06:49:21 INFO - PROCESS | 25416 | __end_tp_report 06:49:21 INFO - PROCESS | 25416 | __start_cc_report 06:49:21 INFO - PROCESS | 25416 | _x_x_mozilla_cycle_collect,1886 06:49:21 INFO - PROCESS | 25416 | __end_cc_report 06:49:21 INFO - PROCESS | 25416 | __startTimestamp1461332961444__endTimestamp 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | ------- Summary: start ------- 06:49:21 INFO - PROCESS | 25416 | Number of tests: 14 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.34 (3.0%) stddev-sans-first:3.50 06:49:21 INFO - PROCESS | 25416 | Values: 112.0 113.0 106.0 112.0 113.0 112.0 103.0 112.0 111.0 112.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#1] audio-beat-detection Cycles:10 Average:159.20 Median:158.00 stddev:23.02 (14.6%) stddev-sans-first:24.40 06:49:21 INFO - PROCESS | 25416 | Values: 161.0 144.0 155.0 192.0 133.0 155.0 176.0 136.0 199.0 141.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 06:49:21 INFO - PROCESS | 25416 | Values: 162.0 163.0 162.0 162.0 163.0 162.0 161.0 161.0 160.0 161.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:20.67 (28.3%) stddev-sans-first:21.19 06:49:21 INFO - PROCESS | 25416 | Values: 74.0 74.0 105.0 116.0 73.0 73.0 72.0 122.0 107.0 75.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:94.00 stddev:28.08 (29.9%) stddev-sans-first:28.98 06:49:21 INFO - PROCESS | 25416 | Values: 93.0 94.0 148.0 94.0 94.0 96.0 154.0 94.0 93.0 154.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:49:21 INFO - PROCESS | 25416 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:49:21 INFO - PROCESS | 25416 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:49:21 INFO - PROCESS | 25416 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:5.74 (8.8%) stddev-sans-first:6.08 06:49:21 INFO - PROCESS | 25416 | Values: 65.0 65.0 65.0 63.0 65.0 64.0 64.0 82.0 64.0 62.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 06:49:21 INFO - PROCESS | 25416 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:2.38 (3.0%) stddev-sans-first:2.42 06:49:21 INFO - PROCESS | 25416 | Values: 78.0 79.0 77.0 86.0 79.0 80.0 80.0 80.0 80.0 80.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:134.00 stddev:9.69 (7.2%) stddev-sans-first:10.10 06:49:21 INFO - PROCESS | 25416 | Values: 131.0 139.0 139.0 134.0 129.0 130.0 131.0 133.0 162.0 134.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:1.69 (1.0%) stddev-sans-first:1.76 06:49:21 INFO - PROCESS | 25416 | Values: 172.0 170.0 168.0 171.0 173.0 171.0 174.0 171.0 172.0 170.0 06:49:21 INFO - PROCESS | 25416 | 06:49:21 INFO - PROCESS | 25416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:2.06 (2.8%) stddev-sans-first:2.09 06:49:21 INFO - PROCESS | 25416 | Values: 74.0 72.0 76.0 73.0 72.0 71.0 72.0 74.0 70.0 69.0 06:49:21 INFO - PROCESS | 25416 | -------- Summary: end -------- 06:49:21 INFO - PROCESS | 25416 | 06:49:22 INFO - TEST-INFO | 25416: exit 0 06:49:22 INFO - TEST-OK | kraken | took 63452ms 06:49:22 INFO - SUITE-END | took 1181s 06:49:22 INFO - Completed test suite (00:19:41) 06:49:22 INFO - javascript benchmark 06:49:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.2945440004, 2604.2187343796854, 2613.6602241708574, 2619.083320837707, 2640.8547529885855, 4401.911961760763, 4494.168578812922, 4540.977295113524, 4578.748168850716, 4597.103564804868, 4508.729476231429, 4570.931436028454, 4619.0, 4654.557817007388, 4665.206914824479, 4251.957480425195, 4275.380069889879, 4293.720908140961, 4319.481662200525, 4361.214981303364, 4230.19626271009, 4281.529031806499, 4338.934915976263, 4384.89037774055, 4389.122175564884, 4128.669706423479, 4203.222403855266, 4305.246581848195, 4342.544032876534, 4343.630791382736, 4180.644645205161, 4183.602557757008, 4223.514295855985, 4235.894102647459, 4252.192083504125, 4218.093109981338, 4233.0, 4233.788310584489, 4247.214265360918, 4277.059047009653, 4333.046729719456, 4460.553944605514, 4476.171908196961, 4490.124425736983, 4525.818967241306, 4903.53416425439, 4932.630052746023, 4939.728314942677, 4955.776990035421, 4982.975085124587, 4929.531694489017, 4933.70397776131, 4948.678335908155, 4954.9009019819405, 4962.702237865704, 4474.530174331649, 4578.107269082497, 4616.3537104805355, 4619.330197121432, 4656.3946686930485, 4921.581665558396, 4935.827246046371, 4947.183714687037, 4948.6783359082265, 4986.825461108844, 4759.095771803415, 4760.7619619018915, 4770.666053376231, 4779.522047795263, 4803.03939212159, 4730.905381892343, 4839.7096174229655, 4892.094962431962, 4902.896848209124, 4919.680220785637, 4852.757362131879, 4877.829275975324, 4890.926636100461, 4894.241392584155, 4920.483349248278, 4868.853934381974, 4871.244957031666, 4878.487758785347, 4882.536159064884, 4898.804047838118, 4031.657309128757, 4096.139810639799, 4146.295129827937, 4192.643625291885, 4230.767307798039, 3643.143861192618, 3651.415773476231, 3683.9815800920824, 3696.445533170046, 3726.9440958385644, 4247.51153617338, 4250.553691862372, 4255.063885945087, 4259.424977628042, 4298.247806633826, 4747.8575642730775, 4917.409910810726, 4929.06347793918, 4938.506149385033, 4996.775145118479, 4255.3829694694095, 4276.465441819772, 4278.358246263023, 4297.59172878576, 4323.286657701444, 4453.710508816916, 4476.082403107355, 4478.664100192498, 4485.349624304523, 4521.954780452219, 4488.730676159375, 4657.976710116428, 4726.929096063493, 4728.219843725816, 4736.265878788793, 4916.0, 4927.852164435073, 4940.357753492023, 4946.950530494649, 4964.032013757283, 4684.672072954861, 4697.459792123813, 4704.059188162313, 4709.623230141512, 4761.809527618856, 4670.042641258602, 4849.636277279289, 4883.8290659826735, 4921.2864134700985, 4933.33399991011, 4872.537108974641, 4873.4639189689815, 4882.852529655599, 4886.951130488792, 4946.530079642428, 4561.3614094027525, 4721.00858819638, 4766.356541866804, 4768.833090841804, 4813.831515896927, 4737.9052418952115, 4776.116418462596, 4780.95219047805, 4798.352222450064, 4827.975860120677, 4640.837570685145, 4670.906581868411, 4671.906561868812, 4673.976630116827, 4723.763811809327, 4593.242115050979, 4738.526147385234, 4772.379590653193, 4808.831690890802, 4817.397825271841, 4608.35483032369, 4620.168369693488, 4623.3758442609815, 4653.930191047205, 4668.0197158597075], "value": 4509.945259353847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3075079154223, 592.8191901470053, 604.1843511259797, 620.633826042635, 629.8645791154901, 34292.314153716914, 35332.82333588329, 35363.0, 35404.93785186445, 35467.0, 36328.0, 36916.63083369172, 37010.0, 37035.629643703556, 37127.0, 7581.772546823604, 7798.571078590704, 7804.024496937883, 7805.141434442206, 7809.180036096213, 7575.886361704579, 7689.961550192241, 7698.461107722462, 7846.607669616525, 7868.4098692598, 7850.3327217186325, 7928.445008849383, 7928.643211055516, 7929.0, 7934.166912474194, 7852.0, 7867.409944254204, 7909.209079092102, 7910.248526389983, 7912.64393102306, 7854.8429031419055, 7944.205579442068, 7945.841083178304, 7948.682052717884, 7952.0, 37372.25255494875, 37549.62450375489, 37867.43198852019, 37876.29556669956, 37893.621063789564, 3283.770136090475, 3439.6216416194197, 3742.101895545077, 3756.643118903727, 3835.4055121456217, 28242.717572824215, 28779.56830647542, 29190.0, 29206.561901571495, 29596.408071838443, 3326.0, 3360.462326027824, 3380.3070370573973, 3393.52490651309, 3435.12404336895, 223816.0, 291117.0, 297347.0, 297922.5103874488, 299309.0, 32798.836005819816, 51043.744781275855, 51383.74308128435, 51423.48576514262, 51579.74210129, 33472.66527334744, 33805.66194338025, 33810.95701386887, 33816.32367352688, 33818.830905845316, 12254.75490490203, 12444.19112757686, 12447.190932589352, 12450.937745311216, 12455.75088498225, 9773.07155820196, 9820.067093626094, 9831.115199632068, 9833.901660983442, 9838.311318207656, 8046.114927357986, 8124.065732440727, 8133.918660813434, 8202.548859812649, 8212.137725538852, 3195.4248235317864, 3233.288676491168, 3242.7243684286627, 3252.658470860573, 3263.102646772109, 935.6491315756591, 976.3857817549093, 984.3159004491953, 990.0891180114169, 994.9303548751518, 27656.170314890587, 27770.0, 28419.57370639442, 28585.57121643177, 28712.138635840958, 952.9761755956157, 1014.7564584499814, 1052.3843551522293, 1079.4225089577196, 1114.0808832713044, 14436.639084022983, 15053.473128440452, 15130.0, 15300.234988250542, 15412.922935385252, 353715.0, 359928.0, 361026.0, 361027.0, 361027.0, 47252.0, 48108.518914810404, 48109.5189048105, 48147.518524815, 48166.75916620394, 1057.3444464432102, 1123.455124264731, 1127.6842484104463, 1229.2194456520174, 1259.2444533279959, 24526.63210051815, 26762.866185668947, 27129.58942803337, 27269.181924542296, 27616.309592260353, 37796.24407511889, 38018.42972355472, 38235.0, 38294.234115316984, 38326.61673383231, 218678.0, 219330.0, 220472.0, 220988.0, 221175.0, 22398.552028959657, 22467.88766056159, 22761.203357882394, 22779.202727904445, 25713.614295785203, 35569.46645800264, 35752.106197344234, 35913.1021724459, 36073.0, 36325.09187270234, 31941.36117277688, 32822.67177328196, 34327.65672343245, 34686.826565867006, 35830.0, 33604.663953360156, 33683.15792105217, 33892.32215355728, 34120.829395853856, 34338.48492272568, 31168.0, 33954.15114622055, 36971.26057478889, 38647.6135238644, 38775.0, 28668.283292917844, 31061.8446907764, 31222.531662025543, 31544.211394715316, 31559.684403156592, 23599.29202123939, 24049.639255411534, 24207.394815129057, 24649.507009860063, 24673.87663061673], "value": 16007.227277083883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.13676612175055, 377.6902939589537, 382.7225261685277, 387.4923849756819, 391.8706826747174, 15872.682546349066, 16063.0, 17102.401415950444, 17112.657746845085, 17146.228419721097, 16936.89910155839, 17606.38377656782, 17671.823281767178, 17899.821001789976, 17904.28382864684, 5593.300837395325, 5736.827895163131, 5758.510526605243, 5777.451142141511, 5779.682117483537, 3989.98005009976, 4994.97502512487, 6690.464762818963, 6727.428168605675, 6735.461163106964, 6564.803055908306, 6639.73441062357, 6720.764773232938, 6729.932700673004, 6759.966200169017, 6679.265280819106, 6850.4862135340045, 6889.414399775975, 6891.104156459678, 6905.896411553831, 3853.8843834685003, 4078.3066878630702, 4119.8970025749295, 6124.203853499017, 6583.407493325623, 22054.779452205592, 22149.335519934426, 22961.77038229613, 23124.0750369985, 23329.3001209964, 2055.095757866534, 2168.533765240465, 2298.643710224918, 2474.5793215153467, 2805.1864959161817, 14058.0, 14397.0, 14427.0, 14495.27523623825, 14876.256187190596, 1902.248611798332, 1913.9425817225506, 1950.5903760210372, 1969.0351727653347, 1987.3441764217773, 79492.21267188116, 81920.0, 82117.58941205316, 82996.0, 83499.58250208771, 16175.595610109605, 16184.352625895068, 16544.338226471045, 16784.664306714043, 17275.568110797078, 29879.0, 29936.550951735742, 30219.848900755795, 30261.848690756404, 30328.696713033027, 8003.119656837744, 8344.290735287446, 8380.832383352299, 8435.662573497115, 8538.06081331053, 6694.129763130762, 6694.564853284521, 6786.997835638498, 6838.350356716203, 6844.110265665432, 8343.290820280223, 8464.407491475538, 8489.235968762841, 8535.95732021336, 8597.097304782908, 3292.8188949607525, 3297.3075654112904, 3314.983425082859, 3354.6078377473564, 3405.676460736226, 910.7677542226689, 911.3028533172129, 916.7891384981492, 926.1479438916214, 974.512743628186, 16160.515184544482, 16356.427525036805, 16456.094914779802, 16781.328746850235, 16816.663666726843, 855.5551113420986, 863.7797361672859, 884.9292056635454, 896.1173244354305, 904.3353135445442, 9150.679726209552, 9364.25085993119, 9702.692937781798, 9717.56270967794, 9738.561764720605, 380439.0, 393163.0, 393299.0, 394635.0, 396531.0, 77608.0, 79837.20162798413, 79910.6004469974, 80195.0, 80355.19644803595, 924.3483344242293, 929.312308891429, 934.3973137326251, 953.8473844184897, 958.4776296918196, 14797.119339506751, 14921.104733716013, 15191.088534687955, 15274.312655930733, 15276.388944442098, 23708.407289817893, 34150.31699366048, 34435.0, 34452.0, 34514.30971380508, 43752.34371484494, 45616.54383456123, 46030.76984615056, 46191.76904115458, 47117.52882471131, 7515.774526764206, 7807.570583617956, 7814.140444550982, 7825.256600622932, 8064.072631647436, 10849.67450976472, 11411.828822567502, 12273.815892761437, 12516.31160286193, 12548.121631486074, 10472.371657700562, 10617.097546708615, 10841.457927103456, 10997.0, 11095.50070246857, 10597.0, 10599.682009539727, 10636.734081648021, 10785.298955567863, 10858.0, 10792.298500597437, 10999.670009899715, 11059.170562208028, 11116.0, 11132.387718675227, 7707.499012564165, 7875.527468351917, 7904.486208396436, 8075.192480751878, 8090.7168249111, 9163.725088247364, 10487.52806123711, 10520.685449201164, 10609.151267898704, 10767.946160269463], "value": 9282.768513365796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.689327668083, 1401.2573336131854, 1451.8765904898082, 1560.336856835845, 1795.434438151982, 7532.924670753291, 7852.214778522145, 7872.173421790708, 7874.0, 7875.212478752122, 7651.273129052745, 7774.950381698483, 7799.167195709018, 7804.375649948005, 7826.178251283619, 1847.7782666080022, 2201.416624594484, 2218.7004754358118, 2242.450599603091, 2269.035659844568, 2203.327984964585, 2226.997850967063, 2230.609643312422, 2230.9107635694554, 2231.7768223177713, 2170.6526955687095, 2215.191455118886, 2224.7663995280504, 2234.318532847481, 2241.652543855705, 1866.2721538599958, 2181.9236326728646, 2229.6209644360497, 2239.7760223977634, 2241.3388050525136, 2143.346279384787, 2165.675148727688, 2175.8476906616543, 2175.8912054397215, 2186.8906554672203, 7453.85092298151, 7504.924950750477, 7529.8117547061765, 7531.322181003736, 7544.283293087148, 4574.428196475441, 4697.6241900647865, 4703.905921881543, 4706.987997580537, 4726.621870250372, 2914.825110493356, 2963.096255642028, 3026.6821983691616, 3029.6515900671484, 3053.2366908272934, 971.4462756228952, 1702.7445883117632, 1743.2155530011419, 1747.6417334446407, 1756.9472915812546, 10336.0, 10443.79112417755, 10479.318844275098, 10492.055714985689, 10505.159587233004, 3972.523297204354, 4055.8377664893073, 4163.791810409528, 4203.0543127796, 4208.558101399371, 8333.33333333332, 8346.081930987586, 8390.664373424994, 8399.496030238206, 8591.914080859111, 4050.23045621331, 4723.669343145947, 4734.431868175841, 4739.052189562101, 4739.146953548395, 3848.365019771706, 3879.1271963807917, 3879.7284190106984, 4236.322188449895, 4400.031992961543, 3491.982540087334, 3543.6987856032524, 3618.751530721949, 3692.6861216796337, 3713.591504934455, 1106.8671759388924, 1107.5071593140974, 1107.972300692473, 1113.0, 1124.2692250037542, 867.0592407238091, 879.5162660536679, 882.0473888200728, 887.0198430733946, 888.4891187567175, 5283.362157731116, 5313.335833020872, 5447.264619276347, 5499.587530935196, 5583.944160558423, 392.33107551624414, 413.1695292462173, 416.67499350506654, 420.05487652781244, 424.0649368143237, 3755.1738617504107, 3802.334591446486, 3811.9809400953372, 3865.7680539167177, 3867.4972253607416, 9420.528973551294, 9745.074217949283, 9778.706638800848, 9852.261080418997, 9929.2056635469, 9162.129597688208, 9625.085616866387, 9651.71044868641, 9655.662051828152, 9672.322937394314, 7178.712851485987, 7212.134543854666, 7285.162206346232, 7295.0, 7367.742129025565, 5354.598405119709, 5590.329160500766, 5638.85902852432, 5705.686187259575, 5811.360750317546, 8456.83086338282, 8686.609102590524, 8828.470291782514, 8837.293016558788, 8940.642374304955, 8971.910280897107, 9029.683961061332, 9149.77125571866, 9270.490123043297, 9278.211352034883, 6185.876282474415, 6873.278305778022, 7042.718291268497, 7104.289571042855, 7183.820404489929, 7737.5744334062165, 7739.496932699357, 7797.454178207471, 7808.453408261367, 7818.140004599376, 6938.653067346713, 7078.858422831618, 7081.114860642419, 7186.60473673932, 7207.0, 6980.232174460907, 7017.403520700797, 7021.05215795861, 7033.964830175816, 7112.50212485121, 6471.611703297817, 6508.414242717989, 6584.242812076673, 6614.867702646016, 6624.436922861611, 4667.883302917454, 4868.245421959602, 4882.829100981448, 4889.071076495455, 4938.506149385033, 4677.625789936729, 4691.695039822401, 4806.303086052572, 4883.902321953612, 4910.705357678407], "value": 4158.01130260381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2575795364984, 319.9152224660465, 324.8164786895405, 328.25649902969764, 328.32529152591445, 4959.132151873426, 4971.925421118686, 5006.674566153202, 5011.548960593545, 5042.974785126078, 4657.115148121863, 4723.598494128003, 4873.731944743037, 4968.229924361721, 4971.130052240862, 3928.7839168845703, 3957.56466788653, 3959.3071212537907, 3964.801759912007, 3969.702272329572, 3951.9527325258828, 3958.129211573449, 3960.9009774755573, 3960.9603903961024, 3967.801609919507, 3689.4650275710005, 3825.8469661213658, 3928.3321835287925, 3929.8231579578987, 3932.744371615836, 3909.8465952544066, 3928.3125453045604, 3939.72421930465, 3942.4086387042175, 3950.9012274693077, 3477.7739446935866, 3484.6341134181052, 3512.139525816166, 3518.8240587970754, 3518.9120271993147, 4656.371389862359, 4681.789319480597, 4740.525947405266, 4743.430788305425, 4772.713637181745, 4444.888877778049, 4450.198964186445, 4459.910801783979, 4471.552844715535, 4474.127545128701, 5152.639315247934, 5161.458046905096, 5175.585953123741, 5178.870528236786, 5204.245384419238, 3495.91260218494, 3782.2435512897255, 3788.981055094707, 3798.3542797724176, 3800.1639639279592, 5351.224072509464, 5387.356856158909, 5426.403095659474, 5434.722840132566, 5445.564354851603, 3763.2661630981697, 3767.7362584618813, 3768.510093687803, 3774.3772277573894, 3784.6026167252594, 3829.9808500957315, 3839.8080095995088, 3841.0781412461365, 3841.1357444574746, 3846.8461261549783, 4144.48193975753, 4364.650827933758, 4372.868813935587, 4380.8685739427865, 4384.430024096847, 5165.483451654804, 5180.197069454241, 5195.740212989335, 5220.504052115043, 5227.18978558324, 1224.4877576193394, 1278.367208231931, 1321.6960099177243, 1330.1154732103237, 1347.6832944258092, 880.471716969813, 888.3293113699116, 896.2964073202505, 900.6487469886749, 903.503073309677, 4535.160995215896, 4542.795574199169, 4546.408966834357, 4569.748663823521, 4575.359449677047, 5302.125149350314, 5306.071437498499, 5317.096093664087, 5319.898640037163, 5335.599830012765, 4437.64498840092, 4552.499225085238, 4561.817527298937, 4567.634589232854, 4572.725636461823, 2820.5346117890726, 2822.7600653944232, 2828.179827849942, 2832.2494538947194, 2838.8438635874813, 4891.63573216002, 5019.874503137377, 5022.472640372781, 5024.723640199824, 5032.43994361749, 5284.7093409862055, 5385.219143224211, 5410.675359478444, 5413.891722165614, 5421.186821976735, 4991.750412479361, 4992.176290911959, 4992.775325110306, 5019.799208031711, 5020.071286811952, 5116.620771341344, 5273.6044796639635, 5278.155495120763, 5285.0, 5288.656237344714, 5299.429776558289, 5327.254184414108, 5327.9733601331745, 5328.49379308965, 5333.173358129496, 5130.7178105204575, 5147.639665223398, 5151.253068305, 5151.4590967949325, 5161.638685291993, 3544.0, 3781.9810900945317, 3813.447050177653, 3818.427235914635, 3821.0, 5317.548008419173, 5325.653832500875, 5325.973370133124, 5326.280952071421, 5326.493983071602, 5134.12719837621, 5143.562797162133, 5163.302954101148, 5168.870778230575, 5185.810726403311, 4971.613625459727, 5118.616103792156, 5136.97431512855, 5152.896942061213, 5182.144946083854, 4812.133815913169, 5012.548870601663, 5022.447530771686, 5069.555176774602, 5084.26278189653, 5089.643724939367, 5146.356705411824, 5148.922766158586, 5228.895422091613, 5230.529252367305, 5104.387473503203, 5119.820806271762, 5132.948670513247, 5153.793848246029, 5157.484251574812], "value": 3920.445748222145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.1496140056524, 651.4462706699303, 670.7048898484667, 687.3195536418943, 716.802879208218, 10939.726506837333, 10952.123830093593, 11132.833007504894, 11368.317900925951, 11527.769444611113, 10784.46077696116, 10797.46012699364, 10805.83791243132, 10822.24244302899, 10824.18818588605, 642.7814543055383, 813.0446725098016, 819.6516480495795, 824.6206744897324, 825.3850881093564, 796.760971708488, 820.9384296177781, 826.1944604011071, 826.4834478450969, 828.7016673997356, 852.1138016462871, 859.5916939453772, 859.8151397449548, 860.3977215948829, 864.5893200729666, 669.6618207805027, 835.6532039203723, 854.2824027816632, 855.9101294364065, 859.072202021815, 620.1720702861685, 620.9596376235576, 621.0559948877681, 621.071498110328, 623.7349126621214, 11334.829977550344, 11371.0, 11390.658280251606, 11390.829137562943, 11406.31562106268, 11914.940425297818, 12299.0, 12420.937895310555, 12460.875391246153, 12584.68538286541, 9134.223590994774, 9151.313651476166, 9575.329726919119, 9633.325667203299, 9723.902760972442, 2898.2899189698446, 2922.167182353019, 2967.7032296770367, 3147.401993621205, 3457.8271086445575, 43921.34117988233, 48479.27281090787, 48491.0, 48524.51475485235, 48642.75678621584, 9763.853542196874, 9922.80154396908, 10035.548400322003, 10073.69778906634, 10089.848652270222, 16652.83347166537, 16792.58018549546, 16797.580060498585, 16804.075775832447, 16810.495685129466, 5943.58394912352, 5986.5809393342915, 6014.458698717136, 6109.358517355614, 6138.219916224334, 3442.535257740223, 3444.0873168610337, 3455.3434847378917, 3466.7399945004227, 3476.8261586920553, 2738.4659991301905, 2822.2662107852107, 2825.9152225433268, 2831.844248566307, 2832.7025662305573, 504.3418339067552, 516.377764793423, 518.2226660009985, 518.3313525552071, 522.3548917087394, 519.3430310657022, 580.2051189869906, 581.2211636407235, 590.8552404660885, 609.4849851875158, 7448.590327532038, 7595.240475952361, 7618.733344333033, 7747.457677962489, 7845.137034926153, 465.9394278743742, 561.1386521689187, 562.460038363176, 578.2251782611321, 596.7195418153461, 3584.354816133069, 3631.219287853124, 3662.230931504361, 3696.2792255510453, 3733.160038991205, 45234.77382613066, 46533.76733116313, 46883.0, 55762.0, 56490.435095649336, 42141.78929105335, 42910.0, 44175.77912110483, 44306.55693443089, 45158.77420612942, 39811.0, 40532.59467405347, 40814.183716325504, 41115.58884411177, 41171.38242926358, 7809.492382995087, 7885.881711774213, 7893.210678932061, 7919.604019799102, 8028.0, 25523.87238063798, 25754.613680795177, 26688.733112668626, 26840.59739103954, 26871.731282687706, 28136.15591532257, 34070.48894266637, 35727.64272357243, 35830.0, 36277.81861090783, 10013.0, 10150.289479736348, 10168.389896606228, 10213.693589192337, 10513.842292365467, 11290.548378064785, 11334.659960201207, 11370.658880233606, 11419.195898704209, 11709.473073711533, 9931.65239216624, 9967.202623790225, 10958.397288149228, 11097.667069987914, 11236.606718765132, 10120.949395252977, 10169.89830101719, 10380.0, 10641.733956650836, 10694.73263168427, 10227.43749093807, 10461.476926153815, 10735.0, 11169.0, 11502.597409090642, 9772.218222542322, 9866.16137628281, 9985.650502232387, 10098.343607665478, 10200.540975655966, 9467.763305917408, 9494.620215191315, 9563.426194428357, 9781.559829807533, 9800.558974846292], "value": 5708.8503680030735, "unit": "score"}], "name": "dromaeo_css", "value": 6297.435555355521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 106.0, 112.0, 113.0, 112.0, 103.0, 112.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 144.0, 155.0, 192.0, 133.0, 155.0, 176.0, 136.0, 199.0, 141.0], "value": 159.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 161.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 105.0, 116.0, 73.0, 73.0, 72.0, 122.0, 107.0, 75.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 148.0, 94.0, 94.0, 96.0, 154.0, 94.0, 93.0, 154.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 65.0, 64.0, 64.0, 82.0, 64.0, 62.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 86.0, 79.0, 80.0, 80.0, 80.0, 80.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 139.0, 134.0, 129.0, 130.0, 131.0, 133.0, 162.0, 134.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 168.0, 171.0, 173.0, 171.0, 174.0, 171.0, 172.0, 170.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 76.0, 73.0, 72.0, 71.0, 72.0, 74.0, 70.0, 69.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1579.7, "alertThreshold": 2.0}]} 06:49:22 INFO - Return code: 0 06:49:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:49:22 ERROR - # TBPL SUCCESS # 06:49:22 INFO - Running post-action listener: _resource_record_post_action 06:49:22 INFO - Running post-run listener: _resource_record_post_run 06:49:23 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 517009408; Read time: 544; Write time: 767884 06:49:23 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 234352640; Read time: 372; Write time: 466644 06:49:23 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282435584; Read time: 172; Write time: 296984 06:49:23 INFO - Running post-run listener: _upload_blobber_files 06:49:23 INFO - Blob upload gear active. 06:49:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:23 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 06:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:24 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:24 INFO - (blobuploader) - INFO - Done attempting. 06:49:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:25 INFO - (blobuploader) - INFO - Done attempting. 06:49:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:25 INFO - Return code: 0 06:49:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79aa32185418c5e498b0cba836469c80d09e506e68b0b4735a5bfb98bdaaf37cf979958260b81b14b79d6492ab45c6014ceb74557f2cfa72cc67cc5412c2f877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/047f5b01c66658413cd9f393f111e83a293f517792c51a769f0944ebb4a990fb6bbd3e3195763618950292b61da1fc95891ce6173e0cd608b631d96f8c6ebb79"} 06:49:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:25 INFO - Contents: 06:49:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79aa32185418c5e498b0cba836469c80d09e506e68b0b4735a5bfb98bdaaf37cf979958260b81b14b79d6492ab45c6014ceb74557f2cfa72cc67cc5412c2f877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/047f5b01c66658413cd9f393f111e83a293f517792c51a769f0944ebb4a990fb6bbd3e3195763618950292b61da1fc95891ce6173e0cd608b631d96f8c6ebb79"} 06:49:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:25 INFO - Copying logs to upload dir... 06:49:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.551945 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-22 06:49:25.804393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:49:25.808642) ========= 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=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79aa32185418c5e498b0cba836469c80d09e506e68b0b4735a5bfb98bdaaf37cf979958260b81b14b79d6492ab45c6014ceb74557f2cfa72cc67cc5412c2f877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/047f5b01c66658413cd9f393f111e83a293f517792c51a769f0944ebb4a990fb6bbd3e3195763618950292b61da1fc95891ce6173e0cd608b631d96f8c6ebb79"} build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79aa32185418c5e498b0cba836469c80d09e506e68b0b4735a5bfb98bdaaf37cf979958260b81b14b79d6492ab45c6014ceb74557f2cfa72cc67cc5412c2f877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/047f5b01c66658413cd9f393f111e83a293f517792c51a769f0944ebb4a990fb6bbd3e3195763618950292b61da1fc95891ce6173e0cd608b631d96f8c6ebb79"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:49:25.834735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:49:25.835125) ========= 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=aa52b8aba932b19cc50b5275000001de-1461331727.621505-740457082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:49:25.917638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:49:25.918049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:49:25.918524) ========= ========= Total master_lag: 0.17 =========