builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1461711512.83 results: success (0) buildid: 20160426144059 builduid: 5e3a427619484e129638fb2f79999862 revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:32.832182) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:32.832621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:32.832916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:32.874912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:32.875184) ========= 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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 15:58:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-04-26 15:58:33 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.214775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.103532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.103819) ========= 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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.154105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.154700) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b567617d9f02be4bd6870db55a9bd514a5762465 --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 b567617d9f02be4bd6870db55a9bd514a5762465 --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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 15:58:33,482 truncating revision to first 12 chars 2016-04-26 15:58:33,482 Setting DEBUG logging. 2016-04-26 15:58:33,482 attempt 1/10 2016-04-26 15:58:33,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b567617d9f02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 15:58:33,734 unpacking tar archive at: fx-team-b567617d9f02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.691777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.692067) ========= script_repo_revision: b567617d9f02be4bd6870db55a9bd514a5762465 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.692431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.692725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:58:33.702034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-26 15:58:33.702322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:34 INFO - MultiFileLogger online at 20160426 15:58:34 in /builds/slave/test 15:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:34 INFO - {'append_to_log': False, 15:58:34 INFO - 'base_work_dir': '/builds/slave/test', 15:58:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:34 INFO - 'branch': 'Fx-Team-Non-PGO', 15:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:34 INFO - 'config_files': ('talos/linux_config.py',), 15:58:34 INFO - 'default_actions': ('clobber', 15:58:34 INFO - 'read-buildbot-config', 15:58:34 INFO - 'download-and-extract', 15:58:34 INFO - 'populate-webroot', 15:58:34 INFO - 'create-virtualenv', 15:58:34 INFO - 'install', 15:58:34 INFO - 'run-tests'), 15:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:34 INFO - 'download_minidump_stackwalk': True, 15:58:34 INFO - 'download_symbols': 'ondemand', 15:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:34 INFO - 'installer_path': 'installer.exe', 15:58:34 INFO - 'log_level': 'info', 15:58:34 INFO - 'log_name': 'talos', 15:58:34 INFO - 'log_to_console': True, 15:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:34 INFO - 'opt_config_files': (), 15:58:34 INFO - 'pip_index': False, 15:58:34 INFO - 'sps_profile': False, 15:58:34 INFO - 'sps_profile_interval': 0, 15:58:34 INFO - 'suite': 'dromaeojs-e10s', 15:58:34 INFO - 'system_bits': '32', 15:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:34 INFO - 'title': 'talos-linux64-ix-026', 15:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:34 INFO - 'use_talos_json': True, 15:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:34 INFO - 'work_dir': 'build'} 15:58:34 INFO - ##### 15:58:34 INFO - ##### Running clobber step. 15:58:34 INFO - ##### 15:58:34 INFO - Running pre-action listener: _resource_record_pre_action 15:58:34 INFO - Running main action method: clobber 15:58:34 INFO - rmtree: /builds/slave/test/build 15:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:34 INFO - Running post-action listener: _resource_record_post_action 15:58:34 INFO - ##### 15:58:34 INFO - ##### Running read-buildbot-config step. 15:58:34 INFO - ##### 15:58:34 INFO - Running pre-action listener: _resource_record_pre_action 15:58:34 INFO - Running main action method: read_buildbot_config 15:58:34 INFO - Using buildbot properties: 15:58:34 INFO - { 15:58:34 INFO - "project": "", 15:58:34 INFO - "product": "firefox", 15:58:34 INFO - "script_repo_revision": "production", 15:58:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:58:34 INFO - "repository": "", 15:58:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:58:34 INFO - "buildid": "20160426144059", 15:58:34 INFO - "pgo_build": "False", 15:58:34 INFO - "basedir": "/builds/slave/test", 15:58:34 INFO - "buildnumber": 1217, 15:58:34 INFO - "slavename": "talos-linux64-ix-026", 15:58:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:34 INFO - "platform": "ubuntu64_hw", 15:58:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:58:34 INFO - "branch": "fx-team", 15:58:34 INFO - "repo_path": "integration/fx-team", 15:58:34 INFO - "revision": "b567617d9f02be4bd6870db55a9bd514a5762465", 15:58:34 INFO - "stage_platform": "linux64", 15:58:34 INFO - "builduid": "5e3a427619484e129638fb2f79999862", 15:58:34 INFO - "slavebuilddir": "test" 15:58:34 INFO - } 15:58:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:58:34 INFO - Running post-action listener: _resource_record_post_action 15:58:34 INFO - ##### 15:58:34 INFO - ##### Running download-and-extract step. 15:58:34 INFO - ##### 15:58:34 INFO - Running pre-action listener: _resource_record_pre_action 15:58:34 INFO - Running main action method: download_and_extract 15:58:34 INFO - mkdir: /builds/slave/test/build/tests 15:58:34 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')]} 15:58:34 INFO - https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:58:37 INFO - Downloaded 1361 bytes. 15:58:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:37 INFO - Using the following test package requirements: 15:58:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'jsshell-linux-x86_64.zip'], 15:58:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58:37 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')]} 15:58:37 INFO - https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:38 INFO - Downloaded 22291848 bytes. 15:58:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:58:39 INFO - Return code: 0 15:58:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:58: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')]} 15:58:39 INFO - https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:43 INFO - Downloaded 22291848 bytes. 15:58:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:58:44 INFO - Return code: 0 15:58:44 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')]} 15:58:44 INFO - https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:58:45 INFO - Downloaded 10840145 bytes. 15:58:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:58:46 INFO - Return code: 0 15:58:46 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')]} 15:58:46 INFO - https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:58:47 INFO - Downloaded 54818999 bytes. 15:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:47 INFO - mkdir: /builds/slave/test/properties 15:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:47 INFO - Contents: 15:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:48 INFO - Running post-action listener: _resource_record_post_action 15:58:48 INFO - Running post-action listener: set_extra_try_arguments 15:58:48 INFO - ##### 15:58:48 INFO - ##### Running populate-webroot step. 15:58:48 INFO - ##### 15:58:48 INFO - Running pre-action listener: _resource_record_pre_action 15:58:48 INFO - Running main action method: populate_webroot 15:58:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:48 INFO - '--tppagecycles', 15:58:48 INFO - '7'], 15:58:48 INFO - 'tests': ['tsvgm']}}, 15:58:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['damp', 'tps']}, 15:58:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'tests': ['damp', 'tps']}, 15:58:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['dromaeo_dom']}, 15:58:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['a11yr', 15:58:48 INFO - 'ts_paint', 15:58:48 INFO - 'tpaint', 15:58:48 INFO - 'sessionrestore', 15:58:48 INFO - 'sessionrestore_no_auto_restore', 15:58:48 INFO - 'tabpaint']}, 15:58:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['tsvgx', 15:58:48 INFO - 'tsvgr_opacity', 15:58:48 INFO - 'tart', 15:58:48 INFO - 'tscrollx', 15:58:48 INFO - 'cart']}, 15:58:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:48 INFO - 'tsvgr_opacity', 15:58:48 INFO - 'tart', 15:58:48 INFO - 'tscrollx', 15:58:48 INFO - 'cart']}, 15:58:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'talos_options': ['--disable-e10s'], 15:58:48 INFO - 'tests': ['tp5o']}, 15:58:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'tests': ['tp5o']}, 15:58:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'talos_options': ['--disable-e10s', 15:58:48 INFO - '--xperf_path', 15:58:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:48 INFO - 'tests': ['tp5n']}, 15:58:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:48 INFO - 'talos_options': ['--xperf_path', 15:58:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:48 INFO - 'tests': ['tp5n']}}, 15:58:48 INFO - 'talos.zip': {'path': '', 15:58:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:48 INFO - Running post-action listener: _resource_record_post_action 15:58:48 INFO - ##### 15:58:48 INFO - ##### Running create-virtualenv step. 15:58:48 INFO - ##### 15:58:48 INFO - Running pre-action listener: _resource_record_pre_action 15:58:48 INFO - Running main action method: create_virtualenv 15:58:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:48 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 15:58:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:48 INFO - Using real prefix '/usr' 15:58:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:50 INFO - Installing pip.................done. 15:58:50 INFO - Return code: 0 15:58:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:50 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:58:50 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 15:58:50 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 15:58:50 INFO - Using env: {'DISPLAY': ':0', 15:58:50 INFO - 'HOME': '/home/cltbld', 15:58:50 INFO - 'LANG': 'en_US.UTF-8', 15:58:50 INFO - 'LANGUAGE': 'en_US:en', 15:58:50 INFO - 'LOGNAME': 'cltbld', 15:58:50 INFO - 'MAIL': '/var/mail/cltbld', 15:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:50 INFO - 'MOZ_NO_REMOTE': '1', 15:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:50 INFO - 'NO_EM_RESTART': '1', 15:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:50 INFO - 'PWD': '/builds/slave/test', 15:58:50 INFO - 'SHELL': '/bin/bash', 15:58:50 INFO - 'SHLVL': '1', 15:58:50 INFO - 'TERM': 'linux', 15:58:50 INFO - 'TMOUT': '86400', 15:58:50 INFO - 'USER': 'cltbld', 15:58:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:50 INFO - '_': '/tools/buildbot/bin/python'} 15:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:50 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 15:58:50 INFO - Cleaning up... 15:58:50 INFO - Return code: 0 15:58:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:50 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:58:50 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 15:58:50 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 15:58:50 INFO - Using env: {'DISPLAY': ':0', 15:58:50 INFO - 'HOME': '/home/cltbld', 15:58:50 INFO - 'LANG': 'en_US.UTF-8', 15:58:50 INFO - 'LANGUAGE': 'en_US:en', 15:58:50 INFO - 'LOGNAME': 'cltbld', 15:58:50 INFO - 'MAIL': '/var/mail/cltbld', 15:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:50 INFO - 'MOZ_NO_REMOTE': '1', 15:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:50 INFO - 'NO_EM_RESTART': '1', 15:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:50 INFO - 'PWD': '/builds/slave/test', 15:58:50 INFO - 'SHELL': '/bin/bash', 15:58:50 INFO - 'SHLVL': '1', 15:58:50 INFO - 'TERM': 'linux', 15:58:50 INFO - 'TMOUT': '86400', 15:58:50 INFO - 'USER': 'cltbld', 15:58:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:50 INFO - '_': '/tools/buildbot/bin/python'} 15:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:51 INFO - Downloading/unpacking psutil>=0.7.1 15:58:51 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 15:58:51 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 15:58:51 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 15:58:51 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 15:58:51 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 15:58:51 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 15:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:53 INFO - Installing collected packages: psutil 15:58:53 INFO - Running setup.py install for psutil 15:58:53 INFO - building 'psutil._psutil_linux' extension 15:58:53 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 15:58:53 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 15:58:53 INFO - building 'psutil._psutil_posix' extension 15:58:53 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 15:58:53 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 15:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:53 INFO - Successfully installed psutil 15:58:53 INFO - Cleaning up... 15:58:53 INFO - Return code: 0 15:58:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:58:53 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')]} 15:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:53 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')]} 15:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:53 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:58:53 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 15:58:53 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 15:58:53 INFO - Using env: {'DISPLAY': ':0', 15:58:53 INFO - 'HOME': '/home/cltbld', 15:58:53 INFO - 'LANG': 'en_US.UTF-8', 15:58:53 INFO - 'LANGUAGE': 'en_US:en', 15:58:53 INFO - 'LOGNAME': 'cltbld', 15:58:53 INFO - 'MAIL': '/var/mail/cltbld', 15:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:53 INFO - 'MOZ_NO_REMOTE': '1', 15:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:53 INFO - 'NO_EM_RESTART': '1', 15:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:53 INFO - 'PWD': '/builds/slave/test', 15:58:53 INFO - 'SHELL': '/bin/bash', 15:58:53 INFO - 'SHLVL': '1', 15:58:53 INFO - 'TERM': 'linux', 15:58:53 INFO - 'TMOUT': '86400', 15:58:53 INFO - 'USER': 'cltbld', 15:58:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:53 INFO - '_': '/tools/buildbot/bin/python'} 15:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:53 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 15:58:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:58:55 INFO - Installing collected packages: mozsystemmonitor 15:58:55 INFO - Running setup.py install for mozsystemmonitor 15:58:55 INFO - Successfully installed mozsystemmonitor 15:58:55 INFO - Cleaning up... 15:58:55 INFO - Return code: 0 15:58:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:58:55 INFO - Using env: {'DISPLAY': ':0', 15:58:55 INFO - 'HOME': '/home/cltbld', 15:58:55 INFO - 'LANG': 'en_US.UTF-8', 15:58:55 INFO - 'LANGUAGE': 'en_US:en', 15:58:55 INFO - 'LOGNAME': 'cltbld', 15:58:55 INFO - 'MAIL': '/var/mail/cltbld', 15:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:55 INFO - 'MOZ_NO_REMOTE': '1', 15:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:55 INFO - 'NO_EM_RESTART': '1', 15:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:55 INFO - 'PWD': '/builds/slave/test', 15:58:55 INFO - 'SHELL': '/bin/bash', 15:58:55 INFO - 'SHLVL': '1', 15:58:55 INFO - 'TERM': 'linux', 15:58:55 INFO - 'TMOUT': '86400', 15:58:55 INFO - 'USER': 'cltbld', 15:58:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:55 INFO - '_': '/tools/buildbot/bin/python'} 15:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:58 INFO - Downloading docopt-0.6.1.tar.gz 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:58 INFO - Running setup.py install for blobuploader 15:58:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:59 INFO - Running setup.py install for requests 15:58:59 INFO - Running setup.py install for docopt 15:58:59 INFO - Successfully installed blobuploader requests docopt 15:58:59 INFO - Cleaning up... 15:58:59 INFO - Return code: 0 15:58:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:59 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:58:59 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 15:58:59 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 15:58:59 INFO - Using env: {'DISPLAY': ':0', 15:58:59 INFO - 'HOME': '/home/cltbld', 15:58:59 INFO - 'LANG': 'en_US.UTF-8', 15:58:59 INFO - 'LANGUAGE': 'en_US:en', 15:58:59 INFO - 'LOGNAME': 'cltbld', 15:58:59 INFO - 'MAIL': '/var/mail/cltbld', 15:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:59 INFO - 'MOZ_NO_REMOTE': '1', 15:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:59 INFO - 'NO_EM_RESTART': '1', 15:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:59 INFO - 'PWD': '/builds/slave/test', 15:58:59 INFO - 'SHELL': '/bin/bash', 15:58:59 INFO - 'SHLVL': '1', 15:58:59 INFO - 'TERM': 'linux', 15:58:59 INFO - 'TMOUT': '86400', 15:58:59 INFO - 'USER': 'cltbld', 15:58:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:59 INFO - '_': '/tools/buildbot/bin/python'} 15:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:59 INFO - Running setup.py (path:/tmp/pip-qDvTXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:59 INFO - Running setup.py (path:/tmp/pip-pYEARj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:59 INFO - Running setup.py (path:/tmp/pip-oSqDmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:59 INFO - Running setup.py (path:/tmp/pip-06nsJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:59 INFO - Running setup.py (path:/tmp/pip-4L5dgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:00 INFO - Running setup.py (path:/tmp/pip-0Bvoj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:00 INFO - Running setup.py (path:/tmp/pip-kP8jIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:00 INFO - Running setup.py (path:/tmp/pip-QoQpoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:00 INFO - Running setup.py (path:/tmp/pip-20wE4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:00 INFO - Running setup.py (path:/tmp/pip-_dcn6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:00 INFO - Running setup.py (path:/tmp/pip-4QwQNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:00 INFO - Running setup.py (path:/tmp/pip-ckZLNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:00 INFO - Running setup.py (path:/tmp/pip-aOYjWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:00 INFO - Running setup.py (path:/tmp/pip-84a7lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:00 INFO - Running setup.py (path:/tmp/pip-dMOcA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:00 INFO - Running setup.py (path:/tmp/pip-YHoIGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:00 INFO - Running setup.py (path:/tmp/pip-dWDhP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:00 INFO - Running setup.py install for manifestparser 15:59:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for mozcrash 15:59:01 INFO - Running setup.py install for mozdebug 15:59:01 INFO - Running setup.py install for mozdevice 15:59:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for mozfile 15:59:01 INFO - Running setup.py install for mozhttpd 15:59:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for mozinfo 15:59:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for mozInstall 15:59:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for mozleak 15:59:01 INFO - Running setup.py install for mozlog 15:59:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:01 INFO - Running setup.py install for moznetwork 15:59:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozprocess 15:59:02 INFO - Running setup.py install for mozprofile 15:59:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozrunner 15:59:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozscreenshot 15:59:02 INFO - Running setup.py install for moztest 15:59:02 INFO - Running setup.py install for mozversion 15:59:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:02 INFO - Cleaning up... 15:59:02 INFO - Return code: 0 15:59:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:02 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')]} 15:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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')]} 15:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:59:02 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 15:59:02 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 15:59:02 INFO - Using env: {'DISPLAY': ':0', 15:59:02 INFO - 'HOME': '/home/cltbld', 15:59:02 INFO - 'LANG': 'en_US.UTF-8', 15:59:02 INFO - 'LANGUAGE': 'en_US:en', 15:59:02 INFO - 'LOGNAME': 'cltbld', 15:59:02 INFO - 'MAIL': '/var/mail/cltbld', 15:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:02 INFO - 'MOZ_NO_REMOTE': '1', 15:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:02 INFO - 'NO_EM_RESTART': '1', 15:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:02 INFO - 'PWD': '/builds/slave/test', 15:59:02 INFO - 'SHELL': '/bin/bash', 15:59:02 INFO - 'SHLVL': '1', 15:59:02 INFO - 'TERM': 'linux', 15:59:02 INFO - 'TMOUT': '86400', 15:59:02 INFO - 'USER': 'cltbld', 15:59:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:02 INFO - '_': '/tools/buildbot/bin/python'} 15:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:02 INFO - Running setup.py (path:/tmp/pip-MwjFsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:02 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)) 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:02 INFO - Running setup.py (path:/tmp/pip-I7OlTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:03 INFO - Running setup.py (path:/tmp/pip-h3wHyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:03 INFO - Running setup.py (path:/tmp/pip-lwoGJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:03 INFO - Running setup.py (path:/tmp/pip-Q7TIXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:03 INFO - Running setup.py (path:/tmp/pip-XELiS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:03 INFO - Running setup.py (path:/tmp/pip-XkMaSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:03 INFO - Running setup.py (path:/tmp/pip-iZzrQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:03 INFO - Running setup.py (path:/tmp/pip-5RVjan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:03 INFO - Running setup.py (path:/tmp/pip-StL9uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:03 INFO - Running setup.py (path:/tmp/pip-Ilz7Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:03 INFO - Running setup.py (path:/tmp/pip-mW9YF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:03 INFO - Running setup.py (path:/tmp/pip-umW9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:03 INFO - Running setup.py (path:/tmp/pip-3nZSfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:03 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)) 15:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:03 INFO - Running setup.py (path:/tmp/pip-uCkcjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:04 INFO - Running setup.py (path:/tmp/pip-_UxsDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:04 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)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:04 INFO - Running setup.py (path:/tmp/pip-Bulvlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:04 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)) 15:59:04 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)) 15:59:04 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)) 15:59:04 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)) 15:59:04 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)) 15:59:04 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)) 15:59:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:06 INFO - Downloading blessings-1.6.tar.gz 15:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:06 INFO - Installing collected packages: blessings 15:59:06 INFO - Running setup.py install for blessings 15:59:06 INFO - Successfully installed blessings 15:59:06 INFO - Cleaning up... 15:59:06 INFO - Return code: 0 15:59:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:06 INFO - Reading from file tmpfile_stdout 15:59:06 INFO - Current package versions: 15:59:06 INFO - argparse == 1.2.1 15:59:06 INFO - blessings == 1.6 15:59:06 INFO - blobuploader == 1.2.4 15:59:06 INFO - docopt == 0.6.1 15:59:06 INFO - manifestparser == 1.1 15:59:06 INFO - mozInstall == 1.12 15:59:06 INFO - mozcrash == 0.17 15:59:06 INFO - mozdebug == 0.1 15:59:06 INFO - mozdevice == 0.48 15:59:06 INFO - mozfile == 1.2 15:59:06 INFO - mozhttpd == 0.7 15:59:06 INFO - mozinfo == 0.9 15:59:06 INFO - mozleak == 0.1 15:59:06 INFO - mozlog == 3.1 15:59:06 INFO - moznetwork == 0.27 15:59:06 INFO - mozprocess == 0.22 15:59:06 INFO - mozprofile == 0.28 15:59:06 INFO - mozrunner == 6.11 15:59:06 INFO - mozscreenshot == 0.1 15:59:06 INFO - mozsystemmonitor == 0.0 15:59:06 INFO - moztest == 0.7 15:59:06 INFO - mozversion == 1.4 15:59:06 INFO - psutil == 3.1.1 15:59:06 INFO - requests == 1.2.3 15:59:06 INFO - wsgiref == 0.1.2 15:59:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:06 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:59:06 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 15:59:06 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 15:59:06 INFO - Using env: {'DISPLAY': ':0', 15:59:06 INFO - 'HOME': '/home/cltbld', 15:59:06 INFO - 'LANG': 'en_US.UTF-8', 15:59:06 INFO - 'LANGUAGE': 'en_US:en', 15:59:06 INFO - 'LOGNAME': 'cltbld', 15:59:06 INFO - 'MAIL': '/var/mail/cltbld', 15:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:06 INFO - 'MOZ_NO_REMOTE': '1', 15:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:06 INFO - 'NO_EM_RESTART': '1', 15:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:06 INFO - 'PWD': '/builds/slave/test', 15:59:06 INFO - 'SHELL': '/bin/bash', 15:59:06 INFO - 'SHLVL': '1', 15:59:06 INFO - 'TERM': 'linux', 15:59:06 INFO - 'TMOUT': '86400', 15:59:06 INFO - 'USER': 'cltbld', 15:59:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:06 INFO - '_': '/tools/buildbot/bin/python'} 15:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 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)) 15:59:06 INFO - Cleaning up... 15:59:06 INFO - Return code: 0 15:59:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:59: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', 'jsonschema'] in /builds/slave/test/build 15:59: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 jsonschema 15:59:06 INFO - Using env: {'DISPLAY': ':0', 15:59:06 INFO - 'HOME': '/home/cltbld', 15:59:06 INFO - 'LANG': 'en_US.UTF-8', 15:59:06 INFO - 'LANGUAGE': 'en_US:en', 15:59:06 INFO - 'LOGNAME': 'cltbld', 15:59:06 INFO - 'MAIL': '/var/mail/cltbld', 15:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:06 INFO - 'MOZ_NO_REMOTE': '1', 15:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:06 INFO - 'NO_EM_RESTART': '1', 15:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:06 INFO - 'PWD': '/builds/slave/test', 15:59:06 INFO - 'SHELL': '/bin/bash', 15:59:06 INFO - 'SHLVL': '1', 15:59:06 INFO - 'TERM': 'linux', 15:59:06 INFO - 'TMOUT': '86400', 15:59:06 INFO - 'USER': 'cltbld', 15:59:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:06 INFO - '_': '/tools/buildbot/bin/python'} 15:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:06 INFO - Downloading/unpacking jsonschema 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:09 INFO - warning: no files found matching '*.txt' 15:59:09 INFO - no previously-included directories found matching 'build' 15:59:09 INFO - no previously-included directories found matching 'dist' 15:59:09 INFO - no previously-included directories found matching '.git*' 15:59:09 INFO - Installing collected packages: jsonschema, functools32 15:59:09 INFO - Running setup.py install for functools32 15:59:09 INFO - warning: no files found matching '*.txt' 15:59:09 INFO - no previously-included directories found matching 'build' 15:59:09 INFO - no previously-included directories found matching 'dist' 15:59:09 INFO - no previously-included directories found matching '.git*' 15:59:09 INFO - Successfully installed jsonschema functools32 15:59:09 INFO - Cleaning up... 15:59:09 INFO - Return code: 0 15:59:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:09 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 0x7f7add912f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28947d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, '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': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', '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 15:59:09 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 15:59:09 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 15:59:09 INFO - Using env: {'DISPLAY': ':0', 15:59:09 INFO - 'HOME': '/home/cltbld', 15:59:09 INFO - 'LANG': 'en_US.UTF-8', 15:59:09 INFO - 'LANGUAGE': 'en_US:en', 15:59:09 INFO - 'LOGNAME': 'cltbld', 15:59:09 INFO - 'MAIL': '/var/mail/cltbld', 15:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:09 INFO - 'MOZ_NO_REMOTE': '1', 15:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:09 INFO - 'NO_EM_RESTART': '1', 15:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:09 INFO - 'PWD': '/builds/slave/test', 15:59:09 INFO - 'SHELL': '/bin/bash', 15:59:09 INFO - 'SHLVL': '1', 15:59:09 INFO - 'TERM': 'linux', 15:59:09 INFO - 'TMOUT': '86400', 15:59:09 INFO - 'USER': 'cltbld', 15:59:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:09 INFO - '_': '/tools/buildbot/bin/python'} 15:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:09 INFO - Downloading/unpacking flake8 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:12 INFO - no previously-included directories found matching 'docs/_build' 15:59:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:12 INFO - Running setup.py install for pep8 15:59:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:12 INFO - no previously-included directories found matching 'docs/_build' 15:59:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:12 INFO - Cleaning up... 15:59:12 INFO - Return code: 0 15:59:12 INFO - Running post-action listener: _resource_record_post_action 15:59:12 INFO - Running post-action listener: _start_resource_monitoring 15:59:12 INFO - Starting resource monitoring. 15:59:12 INFO - ##### 15:59:12 INFO - ##### Running install step. 15:59:12 INFO - ##### 15:59:12 INFO - Running pre-action listener: _resource_record_pre_action 15:59:12 INFO - Running main action method: install 15:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:12 INFO - Reading from file tmpfile_stdout 15:59:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:12 INFO - Reading from file tmpfile_stdout 15:59:12 INFO - Output received: 15:59:12 INFO - Usage: mozinstall [options] installer 15:59:12 INFO - Options: 15:59:12 INFO - -h, --help show this help message and exit 15:59:12 INFO - -d DEST, --destination=DEST 15:59:12 INFO - Directory to install application into. [default: 15:59:12 INFO - "/builds/slave/test"] 15:59:12 INFO - --app=APP Application being installed. [default: firefox] 15:59:12 INFO - mkdir: /builds/slave/test/build/application 15:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:59:28 INFO - Reading from file tmpfile_stdout 15:59:28 INFO - Output received: 15:59:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:28 INFO - Running post-action listener: _resource_record_post_action 15:59:28 INFO - ##### 15:59:28 INFO - ##### Running run-tests step. 15:59:28 INFO - ##### 15:59:28 INFO - Running pre-action listener: _resource_record_pre_action 15:59:28 INFO - Running main action method: run_tests 15:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:28 INFO - Python 2.7.3 15:59:28 INFO - Return code: 0 15:59:28 INFO - grabbing minidump binary from tooltool 15:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:28 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 0x2923640>, '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 0x2924540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29249d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:28 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 15:59:28 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 15:59:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:28 INFO - Return code: 0 15:59:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:59:29 INFO - Return code: 0 15:59:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:59:29 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test', 15:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:59:29 INFO - mozversion application_buildid: 20160426144059 15:59:29 INFO - mozversion application_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 15:59:29 INFO - mozversion application_display_name: Nightly 15:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:29 INFO - mozversion application_name: Firefox 15:59:29 INFO - mozversion application_remotingname: firefox 15:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:59:29 INFO - mozversion application_vendor: Mozilla 15:59:29 INFO - mozversion application_version: 49.0a1 15:59:29 INFO - mozversion platform_buildid: 20160426144059 15:59:29 INFO - mozversion platform_changeset: b567617d9f02be4bd6870db55a9bd514a5762465 15:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:59:29 INFO - mozversion platform_version: 49.0a1 15:59:29 INFO - using testdate: 1461711569 15:59:29 INFO - actual date: 1461711569 15:59:29 INFO - starting webserver on 'localhost:34081' 15:59:29 INFO - SUITE-START | Running 2 tests 15:59:29 INFO - TEST-START | dromaeo_css 15:59:29 INFO - operating with platform_type : linux_ 15:59:29 INFO - Initialising browser for dromaeo_css test... 15:59:29 INFO - TEST-INFO | started process 9244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ3njzA/profile http://localhost:34081/getInfo.html) 15:59:33 INFO - PROCESS | 9244 | 15:59:33 INFO - PROCESS | 9244 | (process:9314): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:59:34 INFO - PROCESS | 9244 | __metrics Screen width/height:1600/1200 15:59:34 INFO - PROCESS | 9244 | colorDepth:24 15:59:34 INFO - PROCESS | 9244 | Browser inner width/height: 1024/697 15:59:34 INFO - PROCESS | 9244 | __metrics 15:59:34 ERROR - PROCESS | 9244 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:59:35 INFO - TEST-INFO | 9244: exit 0 15:59:35 INFO - Browser initialized. 15:59:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:35 INFO - TEST-INFO | started process 9365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ3njzA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:37 INFO - PROCESS | 9365 | 15:59:37 INFO - PROCESS | 9365 | (process:9426): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:59:47 INFO - PROCESS | 9365 | RSS: Main: 165859328 15:59:47 INFO - PROCESS | 9365 | 16:00:37 INFO - PROCESS | 9365 | 1461711637428 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] 16:02:48 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34081/tests/dromaeo/cssquery-ext.html) 16:02:49 INFO - PROCESS | 9365 | RSS: Main: 169918464 16:02:49 INFO - PROCESS | 9365 | 16:05:51 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-ext.html (next: http://localhost:34081/tests/dromaeo/cssquery-jquery.html) 16:05:52 INFO - PROCESS | 9365 | RSS: Main: 167550976 16:05:52 INFO - PROCESS | 9365 | 16:08:54 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34081/tests/dromaeo/cssquery-mootools.html) 16:08:54 INFO - PROCESS | 9365 | RSS: Main: 168345600 16:08:54 INFO - PROCESS | 9365 | 16:11:56 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34081/tests/dromaeo/cssquery-prototype.html) 16:11:57 INFO - PROCESS | 9365 | RSS: Main: 166277120 16:11:57 INFO - PROCESS | 9365 | 16:14:59 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34081/tests/dromaeo/cssquery-yui.html) 16:15:00 INFO - PROCESS | 9365 | RSS: Main: 167325696 16:15:00 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | Cycle 1(1): loaded http://localhost:34081/tests/dromaeo/cssquery-yui.html (next: http://localhost:34081/tests/dromaeo/cssquery-dojo.html) 16:18:03 INFO - PROCESS | 9365 | RSS: Main: 169316352 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | __start_tp_report 16:18:03 INFO - PROCESS | 9365 | _x_x_mozilla_page_load 16:18:03 INFO - PROCESS | 9365 | _x_x_mozilla_page_load_details 16:18:03 INFO - PROCESS | 9365 | |i|pagename|runs| 16:18:03 INFO - PROCESS | 9365 | |0;dojo.html;2643.960340594891;2701.9729802701972;2734.3164208947765;2741.849198294093;2750.33991841958;4756.928646070307;4786.4974177711365;4794.904101917964;4803.279508073786;4865.7810398532065;4687.390639216906;4734.550217729319;4740.885891815421;4753.310769938357;4763.642726795487;4286.76422796746;4324.17840610283;4365.672574556905;4403.647708183337;4506.391637128995;4386.802593883267;4403.4495688039;4453.554644535553;4476.753778542179;4489.932651010237;4437.6671749618745;4441.822327106928;4450;4453.599176074153;4461.866144015685;247.678346037499;4406.361077643755;4463.4420697412825;4465.0400163964905;4466.798994045275;4406.7355958642265;4420.160169567772;4422.800973956179;4430.689851710382;4472.1502914446155;4753.572178503951;4761.309610106515;4781.784819683123;4784.234522476387;4795.520447955177;4914.852554423373;5045.192769156954;5053.115704751691;5105.974470127626;5127.359080114986;5146.150885103953;5154.252633368178;5171.818986335498;5183.067047931371;5219.895602087937;4784.40194975628;4792.353032340624;4798.2082956312515;4801.975990120062;4845.297431872359;5294.126469132627;5294.205869119586;5308.708021058879;5309.150535914235;5355.116405793001;5047.899042019212;5056.089903817275;5058.342415486037;5067.163917953497;5075.593952483792;4891.828785992473;5042.697438153723;5143.717095559706;5168.586513078944;5171.3535808024;5119.0273847968765;5130.538251557377;5136.922946155811;5142.665726727825;5155.871103222375;5128.230765385222;5128.820491282787;5153.123968925292;5153.871153221125;5201.323827902348;4209.4948606166845;4258.169656916872;4302.720323178984;4332.588404101605;4332.9133417332105;3664.1206110533813;3735.477033215352;3757.3988161893967;3780.4896338994436;3814.561325447609;4489.685721999429;4492.797824097924;4502.257127573979;4516.074204788077;4550.089982003613;4968.6025117990475;5101.770420331094;5166.6641668292195;5204.739763011834;5229.869253268699;4458.977705111453;4466.9553304466535;4467.6202522785925;4469.463664360298;4506.256467682796;4589.541045895384;4591.242444996605;4593.6095431888;4593.63250939924;4596.5863072323655;4739.4075740532435;4748.0978614063215;4795.376601041842;4808.134535783593;4842.757862106951;5107.438181800073;5172;5175.663581867167;5192.9740351298005;5208.947910520847;4693.788779504999;4849.151398505177;4861.1979023460735;4863.440704318907;4908.8772780680765;4979.477154898828;5024.748762561784;5040.36995375578;5055.34280543527;5089.796408143633;5131.358580177478;5156.04613146569;5171.224316352577;5183.663061900965;5205.427402985592;4818.71087734737;4971.328870602422;5017.874553136201;5025.723585202849;5040.34475518195;4913;4917.729524876167;4977.352944117241;4997.825076122318;5018;4842.201036828884;4862.805487780449;4875.488073752347;4878.243872199815;4895.265710143507;4837.95162048375;4963.329950456642;4984.825531106394;5041.722705251246;5047.570956468741;4804.495527969652;4875.219964805614;4916.729579873141;4994.575461085703;5005.949940500694 16:18:03 INFO - PROCESS | 9365 | |1;ext.html;559.6390328238286;604.0878273806551;606.5238787551772;623.3548277532755;631.2771876201746;31721.84139079304;32733.508997365057;32743.672563274362;32746.67253327466;32819.67180328196;32600.184995375126;32812.83593582029;33056.33887322252;33130.50304245438;33265.66734332656;7366.300201480864;7524.774256772305;7556.811079723024;7560.43296752743;7575.090989081318;7575.356094731955;7718.2281771822645;7755.883661745078;7775.805604859867;7788.415868809862;7729.420293477983;7741.961290193542;7804.726834560792;7805.921940780605;7814.452988290822;7701.3453856422275;7762.9611851940945;7767.922320776776;7768.262015108556;7775.727849525239;7598.468107232496;7763.689452421896;7770.106437759617;7782.105057918356;7807.960960195162;24932.50134997308;32845;33687.831560842285;33693.6630633693;33778.6622133778;2735.275152084699;2752.1881045091745;2786.6934637189893;2941.749951254146;3211.2614098757185;26936.19191424241;27055.188344349503;27391.45217095647;27421;27461.17616471509;2978.7616990640913;2993;2994.7753918455987;3053.7709671774705;3105.580746599203;150223;150704;151380.2430987849;151667.24166379208;151977.24011379873;45352.77323613427;45353.31970020452;45519.317210241876;45535.5446445538;45564;49119;49633.50366496361;49705.25442118371;49896.50103498918;53511.732441337546;13942.651433714238;14118.85881141196;14181.645458863404;14184.148951062969;14187.716245675028;10679.57281708723;10737.624183153708;10768.138548916068;10798.51406686701;10817.78364432707;16755.329786808634;16846.157692115346;16872.325106995828;16915.915420422818;17009.319627214772;6413.262474815456;6684.364985326386;6736.932630673728;6743.35938085881;6860.5540639858245;829.0962850492991;859.26532814444;869.5434896679168;895.6238379880466;954.3224310739453;26393.0848859215;27082.05212817542;27232.59151112735;27354.316142096606;27384.58923116155;928.3501548915785;958.2259359155206;966.1304825656965;990.7077412163429;1058.3385384134915;14453.566393008226;14471.276436178148;14514.564563063124;14659.560213193621;14670.486532971508;266097;268407;270046;270938;271647;44314;45323;45603.315950260774;45642.77178614086;45660.315095273596;1190.856777493616;1213.991870677927;1238.2446707508414;1259.3451405269209;1259.703969567151;24809.751902480744;25475.87262063678;25854;26025.21924342273;26752.33119172036;43049.139017220106;43947.56052439435;43990.780046099564;44016;44035.55964440315;255819;256653;257788;259204;264409;35887.102822429646;36397.0900727484;36551.26897462089;36780.24148188843;36832.44751328786;35383.82308088443;37602.24795504129;40103;40155.59844401635;41376.58623413727;33999.470023848495;34814.12964675802;34847.12882177966;34911.12722181966;34919;33766.49350259797;33969.660303397635;34332.48501272533;34399.82800085984;34435;28083.595820209317;31526;31960;33283;34193.48709769405;27970.300742481602;28447.28881777972;28482;28665.28336791597;28873.56689649699;22666.43333916665;22825.657615135453;22852.542949141258;23118.1908633197;23181.536369272184 16:18:03 INFO - PROCESS | 9365 | |2;jquery.html;354.063502037112;354.79421935277543;355.9893203203904;361.9348517266891;363.87082585682083;14665.413383464649;15221.391144354226;15528.145951972638;15534.766978495332;15546.067235965837;14485.927570362133;14792.334344954475;15110.773338399933;15127.773083403757;15262.236888155603;4903.436104847935;4947.480514545975;5071.898562028776;5086.6693664911845;5096.362954630671;4984.177610694249;5008.499150084981;5064.987002599476;5069.695818250898;5094.184930411135;4862.100511405383;5035.144025515671;5045.192769156935;5055.898882022358;5065.721385323805;4993.051320249159;5004.84985450437;5007.774650140753;5014.323066386028;5038.622103342264;4377.34339849022;4463.732176069446;4496.460424749019;4519.954800451987;4559.4072770539615;18672.15975281102;18807.529811754677;19107.140178691992;19147.808521914743;19180.71228931567;1842.4012196036342;2006.4081096076693;2140.9830330592845;2236.284388995522;2525.734797846218;12535.24788512692;12685.175463594836;12728.23630582168;12729.363531823372;12961.41673624689;1788.6780379531679;1795.4613615915173;1800.0459756329167;1846.732223827551;1904.4286713985748;56896;57021.714891425276;57037.429625703626;57305.71347143321;57321.71339143278;8973.192412682889;9128.49793261377;9288.907110928803;9391.812163756687;9562.896162844303;12456.626301210978;12713;12723.55467558631;12725.490980360866;12735.299558524184;6741.831454213586;6819.624920629413;6932.272111428329;6985.89521157183;7034.5427547209265;6433.067205255212;6464.191976003;6516.804495865132;6549.508786841006;6591.143151390384;5829.825105246765;6027.578069535178;6055.424734650202;6082.482988945901;6087.634741915499;1767.2930827669036;1778.7154055351082;1789.168036862865;1789.865760068;1801.73874788155;850.4302117581235;882.5146169606691;922.8292765838341;932.1657116880355;985.5564995751797;14169.008169428042;14686.926565367105;15697.450589229322;15754;16225.756613650805;882.1575395497284;887.8845750052581;895.1853813030111;947.3984020147118;948.9478078705738;9308.813823723487;9417.811643767087;9476.905230947741;9522.190613797904;9552.474613896164;302045;306917;310123;310367;368300;52778;58989;59137.70431147903;64992.67503662546;71799.2820071803;941.4774799986074;953.0564740906591;972.6206779356057;979.9510024498746;980.5342462330478;13742.96015971845;14326.283685815459;14443.638909027359;14584.052036617586;14676.926615366854;28851.855740721163;31029.983051101604;31134.844325778227;31733.682663173997;33533.32933341368;42005;43714.56285437105;44668.77665611651;45145;45177.774111129234;4815.446223684181;4938.802447902043;5230.790768369223;6705.932940670531;7272.527285726411;8276.793080173044;10666.679999599713;11222.887771122185;11351.716207094889;11577.942110289394;9811.55847986828;9896.950515247378;10081.89918100839;10122.79754404893;10248.897511024794;9830.75423114428;9874.901250987397;9999.3000489965;10198.184145268213;10415.1667866572;6948.895766563404;10175.898241017496;10176.745581360525;10205.2140875348;10237.590496380062;7161.176464706626;7405.370543503647;7618.733344332922;7663.616819159131;8050.718224862336;9488;9822.116009558888;9856.408615483095;10066.8489972649;10070.44612546317 16:18:03 INFO - PROCESS | 9365 | |3;mootools.html;1432.219440404979;1451.5717863230345;1579.1472604793405;1720.5010546941387;1755.5786611213305;6494.610323380601;7210.4952653314285;7433.81415464613;7703.229677032294;7746.186650401704;7184.568925864439;7190.892136617955;7256.927430725705;7273.2726727327245;7300;2115.629764791163;2138.091311192737;2140.978590214101;2144.453164443065;2152.0961196297512;2150.2689085710854;2167.6098302305577;2173.271953895439;2182.9345119646437;2186.7485239197536;2156.8598041127275;2175.3365223606793;2176.869387836727;2188.6388745856993;2234.944126396837;2153.924612638558;2154.997925964434;2156.1914282144194;2161.7189765330563;2163.167180635459;2129.7231359923267;2163.7836216378237;2179.2154824263253;2201.4276288165033;2203.6584329428965;7376.963115184443;7448.217937116633;7474;7477.21489243627;7491.513051651626;4545.11370282795;4689.50760170184;4717.599004084657;4720.740359280238;4727.66906316558;2821.3369858083333;2832.4335132973283;2983.1498023063323;3002.9699703002907;3013.819170849756;907.4464576608264;909.4225167018991;917.2936838634214;927.1979737527058;937.3813283233034;10571.577136914515;10574.841377379345;10574.894251057545;10575.576976920915;10623.734406639818;4202.957970420318;4280.379344994958;4341.8480353188115;4350.260455722535;4367.30123180296;8644.394892357475;8718.128187181357;8746.51894145828;8749.912500875038;8755.0807165248;4677.695949763254;4714.5521175488275;4723.173444647242;4725.173094708481;4742.4309082909585;3576.7317451191266;4238.788060596958;4249.128928569636;4332.761698106571;4351.108022855307;3594.5506811648543;3614.204874927512;3684.8710295140077;3742.4947632069866;3755.192633583738;1183.6567395455222;1221.3099598726692;1224.1430998301225;1234.493857518413;1236.3385588709998;833.7623777223462;861.7328628125301;862.9913700862911;878.6617152396374;893.3523195683077;5040.168372218543;5128.358955130609;5266.499682530153;5321.840344789663;5464.672119672832;406.3843277434689;407.5374449999213;418.56051146296875;420.53530848412674;435.5861931165405;3653.5250417446096;3656.1590834108306;3678.9882782234563;3809.580946095927;4031.0728532437115;9447.952760236292;9617.422954622605;9681.51592420376;9682.95158524217;9700.417974921527;9516.619335226653;9609.615615375447;9712.75718107053;9720.75698107553;9721.61113555464;7165.176004759519;7292.124945006633;7319.597422141726;7369.742059027908;7388.889166662504;5028.673136246132;5196.766145523385;5211.9478805211465;5226.980738755906;5427.701476418835;8346.457480263764;8394.0766515682;8572.442791218551;8582;8593.226609605166;8594.527300998505;8633.39566230383;8674;8711.47731136134;8820.11798820113;5944.762209511571;6656.500762442739;6841.486888483483;6889.965550172217;6919.342662447059;7261.419086473175;7273.0908636420445;7329.963350183215;7343.412526997934;7403.333699967029;6405.167328247298;6760.121184246016;6760.391564759196;6779.050932869303;6835;6509.544331896722;6570.77002304917;6677.432418244503;6725.529212955046;6752.561083529555;6334.746610135728;6497.4477169441125;6510.641914694548;6531.967340163269;6535.640539770358;4489.797959091783;4551.271796512542;4628.745419001987;4670.392848929618;4683.414573178353;4429.64562834966;4440.4671439427475;4442.444694413199;4466.017476155241;4503.617192538671 16:18:03 INFO - PROCESS | 9365 | |4;prototype.html;298.7669617698196;298.7983111399805;302.62021163439886;302.9000429858146;303.9711227433393;4917.557419832215;4945.604351651873;4967.354243948286;4998.525140111693;4998.775055122519;4902.60779137669;4905.2396878483805;4908.190148625481;4923.926141107886;4938.308636790844;3640.872569460076;3744.457053727208;3832.6550610445056;3835.42468629705;3853.5953724858905;3851.7496362736474;3868.013656517584;3869.2528304903553;3869.496965394509;3891.3190191716476;3846.2692088503236;3846.4614953906475;3851.383778595425;3859.4017927221325;3881.0879443330937;3569.1434055826417;3802.1445174835717;3842.865499707497;3879.1659793144468;3882.8835134945857;3315.469524876032;3320.638538199351;3328.7503437242303;3344.6320904700465;3349.748768842322;4735.147673418784;4794.856154315376;4797.52024797521;4801.495842936476;4816.951830481686;4348.652107831366;4364.432623758923;4383.276759334706;4394.758288294142;4397.692161548693;5040.495950404967;5137.614678899097;5148.613853960968;5162.948370516285;5205.0110479009245;3603.927921441583;3621.8732344368086;3632.4369722693023;3652.7077833773233;3656.9817150914073;5335.599830012726;5423.349198096214;5430;5439.640089977505;5457.126859702468;3580.9283814323567;3723.7765734056043;3738.775673459601;3741.6904083571076;3748.5876553579083;3762.9087564606507;3777.735558510878;3778.4521244419407;3783.5270591176104;3798.0694729791376;4304.5910638489295;4316.848910288125;4317.136572685476;4323.329883868006;4324.718893271927;5085.923711144335;5209.322788037531;5212.582993360522;5231.110711179109;5232.895342093137;1373.6977864869712;1374.6632075141454;1379.3999610169608;1381.9930900345435;1390.0269811132248;838.3712215838121;887.5843030366555;899.4198741811495;922.9077092290718;928.8885333759993;4492.326151077365;4574.656900732459;4609.640156153942;4612.192866248393;4636.744979026186;5316.660669305493;5328;5378.273933019071;5382.49290198745;5400.540954018874;4420.491643461043;4580.977095114503;4645.442546894395;4683.555062269079;4688.578027977498;3068.6777888321853;3068.7544996400234;3080.5995220621176;3082.1832214463184;3088.336007758343;5325.843033571332;5373.086575282211;5405.405405405402;5411.269478620415;5423.945760542344;5236.790528378822;5494.917576236279;5563.5271001964475;5849.61977471463;5884.293884733859;5089.414717307557;5094.465081166498;5109.38687357512;5115.846524604268;5137.691738495777;5351.839444816662;5400.648957817729;5418.943306055281;5429.755660995185;5433.212184233185;5166.184429486014;5255.554722451357;5267.445289034892;5287.206918962186;5307.681539107666;5034.496550345083;5065.797368105234;5095.33760611133;5126.79492820283;5152.355955505562;3686.4838922551403;3740.7007439404238;3743.887683369503;3761.511003569628;3770.7737535747942;5253.212018197301;5274.920876186937;5346.166531738185;5362.597805164551;5399.919001215064;5165.974170129276;5166.793328266827;5169.302144210484;5191;5236.476352364885;5122.8207012755865;5194.246834209094;5206.947930520646;5238.319018527567;5240.318758561362;4892.975535122301;5171.01750667372;5177.378714554277;5178.275041494118;5190.97404512975;5013.699178049329;5087.694738315713;5146.845594632167;5227.98722491851;5231.163013917755;5049.6465247432325;5083.46623604531;5092.905025419553;5104.014151721285;5130.538251557377 16:18:03 INFO - PROCESS | 9365 | |5;yui.html;608.6621924831718;739.9926000739995;760.1828034862524;762.7559181062062;765.2997507280838;11575.65273041809;12160.756784864298;12315;12397.628071157857;12415.441305141268;11087.22389432738;11235.83146252807;11250.718732031703;11258.943705281463;11294.604688835892;630.2500024970294;765.2194761343426;777.0869228656335;795.6737737527615;796.040770871099;769.2346115614971;773.9729109481169;774.2644487736644;775.2480094308512;776.9300762931335;817.7464985854374;818.9181081891793;819.713100414856;822.3092602214139;823.283743143466;814.9633266503022;815.3721634341524;815.6859609050499;818.10008990111;818.5907046476761;599.3287517979846;601.3775742106942;603.0592276049333;604.782278379783;606.429955841512;11837.822432663517;11863.94068029663;11865;11877.821832672516;11877.881221187765;12268.877311226863;12743.74512509754;12759.74480510394;12777.110407338689;13135.277559734212;9998.700038998843;10083.798324033478;10099.697009089665;10451.111655509214;10548.947255263674;3316.3201543683485;3322.1528510229978;3381.9830900845586;3401.0137060252496;3457.083872773717;44208.12647177956;44505;44732.55267447316;45576;45907;9428.575714092882;9438.575264112995;9546.904530954602;9614.567344469515;9866.408015519091;17134.14329283531;17134.91432542854;17147.914260428617;17151.228194731266;17175.570610734583;6530.216374035052;6579.605223686594;6600.108985287021;6756.2568117507035;6785.117934668461;3282.425575524274;3530.135116896377;3575.696065834381;3683.318586061587;3712.554493460802;2738.370174859793;2812.4656315300026;2817.112609527992;2818.126380821952;2828.476731804623;508.22241969785546;516.6435159739767;520.2066848056668;520.8958208358343;527.6174773289334;480.92305231162845;506.55170174395926;614.3886832601501;615.1019511513151;621.1738387944024;7907.966936862127;8072.233137851895;8091.271785539329;8173.468724532886;8271.255586997198;492.1878899815262;562.2830890614499;581.9447152520504;596.7195418153461;597.6862147372664;3578.946315805265;3626.746127771031;3663.175785448253;3692.409214525717;3719.386301260262;55699.72150139305;55831.72084139553;55895.441045589025;56044.15933760997;56954.7152264236;47985;48092;48319.27521087186;49167.75416122968;51225.487745122075;44483.11033779306;44537.55462445399;44916.55083449189;45306;45389.319160212624;7283.308085731847;7303.707851686086;7318.1949985502615;7359.963200183965;7508.399328053852;28696.426071478872;29004;29288.267793304487;30525;30928.22679432942;39488;40607.796961015;41091.1781764369;41282.1743565133;41654.58345416507;9437.339386243171;9566.856497152408;9681.951590242004;9776.1690256329;9803.36278141947;10422.791544169226;10425.63510277167;10735.624253151102;10993.395363254778;11171.553137874394;10052.798944020933;10297.691069267934;10429.11352535043;10569.682909512727;10847.45762711877;9958.103770660675;9981.301308908307;10049.849252261076;10147.847782283125;10182.236332275257;9976.401415915068;10128.797424051625;10152.695419137437;10203.28576999603;10347.586096556053;8724.607392667218;8731.301495880187;8914.108589141035;9059.22996545301;9445.527723613654;8258.710945116893;8472.44929079608;8483.660653574036;8581.35639827028;8734.69428569997 16:18:03 INFO - PROCESS | 9365 | __end_tp_report 16:18:03 INFO - PROCESS | 9365 | __start_cc_report 16:18:03 INFO - PROCESS | 9365 | _x_x_mozilla_cycle_collect,377 16:18:03 INFO - PROCESS | 9365 | __end_cc_report 16:18:03 INFO - PROCESS | 9365 | __startTimestamp1461712683263__endTimestamp 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | ------- Summary: start ------- 16:18:03 INFO - PROCESS | 9365 | Number of tests: 6 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#0] dojo.html Cycles:165 Average:4714.13 Median:4842.76 stddev:604.80 (12.5%) stddev-sans-first:584.44 16:18:03 INFO - PROCESS | 9365 | Values: 2644.0 2702.0 2734.3 2741.8 2750.3 4756.9 4786.5 4794.9 4803.3 4865.8 4687.4 4734.6 4740.9 4753.3 4763.6 4286.8 4324.2 4365.7 4403.6 4506.4 4386.8 4403.4 4453.6 4476.8 4489.9 4437.7 4441.8 4450.0 4453.6 4461.9 247.7 4406.4 4463.4 4465.0 4466.8 4406.7 4420.2 4422.8 4430.7 4472.2 4753.6 4761.3 4781.8 4784.2 4795.5 4914.9 5045.2 5053.1 5106.0 5127.4 5146.2 5154.3 5171.8 5183.1 5219.9 4784.4 4792.4 4798.2 4802.0 4845.3 5294.1 5294.2 5308.7 5309.2 5355.1 5047.9 5056.1 5058.3 5067.2 5075.6 4891.8 5042.7 5143.7 5168.6 5171.4 5119.0 5130.5 5136.9 5142.7 5155.9 5128.2 5128.8 5153.1 5153.9 5201.3 4209.5 4258.2 4302.7 4332.6 4332.9 3664.1 3735.5 3757.4 3780.5 3814.6 4489.7 4492.8 4502.3 4516.1 4550.1 4968.6 5101.8 5166.7 5204.7 5229.9 4459.0 4467.0 4467.6 4469.5 4506.3 4589.5 4591.2 4593.6 4593.6 4596.6 4739.4 4748.1 4795.4 4808.1 4842.8 5107.4 5172.0 5175.7 5193.0 5208.9 4693.8 4849.2 4861.2 4863.4 4908.9 4979.5 5024.7 5040.4 5055.3 5089.8 5131.4 5156.0 5171.2 5183.7 5205.4 4818.7 4971.3 5017.9 5025.7 5040.3 4913.0 4917.7 4977.4 4997.8 5018.0 4842.2 4862.8 4875.5 4878.2 4895.3 4838.0 4963.3 4984.8 5041.7 5047.6 4804.5 4875.2 4916.7 4994.6 5005.9 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#1] ext.html Cycles:180 Average:38345.49 Median:33274.33 stddev:60753.36 (182.6%) stddev-sans-first:60857.54 16:18:03 INFO - PROCESS | 9365 | Values: 559.6 604.1 606.5 623.4 631.3 31721.8 32733.5 32743.7 32746.7 32819.7 32600.2 32812.8 33056.3 33130.5 33265.7 7366.3 7524.8 7556.8 7560.4 7575.1 7575.4 7718.2 7755.9 7775.8 7788.4 7729.4 7742.0 7804.7 7805.9 7814.5 7701.3 7763.0 7767.9 7768.3 7775.7 7598.5 7763.7 7770.1 7782.1 7808.0 24932.5 32845.0 33687.8 33693.7 33778.7 2735.3 2752.2 2786.7 2941.7 3211.3 26936.2 27055.2 27391.5 27421.0 27461.2 2978.8 2993.0 2994.8 3053.8 3105.6 150223.0 150704.0 151380.2 151667.2 151977.2 45352.8 45353.3 45519.3 45535.5 45564.0 49119.0 49633.5 49705.3 49896.5 53511.7 13942.7 14118.9 14181.6 14184.1 14187.7 10679.6 10737.6 10768.1 10798.5 10817.8 16755.3 16846.2 16872.3 16915.9 17009.3 6413.3 6684.4 6736.9 6743.4 6860.6 829.1 859.3 869.5 895.6 954.3 26393.1 27082.1 27232.6 27354.3 27384.6 928.4 958.2 966.1 990.7 1058.3 14453.6 14471.3 14514.6 14659.6 14670.5 266097.0 268407.0 270046.0 270938.0 271647.0 44314.0 45323.0 45603.3 45642.8 45660.3 1190.9 1214.0 1238.2 1259.3 1259.7 24809.8 25475.9 25854.0 26025.2 26752.3 43049.1 43947.6 43990.8 44016.0 44035.6 255819.0 256653.0 257788.0 259204.0 264409.0 35887.1 36397.1 36551.3 36780.2 36832.4 35383.8 37602.2 40103.0 40155.6 41376.6 33999.5 34814.1 34847.1 34911.1 34919.0 33766.5 33969.7 34332.5 34399.8 34435.0 28083.6 31526.0 31960.0 33283.0 34193.5 27970.3 28447.3 28482.0 28665.3 28873.6 22666.4 22825.7 22852.5 23118.2 23181.5 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#2] jquery.html Cycles:180 Average:20917.86 Median:4838.77 stddev:52745.95 (1090.1%) stddev-sans-first:52871.32 16:18:03 INFO - PROCESS | 9365 | Values: 354.1 354.8 356.0 361.9 363.9 14665.4 15221.4 15528.1 15534.8 15546.1 14485.9 14792.3 15110.8 15127.8 15262.2 4903.4 4947.5 5071.9 5086.7 5096.4 4984.2 5008.5 5065.0 5069.7 5094.2 4862.1 5035.1 5045.2 5055.9 5065.7 4993.1 5004.8 5007.8 5014.3 5038.6 4377.3 4463.7 4496.5 4520.0 4559.4 18672.2 18807.5 19107.1 19147.8 19180.7 1842.4 2006.4 2141.0 2236.3 2525.7 12535.2 12685.2 12728.2 12729.4 12961.4 1788.7 1795.5 1800.0 1846.7 1904.4 56896.0 57021.7 57037.4 57305.7 57321.7 8973.2 9128.5 9288.9 9391.8 9562.9 12456.6 12713.0 12723.6 12725.5 12735.3 6741.8 6819.6 6932.3 6985.9 7034.5 6433.1 6464.2 6516.8 6549.5 6591.1 5829.8 6027.6 6055.4 6082.5 6087.6 1767.3 1778.7 1789.2 1789.9 1801.7 850.4 882.5 922.8 932.2 985.6 14169.0 14686.9 15697.5 15754.0 16225.8 882.2 887.9 895.2 947.4 948.9 9308.8 9417.8 9476.9 9522.2 9552.5 302045.0 306917.0 310123.0 310367.0 368300.0 52778.0 58989.0 59137.7 64992.7 71799.3 941.5 953.1 972.6 980.0 980.5 13743.0 14326.3 14443.6 14584.1 14676.9 28851.9 31030.0 31134.8 31733.7 33533.3 42005.0 43714.6 44668.8 45145.0 45177.8 4815.4 4938.8 5230.8 6705.9 7272.5 8276.8 10666.7 11222.9 11351.7 11577.9 9811.6 9897.0 10081.9 10122.8 10248.9 9830.8 9874.9 9999.3 10198.2 10415.2 6948.9 10175.9 10176.7 10205.2 10237.6 7161.2 7405.4 7618.7 7663.6 8050.7 9488.0 9822.1 9856.4 10066.8 10070.4 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#3] mootools.html Cycles:180 Average:5069.40 Median:5034.42 stddev:2808.54 (55.8%) stddev-sans-first:2803.12 16:18:03 INFO - PROCESS | 9365 | Values: 1432.2 1451.6 1579.1 1720.5 1755.6 6494.6 7210.5 7433.8 7703.2 7746.2 7184.6 7190.9 7256.9 7273.3 7300.0 2115.6 2138.1 2141.0 2144.5 2152.1 2150.3 2167.6 2173.3 2182.9 2186.7 2156.9 2175.3 2176.9 2188.6 2234.9 2153.9 2155.0 2156.2 2161.7 2163.2 2129.7 2163.8 2179.2 2201.4 2203.7 7377.0 7448.2 7474.0 7477.2 7491.5 4545.1 4689.5 4717.6 4720.7 4727.7 2821.3 2832.4 2983.1 3003.0 3013.8 907.4 909.4 917.3 927.2 937.4 10571.6 10574.8 10574.9 10575.6 10623.7 4203.0 4280.4 4341.8 4350.3 4367.3 8644.4 8718.1 8746.5 8749.9 8755.1 4677.7 4714.6 4723.2 4725.2 4742.4 3576.7 4238.8 4249.1 4332.8 4351.1 3594.6 3614.2 3684.9 3742.5 3755.2 1183.7 1221.3 1224.1 1234.5 1236.3 833.8 861.7 863.0 878.7 893.4 5040.2 5128.4 5266.5 5321.8 5464.7 406.4 407.5 418.6 420.5 435.6 3653.5 3656.2 3679.0 3809.6 4031.1 9448.0 9617.4 9681.5 9683.0 9700.4 9516.6 9609.6 9712.8 9720.8 9721.6 7165.2 7292.1 7319.6 7369.7 7388.9 5028.7 5196.8 5211.9 5227.0 5427.7 8346.5 8394.1 8572.4 8582.0 8593.2 8594.5 8633.4 8674.0 8711.5 8820.1 5944.8 6656.5 6841.5 6890.0 6919.3 7261.4 7273.1 7330.0 7343.4 7403.3 6405.2 6760.1 6760.4 6779.1 6835.0 6509.5 6570.8 6677.4 6725.5 6752.6 6334.7 6497.4 6510.6 6532.0 6535.6 4489.8 4551.3 4628.7 4670.4 4683.4 4429.6 4440.5 4442.4 4466.0 4503.6 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#4] prototype.html Cycles:180 Average:4326.34 Median:4931.12 stddev:1262.22 (25.6%) stddev-sans-first:1229.02 16:18:03 INFO - PROCESS | 9365 | Values: 298.8 298.8 302.6 302.9 304.0 4917.6 4945.6 4967.4 4998.5 4998.8 4902.6 4905.2 4908.2 4923.9 4938.3 3640.9 3744.5 3832.7 3835.4 3853.6 3851.7 3868.0 3869.3 3869.5 3891.3 3846.3 3846.5 3851.4 3859.4 3881.1 3569.1 3802.1 3842.9 3879.2 3882.9 3315.5 3320.6 3328.8 3344.6 3349.7 4735.1 4794.9 4797.5 4801.5 4817.0 4348.7 4364.4 4383.3 4394.8 4397.7 5040.5 5137.6 5148.6 5162.9 5205.0 3603.9 3621.9 3632.4 3652.7 3657.0 5335.6 5423.3 5430.0 5439.6 5457.1 3580.9 3723.8 3738.8 3741.7 3748.6 3762.9 3777.7 3778.5 3783.5 3798.1 4304.6 4316.8 4317.1 4323.3 4324.7 5085.9 5209.3 5212.6 5231.1 5232.9 1373.7 1374.7 1379.4 1382.0 1390.0 838.4 887.6 899.4 922.9 928.9 4492.3 4574.7 4609.6 4612.2 4636.7 5316.7 5328.0 5378.3 5382.5 5400.5 4420.5 4581.0 4645.4 4683.6 4688.6 3068.7 3068.8 3080.6 3082.2 3088.3 5325.8 5373.1 5405.4 5411.3 5423.9 5236.8 5494.9 5563.5 5849.6 5884.3 5089.4 5094.5 5109.4 5115.8 5137.7 5351.8 5400.6 5418.9 5429.8 5433.2 5166.2 5255.6 5267.4 5287.2 5307.7 5034.5 5065.8 5095.3 5126.8 5152.4 3686.5 3740.7 3743.9 3761.5 3770.8 5253.2 5274.9 5346.2 5362.6 5399.9 5166.0 5166.8 5169.3 5191.0 5236.5 5122.8 5194.2 5206.9 5238.3 5240.3 4893.0 5171.0 5177.4 5178.3 5191.0 5013.7 5087.7 5146.8 5228.0 5231.2 5049.6 5083.5 5092.9 5104.0 5130.5 16:18:03 INFO - PROCESS | 9365 | 16:18:03 INFO - PROCESS | 9365 | [#5] yui.html Cycles:180 Average:12795.22 Median:24829.97 stddev:15133.91 (61.0%) stddev-sans-first:15148.70 16:18:03 INFO - PROCESS | 9365 | Values: 608.7 740.0 760.2 762.8 765.3 11575.7 12160.8 12315.0 12397.6 12415.4 11087.2 11235.8 11250.7 11258.9 11294.6 630.3 765.2 777.1 795.7 796.0 769.2 774.0 774.3 775.2 776.9 817.7 818.9 819.7 822.3 823.3 815.0 815.4 815.7 818.1 818.6 599.3 601.4 603.1 604.8 606.4 11837.8 11863.9 11865.0 11877.8 11877.9 12268.9 12743.7 12759.7 12777.1 13135.3 9998.7 10083.8 10099.7 10451.1 10548.9 3316.3 3322.2 3382.0 3401.0 3457.1 44208.1 44505.0 44732.6 45576.0 45907.0 9428.6 9438.6 9546.9 9614.6 9866.4 17134.1 17134.9 17147.9 17151.2 17175.6 6530.2 6579.6 6600.1 6756.3 6785.1 3282.4 3530.1 3575.7 3683.3 3712.6 2738.4 2812.5 2817.1 2818.1 2828.5 508.2 516.6 520.2 520.9 527.6 480.9 506.6 614.4 615.1 621.2 7908.0 8072.2 8091.3 8173.5 8271.3 492.2 562.3 581.9 596.7 597.7 3578.9 3626.7 3663.2 3692.4 3719.4 55699.7 55831.7 55895.4 56044.2 56954.7 47985.0 48092.0 48319.3 49167.8 51225.5 44483.1 44537.6 44916.6 45306.0 45389.3 7283.3 7303.7 7318.2 7360.0 7508.4 28696.4 29004.0 29288.3 30525.0 30928.2 39488.0 40607.8 41091.2 41282.2 41654.6 9437.3 9566.9 9682.0 9776.2 9803.4 10422.8 10425.6 10735.6 10993.4 11171.6 10052.8 10297.7 10429.1 10569.7 10847.5 9958.1 9981.3 10049.8 10147.8 10182.2 9976.4 10128.8 10152.7 10203.3 10347.6 8724.6 8731.3 8914.1 9059.2 9445.5 8258.7 8472.4 8483.7 8581.4 8734.7 16:18:03 INFO - PROCESS | 9365 | -------- Summary: end -------- 16:18:03 INFO - PROCESS | 9365 | 16:18:04 INFO - TEST-INFO | 9365: exit 0 16:18:04 INFO - TEST-OK | dromaeo_css | took 1114340ms 16:18:04 INFO - TEST-START | kraken 16:18:04 INFO - operating with platform_type : linux_ 16:18:04 INFO - Initialising browser for kraken test... 16:18:04 INFO - TEST-INFO | started process 9599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTn9mJC/profile http://localhost:34081/getInfo.html) 16:18:07 INFO - PROCESS | 9599 | 16:18:07 INFO - PROCESS | 9599 | (process:9669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:08 INFO - PROCESS | 9599 | __metrics Screen width/height:1600/1200 16:18:08 INFO - PROCESS | 9599 | colorDepth:24 16:18:08 INFO - PROCESS | 9599 | Browser inner width/height: 1024/697 16:18:08 INFO - PROCESS | 9599 | __metrics 16:18:09 ERROR - PROCESS | 9599 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:18:10 INFO - TEST-INFO | 9599: exit 0 16:18:10 INFO - Browser initialized. 16:18:10 INFO - Running cycle 1/1 for kraken test... 16:18:10 INFO - TEST-INFO | started process 9720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTn9mJC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:12 INFO - PROCESS | 9720 | 16:18:12 INFO - PROCESS | 9720 | (process:9780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:22 INFO - PROCESS | 9720 | RSS: Main: 166088704 16:18:22 INFO - PROCESS | 9720 | 16:18:24 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34081/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:25 INFO - PROCESS | 9720 | RSS: Main: 170024960 16:18:25 INFO - PROCESS | 9720 | 16:18:28 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34081/tests/kraken/driver.html?testName=audio-dft) 16:18:29 INFO - PROCESS | 9720 | RSS: Main: 173535232 16:18:29 INFO - PROCESS | 9720 | 16:18:32 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34081/tests/kraken/driver.html?testName=audio-fft) 16:18:32 INFO - PROCESS | 9720 | RSS: Main: 163647488 16:18:32 INFO - PROCESS | 9720 | 16:18:35 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34081/tests/kraken/driver.html?testName=audio-oscillator) 16:18:35 INFO - PROCESS | 9720 | RSS: Main: 164163584 16:18:35 INFO - PROCESS | 9720 | 16:18:37 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:38 INFO - PROCESS | 9720 | RSS: Main: 166465536 16:18:38 INFO - PROCESS | 9720 | 16:18:41 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34081/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:42 INFO - PROCESS | 9720 | RSS: Main: 166162432 16:18:42 INFO - PROCESS | 9720 | 16:18:45 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34081/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:46 INFO - PROCESS | 9720 | RSS: Main: 165289984 16:18:46 INFO - PROCESS | 9720 | 16:18:49 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34081/tests/kraken/driver.html?testName=json-parse-financial) 16:18:50 INFO - PROCESS | 9720 | RSS: Main: 166076416 16:18:50 INFO - PROCESS | 9720 | 16:18:51 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:52 INFO - PROCESS | 9720 | RSS: Main: 166387712 16:18:52 INFO - PROCESS | 9720 | 16:18:54 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:54 INFO - PROCESS | 9720 | RSS: Main: 166174720 16:18:54 INFO - PROCESS | 9720 | 16:18:57 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:57 INFO - PROCESS | 9720 | RSS: Main: 167612416 16:18:57 INFO - PROCESS | 9720 | 16:19:00 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:01 INFO - PROCESS | 9720 | RSS: Main: 167366656 16:19:01 INFO - PROCESS | 9720 | 16:19:04 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:05 INFO - PROCESS | 9720 | RSS: Main: 165154816 16:19:05 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | Cycle 1(1): loaded http://localhost:34081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34081/tests/kraken/driver.html?testName=ai-astar) 16:19:07 INFO - PROCESS | 9720 | RSS: Main: 167034880 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | __start_tp_report 16:19:07 INFO - PROCESS | 9720 | _x_x_mozilla_page_load 16:19:07 INFO - PROCESS | 9720 | _x_x_mozilla_page_load_details 16:19:07 INFO - PROCESS | 9720 | |i|pagename|runs| 16:19:07 INFO - PROCESS | 9720 | |0;ai-astar;116;109;114;116;116;126;116;114;118;114 16:19:07 INFO - PROCESS | 9720 | |1;audio-beat-detection;163;132;157;190;138;156;161;144;183;138 16:19:07 INFO - PROCESS | 9720 | |2;audio-dft;163;161;164;171;164;162;164;164;168;161 16:19:07 INFO - PROCESS | 9720 | |3;audio-fft;74;80;73;168;74;77;78;74;152;75 16:19:07 INFO - PROCESS | 9720 | |4;audio-oscillator;96;95;145;93;94;95;135;95;94;153 16:19:07 INFO - PROCESS | 9720 | |5;imaging-gaussian-blur;117;118;118;119;119;118;118;118;118;117 16:19:07 INFO - PROCESS | 9720 | |6;imaging-darkroom;148;146;147;148;147;146;146;147;148;146 16:19:07 INFO - PROCESS | 9720 | |7;imaging-desaturate;95;95;96;97;96;96;95;96;95;96 16:19:07 INFO - PROCESS | 9720 | |8;json-parse-financial;65;69;67;67;66;67;67;82;64;66 16:19:07 INFO - PROCESS | 9720 | |9;json-stringify-tinderbox;64;65;64;64;66;65;65;65;64;65 16:19:07 INFO - PROCESS | 9720 | |10;stanford-crypto-aes;87;80;82;80;80;80;90;80;81;79 16:19:07 INFO - PROCESS | 9720 | |11;stanford-crypto-ccm;135;141;138;135;133;134;137;133;172;138 16:19:07 INFO - PROCESS | 9720 | |12;stanford-crypto-pbkdf2;225;214;237;219;228;219;217;219;214;217 16:19:07 INFO - PROCESS | 9720 | |13;stanford-crypto-sha256-iterative;75;76;76;75;74;74;74;75;75;79 16:19:07 INFO - PROCESS | 9720 | __end_tp_report 16:19:07 INFO - PROCESS | 9720 | __start_cc_report 16:19:07 INFO - PROCESS | 9720 | _x_x_mozilla_cycle_collect,956 16:19:07 INFO - PROCESS | 9720 | __end_cc_report 16:19:07 INFO - PROCESS | 9720 | __startTimestamp1461712747343__endTimestamp 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | ------- Summary: start ------- 16:19:07 INFO - PROCESS | 9720 | Number of tests: 14 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:4.28 (3.7%) stddev-sans-first:4.54 16:19:07 INFO - PROCESS | 9720 | Values: 116.0 109.0 114.0 116.0 116.0 126.0 116.0 114.0 118.0 114.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:159.00 stddev:19.23 (12.1%) stddev-sans-first:20.24 16:19:07 INFO - PROCESS | 9720 | Values: 163.0 132.0 157.0 190.0 138.0 156.0 161.0 144.0 183.0 138.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.12 (1.9%) stddev-sans-first:3.28 16:19:07 INFO - PROCESS | 9720 | Values: 163.0 161.0 164.0 171.0 164.0 162.0 164.0 164.0 168.0 161.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.50 stddev:35.84 (48.1%) stddev-sans-first:37.38 16:19:07 INFO - PROCESS | 9720 | Values: 74.0 80.0 73.0 168.0 74.0 77.0 78.0 74.0 152.0 75.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:94.50 stddev:24.42 (25.8%) stddev-sans-first:25.41 16:19:07 INFO - PROCESS | 9720 | Values: 96.0 95.0 145.0 93.0 94.0 95.0 135.0 95.0 94.0 153.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 16:19:07 INFO - PROCESS | 9720 | Values: 117.0 118.0 118.0 119.0 119.0 118.0 118.0 118.0 118.0 117.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 16:19:07 INFO - PROCESS | 9720 | Values: 148.0 146.0 147.0 148.0 147.0 146.0 146.0 147.0 148.0 146.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 16:19:07 INFO - PROCESS | 9720 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 95.0 96.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.00 stddev:5.10 (7.6%) stddev-sans-first:5.29 16:19:07 INFO - PROCESS | 9720 | Values: 65.0 69.0 67.0 67.0 66.0 67.0 67.0 82.0 64.0 66.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:19:07 INFO - PROCESS | 9720 | Values: 64.0 65.0 64.0 64.0 66.0 65.0 65.0 65.0 64.0 65.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:3.63 (4.5%) stddev-sans-first:3.35 16:19:07 INFO - PROCESS | 9720 | Values: 87.0 80.0 82.0 80.0 80.0 80.0 90.0 80.0 81.0 79.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:137.50 stddev:11.66 (8.5%) stddev-sans-first:12.25 16:19:07 INFO - PROCESS | 9720 | Values: 135.0 141.0 138.0 135.0 133.0 134.0 137.0 133.0 172.0 138.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.90 Median:219.00 stddev:7.17 (3.3%) stddev-sans-first:7.45 16:19:07 INFO - PROCESS | 9720 | Values: 225.0 214.0 237.0 219.0 228.0 219.0 217.0 219.0 214.0 217.0 16:19:07 INFO - PROCESS | 9720 | 16:19:07 INFO - PROCESS | 9720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.00 stddev:1.49 (2.0%) stddev-sans-first:1.58 16:19:07 INFO - PROCESS | 9720 | Values: 75.0 76.0 76.0 75.0 74.0 74.0 74.0 75.0 75.0 79.0 16:19:07 INFO - PROCESS | 9720 | -------- Summary: end -------- 16:19:07 INFO - PROCESS | 9720 | 16:19:08 INFO - TEST-INFO | 9720: exit 0 16:19:08 INFO - TEST-OK | kraken | took 64365ms 16:19:08 INFO - SUITE-END | took 1178s 16:19:08 INFO - Completed test suite (00:19:38) 16:19:08 INFO - javascript benchmark 16:19:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.960340594891, 2701.9729802701972, 2734.3164208947765, 2741.849198294093, 2750.33991841958, 4756.928646070307, 4786.4974177711365, 4794.904101917964, 4803.279508073786, 4865.7810398532065, 4687.390639216906, 4734.550217729319, 4740.885891815421, 4753.310769938357, 4763.642726795487, 4286.76422796746, 4324.17840610283, 4365.672574556905, 4403.647708183337, 4506.391637128995, 4386.802593883267, 4403.4495688039, 4453.554644535553, 4476.753778542179, 4489.932651010237, 4437.6671749618745, 4441.822327106928, 4450.0, 4453.599176074153, 4461.866144015685, 247.678346037499, 4406.361077643755, 4463.4420697412825, 4465.0400163964905, 4466.798994045275, 4406.7355958642265, 4420.160169567772, 4422.800973956179, 4430.689851710382, 4472.1502914446155, 4753.572178503951, 4761.309610106515, 4781.784819683123, 4784.234522476387, 4795.520447955177, 4914.852554423373, 5045.192769156954, 5053.115704751691, 5105.974470127626, 5127.359080114986, 5146.150885103953, 5154.252633368178, 5171.818986335498, 5183.067047931371, 5219.895602087937, 4784.40194975628, 4792.353032340624, 4798.2082956312515, 4801.975990120062, 4845.297431872359, 5294.126469132627, 5294.205869119586, 5308.708021058879, 5309.150535914235, 5355.116405793001, 5047.899042019212, 5056.089903817275, 5058.342415486037, 5067.163917953497, 5075.593952483792, 4891.828785992473, 5042.697438153723, 5143.717095559706, 5168.586513078944, 5171.3535808024, 5119.0273847968765, 5130.538251557377, 5136.922946155811, 5142.665726727825, 5155.871103222375, 5128.230765385222, 5128.820491282787, 5153.123968925292, 5153.871153221125, 5201.323827902348, 4209.4948606166845, 4258.169656916872, 4302.720323178984, 4332.588404101605, 4332.9133417332105, 3664.1206110533813, 3735.477033215352, 3757.3988161893967, 3780.4896338994436, 3814.561325447609, 4489.685721999429, 4492.797824097924, 4502.257127573979, 4516.074204788077, 4550.089982003613, 4968.6025117990475, 5101.770420331094, 5166.6641668292195, 5204.739763011834, 5229.869253268699, 4458.977705111453, 4466.9553304466535, 4467.6202522785925, 4469.463664360298, 4506.256467682796, 4589.541045895384, 4591.242444996605, 4593.6095431888, 4593.63250939924, 4596.5863072323655, 4739.4075740532435, 4748.0978614063215, 4795.376601041842, 4808.134535783593, 4842.757862106951, 5107.438181800073, 5172.0, 5175.663581867167, 5192.9740351298005, 5208.947910520847, 4693.788779504999, 4849.151398505177, 4861.1979023460735, 4863.440704318907, 4908.8772780680765, 4979.477154898828, 5024.748762561784, 5040.36995375578, 5055.34280543527, 5089.796408143633, 5131.358580177478, 5156.04613146569, 5171.224316352577, 5183.663061900965, 5205.427402985592, 4818.71087734737, 4971.328870602422, 5017.874553136201, 5025.723585202849, 5040.34475518195, 4913.0, 4917.729524876167, 4977.352944117241, 4997.825076122318, 5018.0, 4842.201036828884, 4862.805487780449, 4875.488073752347, 4878.243872199815, 4895.265710143507, 4837.95162048375, 4963.329950456642, 4984.825531106394, 5041.722705251246, 5047.570956468741, 4804.495527969652, 4875.219964805614, 4916.729579873141, 4994.575461085703, 5005.949940500694], "value": 4678.729747310917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6390328238286, 604.0878273806551, 606.5238787551772, 623.3548277532755, 631.2771876201746, 31721.84139079304, 32733.508997365057, 32743.672563274362, 32746.67253327466, 32819.67180328196, 32600.184995375126, 32812.83593582029, 33056.33887322252, 33130.50304245438, 33265.66734332656, 7366.300201480864, 7524.774256772305, 7556.811079723024, 7560.43296752743, 7575.090989081318, 7575.356094731955, 7718.2281771822645, 7755.883661745078, 7775.805604859867, 7788.415868809862, 7729.420293477983, 7741.961290193542, 7804.726834560792, 7805.921940780605, 7814.452988290822, 7701.3453856422275, 7762.9611851940945, 7767.922320776776, 7768.262015108556, 7775.727849525239, 7598.468107232496, 7763.689452421896, 7770.106437759617, 7782.105057918356, 7807.960960195162, 24932.50134997308, 32845.0, 33687.831560842285, 33693.6630633693, 33778.6622133778, 2735.275152084699, 2752.1881045091745, 2786.6934637189893, 2941.749951254146, 3211.2614098757185, 26936.19191424241, 27055.188344349503, 27391.45217095647, 27421.0, 27461.17616471509, 2978.7616990640913, 2993.0, 2994.7753918455987, 3053.7709671774705, 3105.580746599203, 150223.0, 150704.0, 151380.2430987849, 151667.24166379208, 151977.24011379873, 45352.77323613427, 45353.31970020452, 45519.317210241876, 45535.5446445538, 45564.0, 49119.0, 49633.50366496361, 49705.25442118371, 49896.50103498918, 53511.732441337546, 13942.651433714238, 14118.85881141196, 14181.645458863404, 14184.148951062969, 14187.716245675028, 10679.57281708723, 10737.624183153708, 10768.138548916068, 10798.51406686701, 10817.78364432707, 16755.329786808634, 16846.157692115346, 16872.325106995828, 16915.915420422818, 17009.319627214772, 6413.262474815456, 6684.364985326386, 6736.932630673728, 6743.35938085881, 6860.5540639858245, 829.0962850492991, 859.26532814444, 869.5434896679168, 895.6238379880466, 954.3224310739453, 26393.0848859215, 27082.05212817542, 27232.59151112735, 27354.316142096606, 27384.58923116155, 928.3501548915785, 958.2259359155206, 966.1304825656965, 990.7077412163429, 1058.3385384134915, 14453.566393008226, 14471.276436178148, 14514.564563063124, 14659.560213193621, 14670.486532971508, 266097.0, 268407.0, 270046.0, 270938.0, 271647.0, 44314.0, 45323.0, 45603.315950260774, 45642.77178614086, 45660.315095273596, 1190.856777493616, 1213.991870677927, 1238.2446707508414, 1259.3451405269209, 1259.703969567151, 24809.751902480744, 25475.87262063678, 25854.0, 26025.21924342273, 26752.33119172036, 43049.139017220106, 43947.56052439435, 43990.780046099564, 44016.0, 44035.55964440315, 255819.0, 256653.0, 257788.0, 259204.0, 264409.0, 35887.102822429646, 36397.0900727484, 36551.26897462089, 36780.24148188843, 36832.44751328786, 35383.82308088443, 37602.24795504129, 40103.0, 40155.59844401635, 41376.58623413727, 33999.470023848495, 34814.12964675802, 34847.12882177966, 34911.12722181966, 34919.0, 33766.49350259797, 33969.660303397635, 34332.48501272533, 34399.82800085984, 34435.0, 28083.595820209317, 31526.0, 31960.0, 33283.0, 34193.48709769405, 27970.300742481602, 28447.28881777972, 28482.0, 28665.28336791597, 28873.56689649699, 22666.43333916665, 22825.657615135453, 22852.542949141258, 23118.1908633197, 23181.536369272184], "value": 16280.428814935205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.063502037112, 354.79421935277543, 355.9893203203904, 361.9348517266891, 363.87082585682083, 14665.413383464649, 15221.391144354226, 15528.145951972638, 15534.766978495332, 15546.067235965837, 14485.927570362133, 14792.334344954475, 15110.773338399933, 15127.773083403757, 15262.236888155603, 4903.436104847935, 4947.480514545975, 5071.898562028776, 5086.6693664911845, 5096.362954630671, 4984.177610694249, 5008.499150084981, 5064.987002599476, 5069.695818250898, 5094.184930411135, 4862.100511405383, 5035.144025515671, 5045.192769156935, 5055.898882022358, 5065.721385323805, 4993.051320249159, 5004.84985450437, 5007.774650140753, 5014.323066386028, 5038.622103342264, 4377.34339849022, 4463.732176069446, 4496.460424749019, 4519.954800451987, 4559.4072770539615, 18672.15975281102, 18807.529811754677, 19107.140178691992, 19147.808521914743, 19180.71228931567, 1842.4012196036342, 2006.4081096076693, 2140.9830330592845, 2236.284388995522, 2525.734797846218, 12535.24788512692, 12685.175463594836, 12728.23630582168, 12729.363531823372, 12961.41673624689, 1788.6780379531679, 1795.4613615915173, 1800.0459756329167, 1846.732223827551, 1904.4286713985748, 56896.0, 57021.714891425276, 57037.429625703626, 57305.71347143321, 57321.71339143278, 8973.192412682889, 9128.49793261377, 9288.907110928803, 9391.812163756687, 9562.896162844303, 12456.626301210978, 12713.0, 12723.55467558631, 12725.490980360866, 12735.299558524184, 6741.831454213586, 6819.624920629413, 6932.272111428329, 6985.89521157183, 7034.5427547209265, 6433.067205255212, 6464.191976003, 6516.804495865132, 6549.508786841006, 6591.143151390384, 5829.825105246765, 6027.578069535178, 6055.424734650202, 6082.482988945901, 6087.634741915499, 1767.2930827669036, 1778.7154055351082, 1789.168036862865, 1789.865760068, 1801.73874788155, 850.4302117581235, 882.5146169606691, 922.8292765838341, 932.1657116880355, 985.5564995751797, 14169.008169428042, 14686.926565367105, 15697.450589229322, 15754.0, 16225.756613650805, 882.1575395497284, 887.8845750052581, 895.1853813030111, 947.3984020147118, 948.9478078705738, 9308.813823723487, 9417.811643767087, 9476.905230947741, 9522.190613797904, 9552.474613896164, 302045.0, 306917.0, 310123.0, 310367.0, 368300.0, 52778.0, 58989.0, 59137.70431147903, 64992.67503662546, 71799.2820071803, 941.4774799986074, 953.0564740906591, 972.6206779356057, 979.9510024498746, 980.5342462330478, 13742.96015971845, 14326.283685815459, 14443.638909027359, 14584.052036617586, 14676.926615366854, 28851.855740721163, 31029.983051101604, 31134.844325778227, 31733.682663173997, 33533.32933341368, 42005.0, 43714.56285437105, 44668.77665611651, 45145.0, 45177.774111129234, 4815.446223684181, 4938.802447902043, 5230.790768369223, 6705.932940670531, 7272.527285726411, 8276.793080173044, 10666.679999599713, 11222.887771122185, 11351.716207094889, 11577.942110289394, 9811.55847986828, 9896.950515247378, 10081.89918100839, 10122.79754404893, 10248.897511024794, 9830.75423114428, 9874.901250987397, 9999.3000489965, 10198.184145268213, 10415.1667866572, 6948.895766563404, 10175.898241017496, 10176.745581360525, 10205.2140875348, 10237.590496380062, 7161.176464706626, 7405.370543503647, 7618.733344332922, 7663.616819159131, 8050.718224862336, 9488.0, 9822.116009558888, 9856.408615483095, 10066.8489972649, 10070.44612546317], "value": 7823.816754715365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.219440404979, 1451.5717863230345, 1579.1472604793405, 1720.5010546941387, 1755.5786611213305, 6494.610323380601, 7210.4952653314285, 7433.81415464613, 7703.229677032294, 7746.186650401704, 7184.568925864439, 7190.892136617955, 7256.927430725705, 7273.2726727327245, 7300.0, 2115.629764791163, 2138.091311192737, 2140.978590214101, 2144.453164443065, 2152.0961196297512, 2150.2689085710854, 2167.6098302305577, 2173.271953895439, 2182.9345119646437, 2186.7485239197536, 2156.8598041127275, 2175.3365223606793, 2176.869387836727, 2188.6388745856993, 2234.944126396837, 2153.924612638558, 2154.997925964434, 2156.1914282144194, 2161.7189765330563, 2163.167180635459, 2129.7231359923267, 2163.7836216378237, 2179.2154824263253, 2201.4276288165033, 2203.6584329428965, 7376.963115184443, 7448.217937116633, 7474.0, 7477.21489243627, 7491.513051651626, 4545.11370282795, 4689.50760170184, 4717.599004084657, 4720.740359280238, 4727.66906316558, 2821.3369858083333, 2832.4335132973283, 2983.1498023063323, 3002.9699703002907, 3013.819170849756, 907.4464576608264, 909.4225167018991, 917.2936838634214, 927.1979737527058, 937.3813283233034, 10571.577136914515, 10574.841377379345, 10574.894251057545, 10575.576976920915, 10623.734406639818, 4202.957970420318, 4280.379344994958, 4341.8480353188115, 4350.260455722535, 4367.30123180296, 8644.394892357475, 8718.128187181357, 8746.51894145828, 8749.912500875038, 8755.0807165248, 4677.695949763254, 4714.5521175488275, 4723.173444647242, 4725.173094708481, 4742.4309082909585, 3576.7317451191266, 4238.788060596958, 4249.128928569636, 4332.761698106571, 4351.108022855307, 3594.5506811648543, 3614.204874927512, 3684.8710295140077, 3742.4947632069866, 3755.192633583738, 1183.6567395455222, 1221.3099598726692, 1224.1430998301225, 1234.493857518413, 1236.3385588709998, 833.7623777223462, 861.7328628125301, 862.9913700862911, 878.6617152396374, 893.3523195683077, 5040.168372218543, 5128.358955130609, 5266.499682530153, 5321.840344789663, 5464.672119672832, 406.3843277434689, 407.5374449999213, 418.56051146296875, 420.53530848412674, 435.5861931165405, 3653.5250417446096, 3656.1590834108306, 3678.9882782234563, 3809.580946095927, 4031.0728532437115, 9447.952760236292, 9617.422954622605, 9681.51592420376, 9682.95158524217, 9700.417974921527, 9516.619335226653, 9609.615615375447, 9712.75718107053, 9720.75698107553, 9721.61113555464, 7165.176004759519, 7292.124945006633, 7319.597422141726, 7369.742059027908, 7388.889166662504, 5028.673136246132, 5196.766145523385, 5211.9478805211465, 5226.980738755906, 5427.701476418835, 8346.457480263764, 8394.0766515682, 8572.442791218551, 8582.0, 8593.226609605166, 8594.527300998505, 8633.39566230383, 8674.0, 8711.47731136134, 8820.11798820113, 5944.762209511571, 6656.500762442739, 6841.486888483483, 6889.965550172217, 6919.342662447059, 7261.419086473175, 7273.0908636420445, 7329.963350183215, 7343.412526997934, 7403.333699967029, 6405.167328247298, 6760.121184246016, 6760.391564759196, 6779.050932869303, 6835.0, 6509.544331896722, 6570.77002304917, 6677.432418244503, 6725.529212955046, 6752.561083529555, 6334.746610135728, 6497.4477169441125, 6510.641914694548, 6531.967340163269, 6535.640539770358, 4489.797959091783, 4551.271796512542, 4628.745419001987, 4670.392848929618, 4683.414573178353, 4429.64562834966, 4440.4671439427475, 4442.444694413199, 4466.017476155241, 4503.617192538671], "value": 4046.2608892958765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7669617698196, 298.7983111399805, 302.62021163439886, 302.9000429858146, 303.9711227433393, 4917.557419832215, 4945.604351651873, 4967.354243948286, 4998.525140111693, 4998.775055122519, 4902.60779137669, 4905.2396878483805, 4908.190148625481, 4923.926141107886, 4938.308636790844, 3640.872569460076, 3744.457053727208, 3832.6550610445056, 3835.42468629705, 3853.5953724858905, 3851.7496362736474, 3868.013656517584, 3869.2528304903553, 3869.496965394509, 3891.3190191716476, 3846.2692088503236, 3846.4614953906475, 3851.383778595425, 3859.4017927221325, 3881.0879443330937, 3569.1434055826417, 3802.1445174835717, 3842.865499707497, 3879.1659793144468, 3882.8835134945857, 3315.469524876032, 3320.638538199351, 3328.7503437242303, 3344.6320904700465, 3349.748768842322, 4735.147673418784, 4794.856154315376, 4797.52024797521, 4801.495842936476, 4816.951830481686, 4348.652107831366, 4364.432623758923, 4383.276759334706, 4394.758288294142, 4397.692161548693, 5040.495950404967, 5137.614678899097, 5148.613853960968, 5162.948370516285, 5205.0110479009245, 3603.927921441583, 3621.8732344368086, 3632.4369722693023, 3652.7077833773233, 3656.9817150914073, 5335.599830012726, 5423.349198096214, 5430.0, 5439.640089977505, 5457.126859702468, 3580.9283814323567, 3723.7765734056043, 3738.775673459601, 3741.6904083571076, 3748.5876553579083, 3762.9087564606507, 3777.735558510878, 3778.4521244419407, 3783.5270591176104, 3798.0694729791376, 4304.5910638489295, 4316.848910288125, 4317.136572685476, 4323.329883868006, 4324.718893271927, 5085.923711144335, 5209.322788037531, 5212.582993360522, 5231.110711179109, 5232.895342093137, 1373.6977864869712, 1374.6632075141454, 1379.3999610169608, 1381.9930900345435, 1390.0269811132248, 838.3712215838121, 887.5843030366555, 899.4198741811495, 922.9077092290718, 928.8885333759993, 4492.326151077365, 4574.656900732459, 4609.640156153942, 4612.192866248393, 4636.744979026186, 5316.660669305493, 5328.0, 5378.273933019071, 5382.49290198745, 5400.540954018874, 4420.491643461043, 4580.977095114503, 4645.442546894395, 4683.555062269079, 4688.578027977498, 3068.6777888321853, 3068.7544996400234, 3080.5995220621176, 3082.1832214463184, 3088.336007758343, 5325.843033571332, 5373.086575282211, 5405.405405405402, 5411.269478620415, 5423.945760542344, 5236.790528378822, 5494.917576236279, 5563.5271001964475, 5849.61977471463, 5884.293884733859, 5089.414717307557, 5094.465081166498, 5109.38687357512, 5115.846524604268, 5137.691738495777, 5351.839444816662, 5400.648957817729, 5418.943306055281, 5429.755660995185, 5433.212184233185, 5166.184429486014, 5255.554722451357, 5267.445289034892, 5287.206918962186, 5307.681539107666, 5034.496550345083, 5065.797368105234, 5095.33760611133, 5126.79492820283, 5152.355955505562, 3686.4838922551403, 3740.7007439404238, 3743.887683369503, 3761.511003569628, 3770.7737535747942, 5253.212018197301, 5274.920876186937, 5346.166531738185, 5362.597805164551, 5399.919001215064, 5165.974170129276, 5166.793328266827, 5169.302144210484, 5191.0, 5236.476352364885, 5122.8207012755865, 5194.246834209094, 5206.947930520646, 5238.319018527567, 5240.318758561362, 4892.975535122301, 5171.01750667372, 5177.378714554277, 5178.275041494118, 5190.97404512975, 5013.699178049329, 5087.694738315713, 5146.845594632167, 5227.98722491851, 5231.163013917755, 5049.6465247432325, 5083.46623604531, 5092.905025419553, 5104.014151721285, 5130.538251557377], "value": 3927.0191747713106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6621924831718, 739.9926000739995, 760.1828034862524, 762.7559181062062, 765.2997507280838, 11575.65273041809, 12160.756784864298, 12315.0, 12397.628071157857, 12415.441305141268, 11087.22389432738, 11235.83146252807, 11250.718732031703, 11258.943705281463, 11294.604688835892, 630.2500024970294, 765.2194761343426, 777.0869228656335, 795.6737737527615, 796.040770871099, 769.2346115614971, 773.9729109481169, 774.2644487736644, 775.2480094308512, 776.9300762931335, 817.7464985854374, 818.9181081891793, 819.713100414856, 822.3092602214139, 823.283743143466, 814.9633266503022, 815.3721634341524, 815.6859609050499, 818.10008990111, 818.5907046476761, 599.3287517979846, 601.3775742106942, 603.0592276049333, 604.782278379783, 606.429955841512, 11837.822432663517, 11863.94068029663, 11865.0, 11877.821832672516, 11877.881221187765, 12268.877311226863, 12743.74512509754, 12759.74480510394, 12777.110407338689, 13135.277559734212, 9998.700038998843, 10083.798324033478, 10099.697009089665, 10451.111655509214, 10548.947255263674, 3316.3201543683485, 3322.1528510229978, 3381.9830900845586, 3401.0137060252496, 3457.083872773717, 44208.12647177956, 44505.0, 44732.55267447316, 45576.0, 45907.0, 9428.575714092882, 9438.575264112995, 9546.904530954602, 9614.567344469515, 9866.408015519091, 17134.14329283531, 17134.91432542854, 17147.914260428617, 17151.228194731266, 17175.570610734583, 6530.216374035052, 6579.605223686594, 6600.108985287021, 6756.2568117507035, 6785.117934668461, 3282.425575524274, 3530.135116896377, 3575.696065834381, 3683.318586061587, 3712.554493460802, 2738.370174859793, 2812.4656315300026, 2817.112609527992, 2818.126380821952, 2828.476731804623, 508.22241969785546, 516.6435159739767, 520.2066848056668, 520.8958208358343, 527.6174773289334, 480.92305231162845, 506.55170174395926, 614.3886832601501, 615.1019511513151, 621.1738387944024, 7907.966936862127, 8072.233137851895, 8091.271785539329, 8173.468724532886, 8271.255586997198, 492.1878899815262, 562.2830890614499, 581.9447152520504, 596.7195418153461, 597.6862147372664, 3578.946315805265, 3626.746127771031, 3663.175785448253, 3692.409214525717, 3719.386301260262, 55699.72150139305, 55831.72084139553, 55895.441045589025, 56044.15933760997, 56954.7152264236, 47985.0, 48092.0, 48319.27521087186, 49167.75416122968, 51225.487745122075, 44483.11033779306, 44537.55462445399, 44916.55083449189, 45306.0, 45389.319160212624, 7283.308085731847, 7303.707851686086, 7318.1949985502615, 7359.963200183965, 7508.399328053852, 28696.426071478872, 29004.0, 29288.267793304487, 30525.0, 30928.22679432942, 39488.0, 40607.796961015, 41091.1781764369, 41282.1743565133, 41654.58345416507, 9437.339386243171, 9566.856497152408, 9681.951590242004, 9776.1690256329, 9803.36278141947, 10422.791544169226, 10425.63510277167, 10735.624253151102, 10993.395363254778, 11171.553137874394, 10052.798944020933, 10297.691069267934, 10429.11352535043, 10569.682909512727, 10847.45762711877, 9958.103770660675, 9981.301308908307, 10049.849252261076, 10147.847782283125, 10182.236332275257, 9976.401415915068, 10128.797424051625, 10152.695419137437, 10203.28576999603, 10347.586096556053, 8724.607392667218, 8731.301495880187, 8914.108589141035, 9059.22996545301, 9445.527723613654, 8258.710945116893, 8472.44929079608, 8483.660653574036, 8581.35639827028, 8734.69428569997], "value": 5785.279568393396, "unit": "score"}], "name": "dromaeo_css", "value": 6162.872017569194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 116.0, 116.0, 126.0, 116.0, 114.0, 118.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 157.0, 190.0, 138.0, 156.0, 161.0, 144.0, 183.0, 138.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 171.0, 164.0, 162.0, 164.0, 164.0, 168.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 73.0, 168.0, 74.0, 77.0, 78.0, 74.0, 152.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 145.0, 93.0, 94.0, 95.0, 135.0, 95.0, 94.0, 153.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 67.0, 67.0, 66.0, 67.0, 67.0, 82.0, 64.0, 66.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 82.0, 80.0, 80.0, 80.0, 90.0, 80.0, 81.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 138.0, 135.0, 133.0, 134.0, 137.0, 133.0, 172.0, 138.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 214.0, 237.0, 219.0, 228.0, 219.0, 217.0, 219.0, 214.0, 217.0], "value": 220.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 75.0, 74.0, 74.0, 74.0, 75.0, 75.0, 79.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1649.3000000000002, "alertThreshold": 2.0}]} 16:19:08 INFO - Return code: 0 16:19:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:08 ERROR - # TBPL SUCCESS # 16:19:08 INFO - Running post-action listener: _resource_record_post_action 16:19:08 INFO - Running post-run listener: _resource_record_post_run 16:19:09 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542617600; Read time: 16; Write time: 499424 16:19:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234684416; Read time: 0; Write time: 268740 16:19:09 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295940096; Read time: 16; Write time: 227324 16:19:09 INFO - Running post-run listener: _upload_blobber_files 16:19:09 INFO - Blob upload gear active. 16:19:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:09 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 16:19:09 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'] 16:19:09 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 16:19:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:10 INFO - (blobuploader) - INFO - Done attempting. 16:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:11 INFO - (blobuploader) - INFO - Done attempting. 16:19:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:11 INFO - Return code: 0 16:19:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f91f3978c2b8cfb4f614729699db2b4ab0320d66a286058f7379e2e4c7b0fa3e0e7dd0dac671a3b772536b3329f934c3927386917cbf71577cf601b84383863e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bdac9ac7648d63ba6e5439a44f531d18fce35edded6041de5a8d4c76c7b986542607fe03868c3125c2e899adcd2d3fa19877bc24ff7ec9515c588d6341ce465"} 16:19:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:11 INFO - Contents: 16:19:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f91f3978c2b8cfb4f614729699db2b4ab0320d66a286058f7379e2e4c7b0fa3e0e7dd0dac671a3b772536b3329f934c3927386917cbf71577cf601b84383863e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bdac9ac7648d63ba6e5439a44f531d18fce35edded6041de5a8d4c76c7b986542607fe03868c3125c2e899adcd2d3fa19877bc24ff7ec9515c588d6341ce465"} 16:19:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:11 INFO - Copying logs to upload dir... 16:19:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.700969 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-26 16:19:11.421429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:19:11.425437) ========= 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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f91f3978c2b8cfb4f614729699db2b4ab0320d66a286058f7379e2e4c7b0fa3e0e7dd0dac671a3b772536b3329f934c3927386917cbf71577cf601b84383863e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bdac9ac7648d63ba6e5439a44f531d18fce35edded6041de5a8d4c76c7b986542607fe03868c3125c2e899adcd2d3fa19877bc24ff7ec9515c588d6341ce465"} build_url:https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/MBLIts9ARpmM2D4yMGucsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f91f3978c2b8cfb4f614729699db2b4ab0320d66a286058f7379e2e4c7b0fa3e0e7dd0dac671a3b772536b3329f934c3927386917cbf71577cf601b84383863e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2bdac9ac7648d63ba6e5439a44f531d18fce35edded6041de5a8d4c76c7b986542607fe03868c3125c2e899adcd2d3fa19877bc24ff7ec9515c588d6341ce465"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:19:11.449996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:19:11.450347) ========= 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=41bf3e9aed84707956354da8000001c5-1461711220.6456-529226044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:19:11.531833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:19:11.532153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:19:11.532438) ========= ========= Total master_lag: 0.17 =========