builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1464882176.49 results: success (0) buildid: 20160602073152 builduid: 40e78718f320445dbb04f57fa9f82b3c revision: e75f2d129de069681d0a690915c3e9c8f2a671e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.485687) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.486128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.486403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.501012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.501309) ========= 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=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 08:42:56-- 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% 220M=0s 2016-06-02 08:42:56 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.633878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.634201) ========= 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=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.683278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:56.683643) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e75f2d129de069681d0a690915c3e9c8f2a671e4 --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 e75f2d129de069681d0a690915c3e9c8f2a671e4 --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=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 08:42:56,876 truncating revision to first 12 chars 2016-06-02 08:42:56,876 Setting DEBUG logging. 2016-06-02 08:42:56,876 attempt 1/10 2016-06-02 08:42:56,877 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e75f2d129de0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 08:42:57,232 unpacking tar archive at: fx-team-e75f2d129de0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:57.415608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:57.415946) ========= script_repo_revision: e75f2d129de069681d0a690915c3e9c8f2a671e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:57.416340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:57.416628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:42:57.427820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 08:42:57.428208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:57 INFO - MultiFileLogger online at 20160602 08:42:57 in /builds/slave/test 08:42:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:42:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:57 INFO - {'append_to_log': False, 08:42:57 INFO - 'base_work_dir': '/builds/slave/test', 08:42:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:42:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:57 INFO - 'branch': 'Fx-Team-Non-PGO', 08:42:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:57 INFO - 'config_files': ('talos/linux_config.py',), 08:42:57 INFO - 'default_actions': ('clobber', 08:42:57 INFO - 'read-buildbot-config', 08:42:57 INFO - 'download-and-extract', 08:42:57 INFO - 'populate-webroot', 08:42:57 INFO - 'create-virtualenv', 08:42:57 INFO - 'install', 08:42:57 INFO - 'run-tests'), 08:42:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:57 INFO - 'download_minidump_stackwalk': True, 08:42:57 INFO - 'download_symbols': 'ondemand', 08:42:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:57 INFO - 'installer_path': 'installer.exe', 08:42:57 INFO - 'log_level': 'info', 08:42:57 INFO - 'log_name': 'talos', 08:42:57 INFO - 'log_to_console': True, 08:42:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:57 INFO - 'opt_config_files': (), 08:42:57 INFO - 'pip_index': False, 08:42:57 INFO - 'sps_profile': False, 08:42:57 INFO - 'sps_profile_interval': 0, 08:42:57 INFO - 'suite': 'dromaeojs', 08:42:57 INFO - 'system_bits': '32', 08:42:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:57 INFO - 'title': 'talos-linux64-ix-003', 08:42:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:57 INFO - 'use_talos_json': True, 08:42:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:57 INFO - 'work_dir': 'build'} 08:42:57 INFO - ##### 08:42:57 INFO - ##### Running clobber step. 08:42:57 INFO - ##### 08:42:57 INFO - Running pre-action listener: _resource_record_pre_action 08:42:57 INFO - Running main action method: clobber 08:42:57 INFO - rmtree: /builds/slave/test/build 08:42:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:58 INFO - Running post-action listener: _resource_record_post_action 08:42:58 INFO - ##### 08:42:58 INFO - ##### Finished clobber step (success) 08:42:58 INFO - ##### 08:42:58 INFO - ##### 08:42:58 INFO - ##### Running read-buildbot-config step. 08:42:58 INFO - ##### 08:42:58 INFO - Running pre-action listener: _resource_record_pre_action 08:42:58 INFO - Running main action method: read_buildbot_config 08:42:58 INFO - Using buildbot properties: 08:42:58 INFO - { 08:42:58 INFO - "project": "", 08:42:58 INFO - "product": "firefox", 08:42:58 INFO - "script_repo_revision": "production", 08:42:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:42:58 INFO - "repository": "", 08:42:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:42:58 INFO - "buildid": "20160602073152", 08:42:58 INFO - "pgo_build": "False", 08:42:58 INFO - "basedir": "/builds/slave/test", 08:42:58 INFO - "buildnumber": 1810, 08:42:58 INFO - "slavename": "talos-linux64-ix-003", 08:42:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:42:58 INFO - "platform": "ubuntu64_hw", 08:42:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:42:58 INFO - "branch": "fx-team", 08:42:58 INFO - "repo_path": "integration/fx-team", 08:42:58 INFO - "revision": "e75f2d129de069681d0a690915c3e9c8f2a671e4", 08:42:58 INFO - "stage_platform": "linux64", 08:42:58 INFO - "builduid": "40e78718f320445dbb04f57fa9f82b3c", 08:42:58 INFO - "slavebuilddir": "test" 08:42:58 INFO - } 08:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:42:58 INFO - Running post-action listener: _resource_record_post_action 08:42:58 INFO - ##### 08:42:58 INFO - ##### Finished read-buildbot-config step (success) 08:42:58 INFO - ##### 08:42:58 INFO - ##### 08:42:58 INFO - ##### Running download-and-extract step. 08:42:58 INFO - ##### 08:42:58 INFO - Running pre-action listener: _resource_record_pre_action 08:42:58 INFO - Running main action method: download_and_extract 08:42:58 INFO - mkdir: /builds/slave/test/build/tests 08:42:58 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')]} 08:42:58 INFO - https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:42:58 INFO - Downloaded 1361 bytes. 08:42:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:42:58 INFO - Using the following test package requirements: 08:42:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:42:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'jsshell-linux-x86_64.zip'], 08:42:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:42:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:42:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:58 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')]} 08:42:58 INFO - https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:00 INFO - Downloaded 22866922 bytes. 08:43:00 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'] 08:43:00 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 08:43:01 INFO - Return code: 0 08:43:01 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 08:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:01 INFO - https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:02 INFO - Downloaded 22866922 bytes. 08:43:02 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'] 08:43:02 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 08:43:04 INFO - Return code: 0 08:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:04 INFO - https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:05 INFO - Downloaded 10834055 bytes. 08:43:05 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'] 08:43:05 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 08:43:05 INFO - Return code: 0 08:43:05 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')]} 08:43:05 INFO - https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/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 08:43:07 INFO - Downloaded 55087261 bytes. 08:43:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:43:07 INFO - mkdir: /builds/slave/test/properties 08:43:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:07 INFO - Contents: 08:43:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:43:07 INFO - Running post-action listener: _resource_record_post_action 08:43:07 INFO - Running post-action listener: set_extra_try_arguments 08:43:07 INFO - ##### 08:43:07 INFO - ##### Finished download-and-extract step (success) 08:43:07 INFO - ##### 08:43:07 INFO - ##### 08:43:07 INFO - ##### Running populate-webroot step. 08:43:07 INFO - ##### 08:43:07 INFO - Running pre-action listener: _resource_record_pre_action 08:43:08 INFO - Running main action method: populate_webroot 08:43:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:08 INFO - '--tppagecycles', 08:43:08 INFO - '7'], 08:43:08 INFO - 'tests': ['tsvgm']}}, 08:43:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['damp', 'tps']}, 08:43:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'tests': ['damp', 'tps']}, 08:43:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['dromaeo_dom']}, 08:43:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['a11yr', 08:43:08 INFO - 'ts_paint', 08:43:08 INFO - 'tpaint', 08:43:08 INFO - 'sessionrestore', 08:43:08 INFO - 'sessionrestore_no_auto_restore', 08:43:08 INFO - 'tabpaint']}, 08:43:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['tsvgx', 08:43:08 INFO - 'tsvgr_opacity', 08:43:08 INFO - 'tart', 08:43:08 INFO - 'tscrollx', 08:43:08 INFO - 'cart']}, 08:43:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:08 INFO - 'tsvgr_opacity', 08:43:08 INFO - 'tart', 08:43:08 INFO - 'tscrollx', 08:43:08 INFO - 'cart']}, 08:43:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'talos_options': ['--disable-e10s'], 08:43:08 INFO - 'tests': ['tp5o']}, 08:43:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'tests': ['tp5o']}, 08:43:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'talos_options': ['--disable-e10s', 08:43:08 INFO - '--xperf_path', 08:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:08 INFO - 'tests': ['tp5n']}, 08:43:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:08 INFO - 'talos_options': ['--xperf_path', 08:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:08 INFO - 'tests': ['tp5n']}}, 08:43:08 INFO - 'talos.zip': {'path': '', 08:43:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:08 INFO - Running post-action listener: _resource_record_post_action 08:43:08 INFO - ##### 08:43:08 INFO - ##### Finished populate-webroot step (success) 08:43:08 INFO - ##### 08:43:08 INFO - ##### 08:43:08 INFO - ##### Running create-virtualenv step. 08:43:08 INFO - ##### 08:43:08 INFO - Running pre-action listener: _resource_record_pre_action 08:43:08 INFO - Running main action method: create_virtualenv 08:43:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:08 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 08:43:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:08 INFO - Using real prefix '/usr' 08:43:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:10 INFO - Installing pip.................done. 08:43:10 INFO - Return code: 0 08:43:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:10 INFO - Using env: {'DISPLAY': ':0', 08:43:10 INFO - 'HOME': '/home/cltbld', 08:43:10 INFO - 'LANG': 'en_US.UTF-8', 08:43:10 INFO - 'LANGUAGE': 'en_US:en', 08:43:10 INFO - 'LOGNAME': 'cltbld', 08:43:10 INFO - 'MAIL': '/var/mail/cltbld', 08:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:10 INFO - 'MOZ_NO_REMOTE': '1', 08:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:10 INFO - 'NO_EM_RESTART': '1', 08:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:10 INFO - 'PWD': '/builds/slave/test', 08:43:10 INFO - 'SHELL': '/bin/bash', 08:43:10 INFO - 'SHLVL': '1', 08:43:10 INFO - 'TERM': 'linux', 08:43:10 INFO - 'TMOUT': '86400', 08:43:10 INFO - 'USER': 'cltbld', 08:43:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:10 INFO - '_': '/tools/buildbot/bin/python'} 08:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:10 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 08:43:10 INFO - Cleaning up... 08:43:10 INFO - Return code: 0 08:43:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:43:10 INFO - Using env: {'DISPLAY': ':0', 08:43:10 INFO - 'HOME': '/home/cltbld', 08:43:10 INFO - 'LANG': 'en_US.UTF-8', 08:43:10 INFO - 'LANGUAGE': 'en_US:en', 08:43:10 INFO - 'LOGNAME': 'cltbld', 08:43:10 INFO - 'MAIL': '/var/mail/cltbld', 08:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:10 INFO - 'MOZ_NO_REMOTE': '1', 08:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:10 INFO - 'NO_EM_RESTART': '1', 08:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:10 INFO - 'PWD': '/builds/slave/test', 08:43:10 INFO - 'SHELL': '/bin/bash', 08:43:10 INFO - 'SHLVL': '1', 08:43:10 INFO - 'TERM': 'linux', 08:43:10 INFO - 'TMOUT': '86400', 08:43:10 INFO - 'USER': 'cltbld', 08:43:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:10 INFO - '_': '/tools/buildbot/bin/python'} 08:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:11 INFO - Downloading/unpacking psutil>=3.1.1 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:13 INFO - Installing collected packages: psutil 08:43:13 INFO - Running setup.py install for psutil 08:43:13 INFO - building 'psutil._psutil_linux' extension 08:43:13 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 08:43:13 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 08:43:13 INFO - building 'psutil._psutil_posix' extension 08:43:13 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 08:43:13 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 08:43:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:13 INFO - Successfully installed psutil 08:43:13 INFO - Cleaning up... 08:43:13 INFO - Return code: 0 08:43:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:43:13 INFO - Using env: {'DISPLAY': ':0', 08:43:13 INFO - 'HOME': '/home/cltbld', 08:43:13 INFO - 'LANG': 'en_US.UTF-8', 08:43:13 INFO - 'LANGUAGE': 'en_US:en', 08:43:13 INFO - 'LOGNAME': 'cltbld', 08:43:13 INFO - 'MAIL': '/var/mail/cltbld', 08:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:13 INFO - 'MOZ_NO_REMOTE': '1', 08:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:13 INFO - 'NO_EM_RESTART': '1', 08:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:13 INFO - 'PWD': '/builds/slave/test', 08:43:13 INFO - 'SHELL': '/bin/bash', 08:43:13 INFO - 'SHLVL': '1', 08:43:13 INFO - 'TERM': 'linux', 08:43:13 INFO - 'TMOUT': '86400', 08:43:13 INFO - 'USER': 'cltbld', 08:43:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:13 INFO - '_': '/tools/buildbot/bin/python'} 08:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:15 INFO - Installing collected packages: mozsystemmonitor 08:43:15 INFO - Running setup.py install for mozsystemmonitor 08:43:15 INFO - Successfully installed mozsystemmonitor 08:43:15 INFO - Cleaning up... 08:43:15 INFO - Return code: 0 08:43:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:15 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:15 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 08:43:15 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 08:43:15 INFO - Using env: {'DISPLAY': ':0', 08:43:15 INFO - 'HOME': '/home/cltbld', 08:43:15 INFO - 'LANG': 'en_US.UTF-8', 08:43:15 INFO - 'LANGUAGE': 'en_US:en', 08:43:15 INFO - 'LOGNAME': 'cltbld', 08:43:15 INFO - 'MAIL': '/var/mail/cltbld', 08:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:15 INFO - 'MOZ_NO_REMOTE': '1', 08:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:15 INFO - 'NO_EM_RESTART': '1', 08:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:15 INFO - 'PWD': '/builds/slave/test', 08:43:15 INFO - 'SHELL': '/bin/bash', 08:43:15 INFO - 'SHLVL': '1', 08:43:15 INFO - 'TERM': 'linux', 08:43:15 INFO - 'TMOUT': '86400', 08:43:15 INFO - 'USER': 'cltbld', 08:43:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:15 INFO - '_': '/tools/buildbot/bin/python'} 08:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 INFO - Downloading docopt-0.6.1.tar.gz 08:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:18 INFO - Running setup.py install for blobuploader 08:43:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:18 INFO - Running setup.py install for requests 08:43:19 INFO - Running setup.py install for docopt 08:43:19 INFO - Successfully installed blobuploader requests docopt 08:43:19 INFO - Cleaning up... 08:43:19 INFO - Return code: 0 08:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:19 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 08:43:19 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 08:43:19 INFO - Using env: {'DISPLAY': ':0', 08:43:19 INFO - 'HOME': '/home/cltbld', 08:43:19 INFO - 'LANG': 'en_US.UTF-8', 08:43:19 INFO - 'LANGUAGE': 'en_US:en', 08:43:19 INFO - 'LOGNAME': 'cltbld', 08:43:19 INFO - 'MAIL': '/var/mail/cltbld', 08:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:19 INFO - 'MOZ_NO_REMOTE': '1', 08:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:19 INFO - 'NO_EM_RESTART': '1', 08:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:19 INFO - 'PWD': '/builds/slave/test', 08:43:19 INFO - 'SHELL': '/bin/bash', 08:43:19 INFO - 'SHLVL': '1', 08:43:19 INFO - 'TERM': 'linux', 08:43:19 INFO - 'TMOUT': '86400', 08:43:19 INFO - 'USER': 'cltbld', 08:43:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:19 INFO - '_': '/tools/buildbot/bin/python'} 08:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:19 INFO - Running setup.py (path:/tmp/pip-1Tutwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:19 INFO - Running setup.py (path:/tmp/pip-lz5OoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:19 INFO - Running setup.py (path:/tmp/pip-MKty4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:19 INFO - Running setup.py (path:/tmp/pip-AS_qU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:19 INFO - Running setup.py (path:/tmp/pip-JDvqnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:19 INFO - Running setup.py (path:/tmp/pip-EOubJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:19 INFO - Running setup.py (path:/tmp/pip-vj3dcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:20 INFO - Running setup.py (path:/tmp/pip-MVzr7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:20 INFO - Running setup.py (path:/tmp/pip-RNd585-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:20 INFO - Running setup.py (path:/tmp/pip-T63t4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:20 INFO - Running setup.py (path:/tmp/pip-hd_asR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:20 INFO - Running setup.py (path:/tmp/pip-eEPqPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:20 INFO - Running setup.py (path:/tmp/pip-oVaFhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:20 INFO - Running setup.py (path:/tmp/pip-LgtpX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:20 INFO - Running setup.py (path:/tmp/pip-ij2I9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:20 INFO - Running setup.py (path:/tmp/pip-nGoTIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:20 INFO - Running setup.py (path:/tmp/pip-dvj_R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:20 INFO - Running setup.py install for manifestparser 08:43:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozcrash 08:43:20 INFO - Running setup.py install for mozdebug 08:43:21 INFO - Running setup.py install for mozdevice 08:43:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozfile 08:43:21 INFO - Running setup.py install for mozhttpd 08:43:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozinfo 08:43:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozInstall 08:43:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozleak 08:43:21 INFO - Running setup.py install for mozlog 08:43:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for moznetwork 08:43:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozprocess 08:43:21 INFO - Running setup.py install for mozprofile 08:43:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:22 INFO - Running setup.py install for mozrunner 08:43:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:22 INFO - Running setup.py install for mozscreenshot 08:43:22 INFO - Running setup.py install for moztest 08:43:22 INFO - Running setup.py install for mozversion 08:43:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:22 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:22 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')]} 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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')]} 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:22 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 08:43:22 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 08:43:22 INFO - Using env: {'DISPLAY': ':0', 08:43:22 INFO - 'HOME': '/home/cltbld', 08:43:22 INFO - 'LANG': 'en_US.UTF-8', 08:43:22 INFO - 'LANGUAGE': 'en_US:en', 08:43:22 INFO - 'LOGNAME': 'cltbld', 08:43:22 INFO - 'MAIL': '/var/mail/cltbld', 08:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:22 INFO - 'MOZ_NO_REMOTE': '1', 08:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:22 INFO - 'NO_EM_RESTART': '1', 08:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:22 INFO - 'PWD': '/builds/slave/test', 08:43:22 INFO - 'SHELL': '/bin/bash', 08:43:22 INFO - 'SHLVL': '1', 08:43:22 INFO - 'TERM': 'linux', 08:43:22 INFO - 'TMOUT': '86400', 08:43:22 INFO - 'USER': 'cltbld', 08:43:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:22 INFO - '_': '/tools/buildbot/bin/python'} 08:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:22 INFO - Running setup.py (path:/tmp/pip-wmzt7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:22 INFO - Running setup.py (path:/tmp/pip-Njn2sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:22 INFO - Running setup.py (path:/tmp/pip-HySUGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:22 INFO - Running setup.py (path:/tmp/pip-BQAhJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:23 INFO - Running setup.py (path:/tmp/pip-Kk2MyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:23 INFO - Running setup.py (path:/tmp/pip-bkLda8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:23 INFO - Running setup.py (path:/tmp/pip-ImRlVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:23 INFO - Running setup.py (path:/tmp/pip-vHXfwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:23 INFO - Running setup.py (path:/tmp/pip-7UN521-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:23 INFO - Running setup.py (path:/tmp/pip-zpz8CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:23 INFO - Running setup.py (path:/tmp/pip-cVpcQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:23 INFO - Running setup.py (path:/tmp/pip-NDs6qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:23 INFO - Running setup.py (path:/tmp/pip-ZVi1yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:23 INFO - Running setup.py (path:/tmp/pip-rhIrHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:23 INFO - Running setup.py (path:/tmp/pip-Ior7Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:23 INFO - Running setup.py (path:/tmp/pip-bL2sZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:23 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)) 08:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:23 INFO - Running setup.py (path:/tmp/pip-zOFr9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:23 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)) 08:43:23 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)) 08:43:23 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)) 08:43:23 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)) 08:43:23 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)) 08:43:23 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)) 08:43:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:25 INFO - Downloading blessings-1.6.tar.gz 08:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:25 INFO - Installing collected packages: blessings 08:43:25 INFO - Running setup.py install for blessings 08:43:26 INFO - Successfully installed blessings 08:43:26 INFO - Cleaning up... 08:43:26 INFO - Return code: 0 08:43:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:26 INFO - Reading from file tmpfile_stdout 08:43:26 INFO - Current package versions: 08:43:26 INFO - argparse == 1.2.1 08:43:26 INFO - blessings == 1.6 08:43:26 INFO - blobuploader == 1.2.4 08:43:26 INFO - docopt == 0.6.1 08:43:26 INFO - manifestparser == 1.1 08:43:26 INFO - mozInstall == 1.12 08:43:26 INFO - mozcrash == 0.17 08:43:26 INFO - mozdebug == 0.1 08:43:26 INFO - mozdevice == 0.48 08:43:26 INFO - mozfile == 1.2 08:43:26 INFO - mozhttpd == 0.7 08:43:26 INFO - mozinfo == 0.9 08:43:26 INFO - mozleak == 0.1 08:43:26 INFO - mozlog == 3.2 08:43:26 INFO - moznetwork == 0.27 08:43:26 INFO - mozprocess == 0.22 08:43:26 INFO - mozprofile == 0.28 08:43:26 INFO - mozrunner == 6.11 08:43:26 INFO - mozscreenshot == 0.1 08:43:26 INFO - mozsystemmonitor == 0.3 08:43:26 INFO - moztest == 0.7 08:43:26 INFO - mozversion == 1.4 08:43:26 INFO - psutil == 3.1.1 08:43:26 INFO - requests == 1.2.3 08:43:26 INFO - wsgiref == 0.1.2 08:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:26 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')]} 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 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')]} 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:26 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 08:43:26 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 08:43:26 INFO - Using env: {'DISPLAY': ':0', 08:43:26 INFO - 'HOME': '/home/cltbld', 08:43:26 INFO - 'LANG': 'en_US.UTF-8', 08:43:26 INFO - 'LANGUAGE': 'en_US:en', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MAIL': '/var/mail/cltbld', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SHLVL': '1', 08:43:26 INFO - 'TERM': 'linux', 08:43:26 INFO - 'TMOUT': '86400', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - '_': '/tools/buildbot/bin/python'} 08:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 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)) 08:43:26 INFO - Cleaning up... 08:43:26 INFO - Return code: 0 08:43:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:26 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')]} 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 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')]} 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:26 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:26 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 08:43:26 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 08:43:26 INFO - Using env: {'DISPLAY': ':0', 08:43:26 INFO - 'HOME': '/home/cltbld', 08:43:26 INFO - 'LANG': 'en_US.UTF-8', 08:43:26 INFO - 'LANGUAGE': 'en_US:en', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MAIL': '/var/mail/cltbld', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SHLVL': '1', 08:43:26 INFO - 'TERM': 'linux', 08:43:26 INFO - 'TMOUT': '86400', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - '_': '/tools/buildbot/bin/python'} 08:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:26 INFO - Downloading/unpacking jsonschema 08:43:26 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 08:43:26 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 08:43:26 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 08:43:26 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 08:43:26 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 08:43:26 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 08:43:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:28 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:28 INFO - warning: no files found matching '*.txt' 08:43:28 INFO - no previously-included directories found matching 'build' 08:43:28 INFO - no previously-included directories found matching 'dist' 08:43:28 INFO - no previously-included directories found matching '.git*' 08:43:28 INFO - Installing collected packages: jsonschema, functools32 08:43:29 INFO - Running setup.py install for functools32 08:43:29 INFO - warning: no files found matching '*.txt' 08:43:29 INFO - no previously-included directories found matching 'build' 08:43:29 INFO - no previously-included directories found matching 'dist' 08:43:29 INFO - no previously-included directories found matching '.git*' 08:43:29 INFO - Successfully installed jsonschema functools32 08:43:29 INFO - Cleaning up... 08:43:29 INFO - Return code: 0 08:43:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43:29 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')]} 08:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:29 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')]} 08:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:29 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 0x7f6decc0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15838e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, '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': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', '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 08:43:29 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 08:43:29 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 08:43:29 INFO - Using env: {'DISPLAY': ':0', 08:43:29 INFO - 'HOME': '/home/cltbld', 08:43:29 INFO - 'LANG': 'en_US.UTF-8', 08:43:29 INFO - 'LANGUAGE': 'en_US:en', 08:43:29 INFO - 'LOGNAME': 'cltbld', 08:43:29 INFO - 'MAIL': '/var/mail/cltbld', 08:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:29 INFO - 'MOZ_NO_REMOTE': '1', 08:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:29 INFO - 'NO_EM_RESTART': '1', 08:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:29 INFO - 'PWD': '/builds/slave/test', 08:43:29 INFO - 'SHELL': '/bin/bash', 08:43:29 INFO - 'SHLVL': '1', 08:43:29 INFO - 'TERM': 'linux', 08:43:29 INFO - 'TMOUT': '86400', 08:43:29 INFO - 'USER': 'cltbld', 08:43:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:29 INFO - '_': '/tools/buildbot/bin/python'} 08:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:29 INFO - Downloading/unpacking flake8 08:43:29 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 08:43:29 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 08:43:29 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 08:43:29 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 08:43:29 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 08:43:29 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 08:43:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:31 INFO - no previously-included directories found matching 'docs/_build' 08:43:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:32 INFO - Running setup.py install for pep8 08:43:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:32 INFO - no previously-included directories found matching 'docs/_build' 08:43:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:32 INFO - Cleaning up... 08:43:32 INFO - Return code: 0 08:43:32 INFO - Running post-action listener: _resource_record_post_action 08:43:32 INFO - Running post-action listener: _start_resource_monitoring 08:43:32 INFO - Starting resource monitoring. 08:43:32 INFO - ##### 08:43:32 INFO - ##### Finished create-virtualenv step (success) 08:43:32 INFO - ##### 08:43:32 INFO - ##### 08:43:32 INFO - ##### Running install step. 08:43:32 INFO - ##### 08:43:32 INFO - Running pre-action listener: _resource_record_pre_action 08:43:32 INFO - Running main action method: install 08:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:32 INFO - Reading from file tmpfile_stdout 08:43:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:32 INFO - Reading from file tmpfile_stdout 08:43:32 INFO - Output received: 08:43:32 INFO - Usage: mozinstall [options] installer 08:43:32 INFO - Options: 08:43:32 INFO - -h, --help show this help message and exit 08:43:32 INFO - -d DEST, --destination=DEST 08:43:32 INFO - Directory to install application into. [default: 08:43:32 INFO - "/builds/slave/test"] 08:43:32 INFO - --app=APP Application being installed. [default: firefox] 08:43:32 INFO - mkdir: /builds/slave/test/build/application 08:43:32 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'] 08:43:32 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 08:43:48 INFO - Reading from file tmpfile_stdout 08:43:48 INFO - Output received: 08:43:48 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:48 INFO - Running post-action listener: _resource_record_post_action 08:43:48 INFO - ##### 08:43:48 INFO - ##### Finished install step (success) 08:43:48 INFO - ##### 08:43:48 INFO - ##### 08:43:48 INFO - ##### Running run-tests step. 08:43:48 INFO - ##### 08:43:48 INFO - Running pre-action listener: _resource_record_pre_action 08:43:48 INFO - Running main action method: run_tests 08:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:48 INFO - Python 2.7.3 08:43:48 INFO - Return code: 0 08:43:48 INFO - grabbing minidump binary from tooltool 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1612b20>, '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 0x1613a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1613eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:48 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 08:43:48 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 08:43:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:43:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:48 INFO - Return code: 0 08:43:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:49 INFO - Return code: 0 08:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:43:49 INFO - Using env: {'DISPLAY': ':0', 08:43:49 INFO - 'HOME': '/home/cltbld', 08:43:49 INFO - 'LANG': 'en_US.UTF-8', 08:43:49 INFO - 'LANGUAGE': 'en_US:en', 08:43:49 INFO - 'LOGNAME': 'cltbld', 08:43:49 INFO - 'MAIL': '/var/mail/cltbld', 08:43:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:49 INFO - 'MOZ_NO_REMOTE': '1', 08:43:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:49 INFO - 'NO_EM_RESTART': '1', 08:43:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:49 INFO - 'PWD': '/builds/slave/test', 08:43:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:49 INFO - 'SHELL': '/bin/bash', 08:43:49 INFO - 'SHLVL': '1', 08:43:49 INFO - 'TERM': 'linux', 08:43:49 INFO - 'TMOUT': '86400', 08:43:49 INFO - 'USER': 'cltbld', 08:43:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464882175.973899-14616332', 08:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:49 INFO - '_': '/tools/buildbot/bin/python'} 08:43:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:43:49 INFO - mozversion application_buildid: 20160602073152 08:43:49 INFO - mozversion application_changeset: e75f2d129de069681d0a690915c3e9c8f2a671e4 08:43:49 INFO - mozversion application_display_name: Nightly 08:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:49 INFO - mozversion application_name: Firefox 08:43:49 INFO - mozversion application_remotingname: firefox 08:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:43:49 INFO - mozversion application_vendor: Mozilla 08:43:49 INFO - mozversion application_version: 49.0a1 08:43:49 INFO - mozversion platform_buildid: 20160602073152 08:43:49 INFO - mozversion platform_changeset: e75f2d129de069681d0a690915c3e9c8f2a671e4 08:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:43:49 INFO - mozversion platform_version: 49.0a1 08:43:49 INFO - using testdate: 1464882229 08:43:49 INFO - actual date: 1464882229 08:43:49 INFO - starting webserver on 'localhost:58409' 08:43:49 INFO - SUITE-START | Running 2 tests 08:43:49 INFO - TEST-START | dromaeo_css 08:43:49 INFO - operating with platform_type : linux_ 08:43:49 INFO - Initialising browser for dromaeo_css test... 08:43:49 INFO - TEST-INFO | started process 10124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEZe96/profile http://localhost:58409/getInfo.html) 08:43:54 INFO - PROCESS | 10124 | __metrics Screen width/height:1600/1200 08:43:54 INFO - PROCESS | 10124 | colorDepth:24 08:43:54 INFO - PROCESS | 10124 | Browser inner width/height: 1024/697 08:43:54 INFO - PROCESS | 10124 | __metrics 08:43:55 ERROR - PROCESS | 10124 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:56 INFO - TEST-INFO | 10124: exit 0 08:43:56 INFO - Browser initialized. 08:43:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:56 INFO - TEST-INFO | started process 10203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEZe96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:08 INFO - PROCESS | 10203 | RSS: Main: 157323264 08:44:08 INFO - PROCESS | 10203 | 08:44:59 INFO - PROCESS | 10203 | 1464882299901 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] 08:47:11 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58409/tests/dromaeo/cssquery-ext.html) 08:47:12 INFO - PROCESS | 10203 | RSS: Main: 264749056 08:47:12 INFO - PROCESS | 10203 | 08:50:15 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-ext.html (next: http://localhost:58409/tests/dromaeo/cssquery-jquery.html) 08:50:16 INFO - PROCESS | 10203 | RSS: Main: 244166656 08:50:16 INFO - PROCESS | 10203 | 08:53:18 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58409/tests/dromaeo/cssquery-mootools.html) 08:53:19 INFO - PROCESS | 10203 | RSS: Main: 249847808 08:53:19 INFO - PROCESS | 10203 | 08:56:21 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58409/tests/dromaeo/cssquery-prototype.html) 08:56:21 INFO - PROCESS | 10203 | RSS: Main: 237191168 08:56:21 INFO - PROCESS | 10203 | 08:59:24 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58409/tests/dromaeo/cssquery-yui.html) 08:59:25 INFO - PROCESS | 10203 | RSS: Main: 229158912 08:59:25 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | Cycle 1(1): loaded http://localhost:58409/tests/dromaeo/cssquery-yui.html (next: http://localhost:58409/tests/dromaeo/cssquery-dojo.html) 09:02:28 INFO - PROCESS | 10203 | RSS: Main: 280227840 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | __start_tp_report 09:02:28 INFO - PROCESS | 10203 | _x_x_mozilla_page_load 09:02:28 INFO - PROCESS | 10203 | _x_x_mozilla_page_load_details 09:02:28 INFO - PROCESS | 10203 | |i|pagename|runs| 09:02:28 INFO - PROCESS | 10203 | |0;dojo.html;2677.79916506262;2690.4753573053263;2720.2655283073573;2730.563109902416;2748.9037883674077;4557.088582283548;4644.535546445354;4746.145693775124;4774.355462012627;4852.102361063201;4713;4722.315264286676;4726.361941137945;4772.642051846108;4777.880552986168;4117.649999750025;4271.551487093865;4346.456692913386;4373.103513779683;4489.483709373431;4391.121775644868;4425.026494171278;4443.577860103301;4455.732656040648;4472.038511719979;4224.957750422503;4258.659307255412;4278.443802305712;4350.064736081726;4356.390105385249;4292.613664770154;4297.39836422901;4298.828046878121;4326.199653064194;4343.370211319372;4312.159128969852;4325.52419233884;4342.869713908588;4370.847020354304;4371.650267978554;4559.863204103882;4606.976965115186;4656.231721765905;4660.460049273154;4682.789274482657;5135.4094279157625;5137.357830271216;5156.071907056728;5162.432132465426;5164.354455693038;5134.229865520165;5160.587153027749;5175.922361164586;5184.274201611777;5186.040582492214;4623;4683.320918466803;4729.243321068612;4732.195526760459;4788.3056956741075;5216.843494695166;5248.160294352885;5248.947510524922;5249.895002100013;5252.080885844962;4962.354893863775;4986.650934434628;5033.0940430722085;5033.144365457881;5035.395752509649;4943.4809345018975;5066.03745288394;5122.87192820175;5180.300659411007;5183.2743415921805;5145.305383773143;5149.485051494896;5150.768215430315;5150.922736158961;5154.458781827929;5119.232115182753;5119.897602048012;5120.385553733501;5125.743712814345;5157.406898206679;4228.746275223435;4269.957300427018;4270.658347332268;4302.462192225972;4303.505096913832;3743.157789497341;3754.1740817020213;3772.1889793694486;3800.4489349044234;3812.3519001769764;4360.280553708666;4362.062156636339;4365.126974605092;4412.24991751403;4424.446944131983;4874.975625121851;4975.278584605212;5062.9746851266245;5077.720725360141;5123.769430375642;4358.3244597087505;4387.188370151533;4390.714603550823;4394.428724265825;4401.22978478765;4611.100835337077;4614.97692511542;4633.582977532038;4657.883552911137;4661.557152070548;4606.976965115153;4658.184817656965;4830.565249127595;4833.9033219335415;4836.709797412166;5083;5122.641415100908;5129.9743501282255;5131.948680513147;5133.486651334837;4817.084753896748;4840.661153719347;4843.24929635907;4854.757262136808;4896.069746748107;4866.513348665105;4977.701337919736;5058.418281897481;5071.492850715046;5105.412877518985;5083.694978301313;5096.133657278346;5110.361204849394;5113.53978141969;5151.1243088675765;4967.975160124176;4982.7508624569355;4992.226204938241;4993.650444468853;5041.1430056889685;4810.95189048119;4934.161192597196;4969.975150124226;4982.950170498394;4999.0501804657;4941.65408421407;4953.628477864103;4972.105021096238;4974.602031837372;4984.75076246179;5009.749512524432;5011.649184557046;5018.749062546931;5018.824341148188;5058;4724.574788269072;4828.227483602747;4894.486078961801;4902.117618828645;4919.237518184687 09:02:28 INFO - PROCESS | 10203 | |1;ext.html;546.0744038854141;584.9853753656159;597.8624916269258;598.6109029131067;613.5153228949131;27067.323316917063;40727.185456290856;41370.17259654805;41400.79299603505;41615.58384416155;40944.59055409445;41508.79245603768;41590.37614435786;41599.37600935988;41644.79177604115;7269.74555890544;7425.888611670829;7436.814079647998;7651.201967537624;7837.608119594026;7585.81035474112;9854.40873547586;10158.034986676292;10159.288849780482;10409.739756506073;10086.041826026552;10151.949240253789;10152.137068349199;10163.339382940085;10166.745831354201;7586.772396828104;7815.062192536875;10014.248931330143;10111.191104711605;10114.645987390479;7411.7035318587195;9612.807743845155;10025.19798416125;10031.498425078717;10304.845427318596;37719.245615087544;38173.61826381728;38197.80901095505;38209.61790382089;38232.235355293014;3012.6686064532882;3122.73456756176;3291.5062740589105;3619.963800361989;3734.9253014939823;29012.12963611095;29266.85366573175;29422.852885735647;29472.41055178906;29587.556186657217;3521.330947120039;3564.1267889367014;3570.9285814283567;3576.302620988908;3609;246010;246523;246560.9999999982;247877;247995;51015.234771478456;51244;51412.74293628508;51478.48521514812;51547;48823;49086.509134908905;49094.50905490971;49121;49142.50857491451;14710.485133020293;15252.542423727306;15253;15255.694886102216;15258.847411525965;10561;11595.76808463826;11816.70458238551;11908.583199587973;11987.100967427477;14763.188024658532;14877.18175500358;14922.40310387594;14996.400143994337;15009.474668386554;5736.827895163152;5745.540356771448;5778.768849245983;5814.622049566765;5923.940760592425;879.3624622149018;918.4122161816442;921.7787730944525;957.3346524165777;977.7408986618552;26571.335716606853;27764.861175693994;27926.72073279282;28028.85985570059;28142;1003.8343673293971;1014.5079636376352;1057.143713591993;1072.9624463143753;1117.8882111788755;14216.644583885485;14798.334074966653;14809.555713328617;15152.16663083541;15248.695026099416;363232;364559;365848;367336;368281;47987.76006120017;48106.75946620244;48155;48180.5181948183;48194.5180548197;1101.9393933333743;1179.422083179236;1180.7697498987616;1214.9392530373445;1237.6287113865803;25203.495930081663;28398;28816.567751483326;29560.113196604136;29612;42082.368764467945;42609.78695106505;42626.36060459157;42904;42977.78511107424;329141;335263;335861;336231;338553;30935.381292373575;32519.674803252612;38165.236695266496;41202.38196427116;41782.79108604559;41728;41891.7905410471;42261.78869105635;42870.57129428666;42936;35405.468917965736;36007.279854402244;36191;36297;36506.26987460289;34598.30803383968;35138.648613513535;35241.82379088088;35478.290434190654;35944.281114378085;31690.207744806565;31772.841135795097;31980.36039279155;32008.67991320057;35803.28393432169;28657.996970105945;32958.01125966225;33066;33390;33656.32687346288;25293.367665807767;25358.366040849127;25407.237782866545;25416;25424.745752542978 09:02:28 INFO - PROCESS | 10203 | |2;jquery.html;371.80480247869866;373.07477455909344;377.6054023545396;390.6074395232791;391.6572998626202;15610.531684049483;16628.916855415737;17128.400505982292;17279.74080388795;17448.651026979453;16040.438584649539;16442.588935276595;17001.91499042503;17003.064831434265;17010.914945425287;5013.799448022084;5115.693058416488;5139.948600513984;5187.948120518784;5192.844214673566;3693.2982733280724;3886.514185726784;5101.770420331075;5592;5933.940660593404;5965.373635768247;5973.4623883850445;5990.760369585211;5991.131285963533;5994.700264986734;5851.210086638292;5886.970565147169;5978.40215978403;5981.043033114703;6007.068904319837;3359.3617212729746;4927.7536123193695;5228.47715228478;5242.973785131088;5274.2879711238875;19371.3220037298;19734.80265197344;19738.111784969566;20052.89973550123;20121.698174527395;1964.2928545723528;2022.2012305139535;2060.7939206079423;2070.8861012644297;2100.2649072824543;12632.68418289541;12746.235225886476;12778;12873.613791586267;13242.337883105805;1733.7139372003605;1775.573862273058;1779.2704990953646;1801.1354549816162;1853.8424233940132;62491.37508624946;65152;65366;65504.344956550776;65692.3430765691;9070.637174512945;9144.771380715401;9550.331476796697;9761.853572196424;9872.654457093968;12883.54907578249;12981.545645902537;13025.283609401575;13044.152130111703;13053;7342.4493163012985;7360.300771426706;7557.168711441737;7662.118856331482;7704.26809453101;7428.588568172138;7480.5885676287235;7493.100827900686;7605.353544948631;7638.083429988437;5982.700864956735;5986.970065149646;6074.726637301332;6101.633901965896;6143.32423433422;1556.7898333724802;1634.3789360043108;1643.194834531095;1692.8307169283219;1750.4836073358135;823.2138307915926;872.8952525696957;897.2059727141527;905.7328088213993;933.2067742419025;16067.598310042342;16423.260953257133;16558.503244902673;16832.495025149266;17388.565285867953;912.5847739278612;925.5973651461636;941.6657086734248;953.6750834963408;957.4446820843893;9360.4383736976;9817.705468835946;9897.703068907944;9913.653022144335;10093.343932644355;336529;344526;354562;354680;355944;41869.1626167475;48590;66983.33016669868;67158.32841671619;67523.66238168876;917.4495302818389;946.3517490519016;971.6016433262329;997.551102004101;1002.0981116994617;14948.626284342978;15065.774013390028;15154.3180556873;15187.620309492351;15272.770908436605;31510;31615.525767113053;31900.36199275955;32124;32375;43088.569114308455;43203.567964319955;43313.35029974616;43352.13295734004;43397.349039763794;7698.499597526367;7757.961210193913;7825.200203953009;7830;7962.044554653478;11347.48936297852;11599.478023489131;11804.468798903898;12106.878931210575;12368.690782730504;9398.248140148908;9638.180754635934;9884.802303954024;10117.038881306264;10256.38461692301;9835.754106147404;9956.751081222737;9993.950030249802;10254.538545765608;10537.57849686004;8749.862517872636;10273.486325683836;10460.529276182742;10572.682819515427;10719.249652524248;7685.308322251024;7719.228077192236;7738.458307918391;7793.337566306927;7883.448158628841;10460.68617941463;10656.840147397641;10668.1998850085;10671.839922401015;10713.089387402159 09:02:28 INFO - PROCESS | 10203 | |3;mootools.html;1230.4647478346915;1359.238826257296;1383.8892888568917;1469.4416121873694;1691.3065643086336;6509.251436084852;7259.60072196029;7520.586367749772;7527.774166774999;7685.269899359552;7358.705651773936;7504.061992250969;7517.924820751791;7519.436042296836;7521.172671006185;2177.9782202177976;2204.944876378095;2208.5251670890757;2208.856424332413;2209.359285807114;2149.279991202949;2173.0547211962767;2202.6695995600708;2205.0297868937696;2207.348832094536;2172.120291282033;2179.498715295483;2180.8473406861526;2181.6291230490856;2220.8001279884807;2129.361191642501;2130.2331160782105;2135.0178917697876;2135.658294672845;2136.9465763355884;2086.457521044539;2126.851120421571;2131.9680204796787;2135.4234356723755;2136.316378758798;7316.414686825041;7506.43701722373;7509.173990861001;7539.095308563007;7551.660175292125;4565.840195593139;4640.814367425299;4664.32367306742;4676.485586585472;4679.9298010529865;2765.294849813305;2977.166393409827;2996.8951086712077;3026.4854974654363;3027.197792584967;974.6686126716879;979.3732011512637;989.5448093876753;997.0428388746811;1004.0762498501323;9909.504524773733;9921.55353009109;9930.106290433896;10020;10027.197824174049;3995.440638310639;4065.776382299002;4105.733127346773;4124;4129.525104612948;7874.527528348203;7901.762947111596;7927.722529711433;7949.244821741925;7954.045514538292;4608.585227329557;4609.377734005866;4612;4613.746243956548;4615.423072115986;3616.475611036385;3810.6379893910034;4198.769067701306;4230.936535951963;4232.513260974965;3398.6091599465885;3436.2096717755057;3460.3944309745693;3492.738044646611;3504.2115524007404;1040.9011143941314;1041.2919214933918;1043.3270540501485;1043.436544266103;1048.5543643951444;730.3536370312312;862.215384000569;865.8701194820701;873.3013589128672;877.6884206106868;4893.21708526634;5076.0863044652315;5202.635815492879;5206.843794686166;5214.634975551751;401.59639562240346;414.78223932435714;419.5699408106715;421.2081287180082;426.098801035807;3512.6838584527513;3542.309249696336;3554.3424466473784;3582.1223800169128;3632.3824949758605;8903.777405564782;9111.772205694779;9240.676576319931;9248.491332976751;9256.583453744597;9011.684591039282;9047.547622618975;9054.81890362189;9077.727668169966;9154.816903662022;6786.321367863175;6821.624810635462;6880.2431732509385;6919.654017299215;6964.721411143498;5100.438951715382;5117.130087884994;5179.1195496766395;5230.084735171406;5280.287161233185;8499.10759370282;8540.804457113898;8546.957265213883;8740.956295218482;8760.51817150063;8692.869606956026;8771.254443372129;8822.2060014599;8823.602937867683;8843.159899809507;5430.592705547178;5612.747426365905;5616.354119276172;5719.48524632785;5720.11338242573;6967.303269672992;7169.247229040876;7197.856042879009;7381.704731810667;7394.186639469762;6455.48356131499;6643.900341494785;6679.532432729662;6761.628110453972;6797.218319893275;6380.170577824853;6390.648514331757;6451.838704032437;6581.769638062645;6625.337466253336;6068.423499767515;6111.236095488064;6119.908201376894;6130.141780150871;6134.78528251509;4361.8255269790125;4544.909101818012;4619.445666520039;4663.976680116578;4744.240921452551;4354.346847972829;4454;4564.201264778584;4656.883577910579;4692.319613656069 09:02:28 INFO - PROCESS | 10203 | |4;prototype.html;297.85702862625936;301.36261806279697;302.0861892774357;305.5599936092026;308.02049482645185;4877.170880950238;4907.779149938252;4912.680675756078;4929.433115191754;4968.975155124228;4841.685290456118;4883.072216278904;4889.511048895109;4897.608191344692;4919.532644398785;3849.9037524061982;3857.40210267409;3859.5754467008605;3864.7487913285545;3895.590962948892;3647.6352364763575;3869.3361854402597;3869.8645547405845;3895.2988462076814;3904.882853514399;3771.924561508768;3807.847686092553;3832.501774769276;3845.4808600838946;3860.82626281818;3824.1969186470874;3825.9426108608254;3833.2333533293313;3841.8271177797064;3854.342632667952;3267.950980735291;3298.670132986706;3411.3688967541084;3423.9486407703903;3437.656234376542;4669.556392142775;4681.5318468153255;4689.81923405618;4696.295555666643;4710.434747830248;4377.737335759833;4382.474103107647;4401.955980440187;4402.581754733295;4412.75729834859;4833.468318484964;4938.160512712848;5092.439831618519;5110.744462776846;5113.616478764107;3717.1636381814146;3742.6257374262627;3747.156889699823;3749.343864823645;3755.1363186466992;5337.2527846101575;5376.220448035052;5395.271638328814;5417.647852889589;5424.267723857308;3640.7633503822167;3810.666266806651;3841.5582208045876;3854.5181852268465;3854.5374555053013;3914.1388894443176;3918.7648741075627;3918.8824335269987;3920.7647541147053;3941.231459865299;4398.252297109499;4411.933820992687;4427.955720442818;4430.579094985971;4447.533009034005;4973.701577905337;5100.770465329069;5136.486351364908;5143.639945203875;5174.9482505174465;1332.393760838816;1347.3398034962797;1350.1898860683511;1361.7140400515805;1365.7951307303786;846.3863698818308;871.73412109306;871.7951281448854;881.0528681667233;893.3255392178993;4070.674346052309;4079.287273962841;4092.7135100542678;4096.40602112692;4130.562967848923;4721.952780472151;4725.834595789131;4735.431748190239;4744.596709279681;4746.857594272177;4081.714280000431;4091.7954102294766;4099.836006559704;4107.979460102681;4120.7321524100835;2417.830751847354;2544.9618255726177;2569.8843552040203;2716.9456610867674;2801.3836955869674;4823.758812059383;4881.755912204376;4910.705357678551;4923.507649235048;4926.359573255526;5367.443441402028;5387.703676297763;5392.73036348181;5410.404855465896;5421.810236641699;4791.5687588117235;4976.850694479099;4981.551660350586;5042.445331013512;5086.61850361217;5096.872578185575;5132.820351287687;5342.118550439134;5362.1420572708175;5409.756560954846;5201.115810312181;5213.661112027706;5226.608004399609;5236.895262094813;5250.18622113573;5002.574781143643;5038.168702164102;5054.393472783289;5057.418396884405;5086.847394578169;3659.4144936809985;3682.963170368262;3740.2332521832413;3761.887143385703;3766.472693822922;5293.364796224478;5296.761645726028;5307.787688492417;5319.8612818437305;5324.201369794562;5140.7429628517675;5151.356080489939;5163.793448262028;5179.22311653255;5214;4936.3089167515855;5154.61340399479;5175.637705360739;5215.791368345375;5243.68537887728;5045.596352291881;5062.620303477181;5070.670406423571;5080.46655101209;5087.669301495391;5161.741912904265;5174.534291913746;5188.195829646411;5201.375834899836;5206.297149884717;4895.608351331956;5023.924641130459;5026.7828589701885;5027.4218464877;5036.6726162799305 09:02:28 INFO - PROCESS | 10203 | |5;yui.html;619.894617914955;649.870025994801;665.6339013542554;687.821166496711;733.7211859493392;11801.350925699095;12477.875221247785;12478.376081195938;12492.875071249286;12494.062945279107;12178.81731774024;13025.674358141052;13026.73946521069;13052.73894522109;13092.672683182902;617.9351168127349;630.9022101574263;777.3004296133469;790.3242727468004;800.0119851982796;795.2564352330561;796.7291121018852;797.8444203380315;798.3573223555036;798.6725442568548;843.8270154618319;845.2308399356587;845.5053793530792;845.5434065604566;845.5687599324358;640.036744699227;657.4805903336359;657.5758635680007;659.8515334049848;834.1325021977136;581.6393835821775;596.2308621877772;599.06246723877;600.3456232706371;600.6756351570147;12875.356232188447;12892.355382230851;13315.467381304736;13361.398737056856;13378.264195469244;12343.876561234452;12776.297303648296;12834.486620535168;12925.935370323183;13231.801522977163;11692.649220523313;11874.16880818343;11955.342456164908;11986.700332491757;12120.151589388746;4063.9593604063875;4102.917941641151;4156.459660244179;4186.476690413699;4205.768682722449;55641.44358556443;55850.16224756632;57219.713901430645;59416.70291648514;59945.70027149836;10367.844482332772;10558.736031599272;10606.098481628993;10619.84070238947;10921.945390272998;19127;19194.808051919583;19201.61596768057;19202.327918522784;19364;6961.547499412522;7002;7020.7893763187185;7113.395361394236;7121.394681452135;3742.139307959185;3743.887683369503;3811.8284677189595;3828.636279553438;3837.76973381598;2789.27478855499;2872.6121973533723;2879.5248783950833;2882.2218001139577;2882.783791215625;507.1049597460485;524.8635354807777;531.7208465555536;533.5411546070376;534.6898798696747;434.81085727708546;499.22370713540795;533.6157966264361;554.8335499350179;582.1413415212528;7850.607469626496;8170.305524030405;8176.6320515576945;8195;8432.78918027042;458.58498059256425;505.9544640982329;519.1304564853855;527.2223470381157;547.1464515356057;3836.5396152461885;3883.417487376916;3899.2201559688174;4049.3318602430268;4084.264832330209;81694.59152704317;94965;96153;97009;97268;80456;83221.58389208015;83586.5820670905;83692;85485.57257213673;74150.62924685342;74726.62636686781;74902.62548687331;75144.24855751482;77091;7899.921000790148;8029.638666260149;8067.152948940511;8074.273315401642;8121.837563248584;41944.3708344369;43059.35410968775;43855.34216986684;44303.33544996763;44326.55673443224;42377.57622423736;54891.725541372034;62899.371006291185;63968;67105.66447167733;11644.475998579916;11831.34927578957;11922.165448418527;12110.576129835414;12570.622881313575;12780.872191277967;12867.163634363736;12884.806727898902;12917.612471625866;12997.220166790023;11984.520619175484;12251.75496490083;12495.750084998068;12550.748985020431;13059.673508162372;11901.702457438634;11962;12034.196506009168;12097.669809112651;12529.93735031319;11414.771704566028;11724.355160466257;11772.70568235801;11813.350265735124;12118.515259389525;9508.144267016001;9694.854577181206;9755.902440975784;9807.55865986018;10095.343802652804;10101.292909496266;10432.947835260775;10494.317869338469;10538.315009524356;10629.734256643645 09:02:28 INFO - PROCESS | 10203 | __end_tp_report 09:02:28 INFO - PROCESS | 10203 | __start_cc_report 09:02:28 INFO - PROCESS | 10203 | _x_x_mozilla_cycle_collect,973 09:02:28 INFO - PROCESS | 10203 | __end_cc_report 09:02:28 INFO - PROCESS | 10203 | __startTimestamp1464883348265__endTimestamp 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | ------- Summary: start ------- 09:02:28 INFO - PROCESS | 10203 | Number of tests: 6 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#0] dojo.html Cycles:165 Average:4705.54 Median:4836.71 stddev:500.21 (10.3%) stddev-sans-first:475.78 09:02:28 INFO - PROCESS | 10203 | Values: 2677.8 2690.5 2720.3 2730.6 2748.9 4557.1 4644.5 4746.1 4774.4 4852.1 4713.0 4722.3 4726.4 4772.6 4777.9 4117.6 4271.6 4346.5 4373.1 4489.5 4391.1 4425.0 4443.6 4455.7 4472.0 4225.0 4258.7 4278.4 4350.1 4356.4 4292.6 4297.4 4298.8 4326.2 4343.4 4312.2 4325.5 4342.9 4370.8 4371.7 4559.9 4607.0 4656.2 4660.5 4682.8 5135.4 5137.4 5156.1 5162.4 5164.4 5134.2 5160.6 5175.9 5184.3 5186.0 4623.0 4683.3 4729.2 4732.2 4788.3 5216.8 5248.2 5248.9 5249.9 5252.1 4962.4 4986.7 5033.1 5033.1 5035.4 4943.5 5066.0 5122.9 5180.3 5183.3 5145.3 5149.5 5150.8 5150.9 5154.5 5119.2 5119.9 5120.4 5125.7 5157.4 4228.7 4270.0 4270.7 4302.5 4303.5 3743.2 3754.2 3772.2 3800.4 3812.4 4360.3 4362.1 4365.1 4412.2 4424.4 4875.0 4975.3 5063.0 5077.7 5123.8 4358.3 4387.2 4390.7 4394.4 4401.2 4611.1 4615.0 4633.6 4657.9 4661.6 4607.0 4658.2 4830.6 4833.9 4836.7 5083.0 5122.6 5130.0 5131.9 5133.5 4817.1 4840.7 4843.2 4854.8 4896.1 4866.5 4977.7 5058.4 5071.5 5105.4 5083.7 5096.1 5110.4 5113.5 5151.1 4968.0 4982.8 4992.2 4993.7 5041.1 4811.0 4934.2 4970.0 4983.0 4999.1 4941.7 4953.6 4972.1 4974.6 4984.8 5009.7 5011.6 5018.7 5018.8 5058.0 4724.6 4828.2 4894.5 4902.1 4919.2 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#1] ext.html Cycles:180 Average:47284.24 Median:19329.99 stddev:84012.75 (434.6%) stddev-sans-first:84175.13 09:02:28 INFO - PROCESS | 10203 | Values: 546.1 585.0 597.9 598.6 613.5 27067.3 40727.2 41370.2 41400.8 41615.6 40944.6 41508.8 41590.4 41599.4 41644.8 7269.7 7425.9 7436.8 7651.2 7837.6 7585.8 9854.4 10158.0 10159.3 10409.7 10086.0 10151.9 10152.1 10163.3 10166.7 7586.8 7815.1 10014.2 10111.2 10114.6 7411.7 9612.8 10025.2 10031.5 10304.8 37719.2 38173.6 38197.8 38209.6 38232.2 3012.7 3122.7 3291.5 3620.0 3734.9 29012.1 29266.9 29422.9 29472.4 29587.6 3521.3 3564.1 3570.9 3576.3 3609.0 246010.0 246523.0 246561.0 247877.0 247995.0 51015.2 51244.0 51412.7 51478.5 51547.0 48823.0 49086.5 49094.5 49121.0 49142.5 14710.5 15252.5 15253.0 15255.7 15258.8 10561.0 11595.8 11816.7 11908.6 11987.1 14763.2 14877.2 14922.4 14996.4 15009.5 5736.8 5745.5 5778.8 5814.6 5923.9 879.4 918.4 921.8 957.3 977.7 26571.3 27764.9 27926.7 28028.9 28142.0 1003.8 1014.5 1057.1 1073.0 1117.9 14216.6 14798.3 14809.6 15152.2 15248.7 363232.0 364559.0 365848.0 367336.0 368281.0 47987.8 48106.8 48155.0 48180.5 48194.5 1101.9 1179.4 1180.8 1214.9 1237.6 25203.5 28398.0 28816.6 29560.1 29612.0 42082.4 42609.8 42626.4 42904.0 42977.8 329141.0 335263.0 335861.0 336231.0 338553.0 30935.4 32519.7 38165.2 41202.4 41782.8 41728.0 41891.8 42261.8 42870.6 42936.0 35405.5 36007.3 36191.0 36297.0 36506.3 34598.3 35138.6 35241.8 35478.3 35944.3 31690.2 31772.8 31980.4 32008.7 35803.3 28658.0 32958.0 33066.0 33390.0 33656.3 25293.4 25358.4 25407.2 25416.0 25424.7 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#2] jquery.html Cycles:180 Average:22294.57 Median:43258.46 stddev:57347.39 (132.6%) stddev-sans-first:57484.64 09:02:28 INFO - PROCESS | 10203 | Values: 371.8 373.1 377.6 390.6 391.7 15610.5 16628.9 17128.4 17279.7 17448.7 16040.4 16442.6 17001.9 17003.1 17010.9 5013.8 5115.7 5139.9 5187.9 5192.8 3693.3 3886.5 5101.8 5592.0 5933.9 5965.4 5973.5 5990.8 5991.1 5994.7 5851.2 5887.0 5978.4 5981.0 6007.1 3359.4 4927.8 5228.5 5243.0 5274.3 19371.3 19734.8 19738.1 20052.9 20121.7 1964.3 2022.2 2060.8 2070.9 2100.3 12632.7 12746.2 12778.0 12873.6 13242.3 1733.7 1775.6 1779.3 1801.1 1853.8 62491.4 65152.0 65366.0 65504.3 65692.3 9070.6 9144.8 9550.3 9761.9 9872.7 12883.5 12981.5 13025.3 13044.2 13053.0 7342.4 7360.3 7557.2 7662.1 7704.3 7428.6 7480.6 7493.1 7605.4 7638.1 5982.7 5987.0 6074.7 6101.6 6143.3 1556.8 1634.4 1643.2 1692.8 1750.5 823.2 872.9 897.2 905.7 933.2 16067.6 16423.3 16558.5 16832.5 17388.6 912.6 925.6 941.7 953.7 957.4 9360.4 9817.7 9897.7 9913.7 10093.3 336529.0 344526.0 354562.0 354680.0 355944.0 41869.2 48590.0 66983.3 67158.3 67523.7 917.4 946.4 971.6 997.6 1002.1 14948.6 15065.8 15154.3 15187.6 15272.8 31510.0 31615.5 31900.4 32124.0 32375.0 43088.6 43203.6 43313.4 43352.1 43397.3 7698.5 7758.0 7825.2 7830.0 7962.0 11347.5 11599.5 11804.5 12106.9 12368.7 9398.2 9638.2 9884.8 10117.0 10256.4 9835.8 9956.8 9994.0 10254.5 10537.6 8749.9 10273.5 10460.5 10572.7 10719.2 7685.3 7719.2 7738.5 7793.3 7883.4 10460.7 10656.8 10668.2 10671.8 10713.1 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#3] mootools.html Cycles:180 Average:4919.13 Median:5108.78 stddev:2702.10 (52.9%) stddev-sans-first:2695.46 09:02:28 INFO - PROCESS | 10203 | Values: 1230.5 1359.2 1383.9 1469.4 1691.3 6509.3 7259.6 7520.6 7527.8 7685.3 7358.7 7504.1 7517.9 7519.4 7521.2 2178.0 2204.9 2208.5 2208.9 2209.4 2149.3 2173.1 2202.7 2205.0 2207.3 2172.1 2179.5 2180.8 2181.6 2220.8 2129.4 2130.2 2135.0 2135.7 2136.9 2086.5 2126.9 2132.0 2135.4 2136.3 7316.4 7506.4 7509.2 7539.1 7551.7 4565.8 4640.8 4664.3 4676.5 4679.9 2765.3 2977.2 2996.9 3026.5 3027.2 974.7 979.4 989.5 997.0 1004.1 9909.5 9921.6 9930.1 10020.0 10027.2 3995.4 4065.8 4105.7 4124.0 4129.5 7874.5 7901.8 7927.7 7949.2 7954.0 4608.6 4609.4 4612.0 4613.7 4615.4 3616.5 3810.6 4198.8 4230.9 4232.5 3398.6 3436.2 3460.4 3492.7 3504.2 1040.9 1041.3 1043.3 1043.4 1048.6 730.4 862.2 865.9 873.3 877.7 4893.2 5076.1 5202.6 5206.8 5214.6 401.6 414.8 419.6 421.2 426.1 3512.7 3542.3 3554.3 3582.1 3632.4 8903.8 9111.8 9240.7 9248.5 9256.6 9011.7 9047.5 9054.8 9077.7 9154.8 6786.3 6821.6 6880.2 6919.7 6964.7 5100.4 5117.1 5179.1 5230.1 5280.3 8499.1 8540.8 8547.0 8741.0 8760.5 8692.9 8771.3 8822.2 8823.6 8843.2 5430.6 5612.7 5616.4 5719.5 5720.1 6967.3 7169.2 7197.9 7381.7 7394.2 6455.5 6643.9 6679.5 6761.6 6797.2 6380.2 6390.6 6451.8 6581.8 6625.3 6068.4 6111.2 6119.9 6130.1 6134.8 4361.8 4544.9 4619.4 4664.0 4744.2 4354.3 4454.0 4564.2 4656.9 4692.3 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#4] prototype.html Cycles:180 Average:4236.14 Median:4807.66 stddev:1230.83 (25.6%) stddev-sans-first:1198.26 09:02:28 INFO - PROCESS | 10203 | Values: 297.9 301.4 302.1 305.6 308.0 4877.2 4907.8 4912.7 4929.4 4969.0 4841.7 4883.1 4889.5 4897.6 4919.5 3849.9 3857.4 3859.6 3864.7 3895.6 3647.6 3869.3 3869.9 3895.3 3904.9 3771.9 3807.8 3832.5 3845.5 3860.8 3824.2 3825.9 3833.2 3841.8 3854.3 3268.0 3298.7 3411.4 3423.9 3437.7 4669.6 4681.5 4689.8 4696.3 4710.4 4377.7 4382.5 4402.0 4402.6 4412.8 4833.5 4938.2 5092.4 5110.7 5113.6 3717.2 3742.6 3747.2 3749.3 3755.1 5337.3 5376.2 5395.3 5417.6 5424.3 3640.8 3810.7 3841.6 3854.5 3854.5 3914.1 3918.8 3918.9 3920.8 3941.2 4398.3 4411.9 4428.0 4430.6 4447.5 4973.7 5100.8 5136.5 5143.6 5174.9 1332.4 1347.3 1350.2 1361.7 1365.8 846.4 871.7 871.8 881.1 893.3 4070.7 4079.3 4092.7 4096.4 4130.6 4722.0 4725.8 4735.4 4744.6 4746.9 4081.7 4091.8 4099.8 4108.0 4120.7 2417.8 2545.0 2569.9 2716.9 2801.4 4823.8 4881.8 4910.7 4923.5 4926.4 5367.4 5387.7 5392.7 5410.4 5421.8 4791.6 4976.9 4981.6 5042.4 5086.6 5096.9 5132.8 5342.1 5362.1 5409.8 5201.1 5213.7 5226.6 5236.9 5250.2 5002.6 5038.2 5054.4 5057.4 5086.8 3659.4 3683.0 3740.2 3761.9 3766.5 5293.4 5296.8 5307.8 5319.9 5324.2 5140.7 5151.4 5163.8 5179.2 5214.0 4936.3 5154.6 5175.6 5215.8 5243.7 5045.6 5062.6 5070.7 5080.5 5087.7 5161.7 5174.5 5188.2 5201.4 5206.3 4895.6 5023.9 5026.8 5027.4 5036.7 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - PROCESS | 10203 | [#5] yui.html Cycles:180 Average:17488.23 Median:44079.34 stddev:24513.23 (55.6%) stddev-sans-first:24549.28 09:02:28 INFO - PROCESS | 10203 | Values: 619.9 649.9 665.6 687.8 733.7 11801.4 12477.9 12478.4 12492.9 12494.1 12178.8 13025.7 13026.7 13052.7 13092.7 617.9 630.9 777.3 790.3 800.0 795.3 796.7 797.8 798.4 798.7 843.8 845.2 845.5 845.5 845.6 640.0 657.5 657.6 659.9 834.1 581.6 596.2 599.1 600.3 600.7 12875.4 12892.4 13315.5 13361.4 13378.3 12343.9 12776.3 12834.5 12925.9 13231.8 11692.6 11874.2 11955.3 11986.7 12120.2 4064.0 4102.9 4156.5 4186.5 4205.8 55641.4 55850.2 57219.7 59416.7 59945.7 10367.8 10558.7 10606.1 10619.8 10921.9 19127.0 19194.8 19201.6 19202.3 19364.0 6961.5 7002.0 7020.8 7113.4 7121.4 3742.1 3743.9 3811.8 3828.6 3837.8 2789.3 2872.6 2879.5 2882.2 2882.8 507.1 524.9 531.7 533.5 534.7 434.8 499.2 533.6 554.8 582.1 7850.6 8170.3 8176.6 8195.0 8432.8 458.6 506.0 519.1 527.2 547.1 3836.5 3883.4 3899.2 4049.3 4084.3 81694.6 94965.0 96153.0 97009.0 97268.0 80456.0 83221.6 83586.6 83692.0 85485.6 74150.6 74726.6 74902.6 75144.2 77091.0 7899.9 8029.6 8067.2 8074.3 8121.8 41944.4 43059.4 43855.3 44303.3 44326.6 42377.6 54891.7 62899.4 63968.0 67105.7 11644.5 11831.3 11922.2 12110.6 12570.6 12780.9 12867.2 12884.8 12917.6 12997.2 11984.5 12251.8 12495.8 12550.7 13059.7 11901.7 11962.0 12034.2 12097.7 12529.9 11414.8 11724.4 11772.7 11813.4 12118.5 9508.1 9694.9 9755.9 9807.6 10095.3 10101.3 10432.9 10494.3 10538.3 10629.7 09:02:28 INFO - PROCESS | 10203 | -------- Summary: end -------- 09:02:28 INFO - PROCESS | 10203 | 09:02:28 INFO - TEST-INFO | 10203: exit 0 09:02:28 INFO - TEST-OK | dromaeo_css | took 1119206ms 09:02:28 INFO - TEST-START | kraken 09:02:28 INFO - operating with platform_type : linux_ 09:02:28 INFO - Initialising browser for kraken test... 09:02:28 INFO - TEST-INFO | started process 10378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9Gym4/profile http://localhost:58409/getInfo.html) 09:02:33 INFO - PROCESS | 10378 | __metrics Screen width/height:1600/1200 09:02:33 INFO - PROCESS | 10378 | colorDepth:24 09:02:33 INFO - PROCESS | 10378 | Browser inner width/height: 1024/697 09:02:33 INFO - PROCESS | 10378 | __metrics 09:02:34 ERROR - PROCESS | 10378 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:02:35 INFO - TEST-INFO | 10378: exit 0 09:02:35 INFO - Browser initialized. 09:02:35 INFO - Running cycle 1/1 for kraken test... 09:02:35 INFO - TEST-INFO | started process 10459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9Gym4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:47 INFO - PROCESS | 10459 | RSS: Main: 157908992 09:02:47 INFO - PROCESS | 10459 | 09:02:50 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58409/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:50 INFO - PROCESS | 10459 | RSS: Main: 214290432 09:02:50 INFO - PROCESS | 10459 | 09:02:53 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58409/tests/kraken/driver.html?testName=audio-dft) 09:02:54 INFO - PROCESS | 10459 | RSS: Main: 200331264 09:02:54 INFO - PROCESS | 10459 | 09:02:57 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58409/tests/kraken/driver.html?testName=audio-fft) 09:02:58 INFO - PROCESS | 10459 | RSS: Main: 270249984 09:02:58 INFO - PROCESS | 10459 | 09:03:00 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58409/tests/kraken/driver.html?testName=audio-oscillator) 09:03:00 INFO - PROCESS | 10459 | RSS: Main: 180133888 09:03:00 INFO - PROCESS | 10459 | 09:03:03 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:03 INFO - PROCESS | 10459 | RSS: Main: 184311808 09:03:03 INFO - PROCESS | 10459 | 09:03:06 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58409/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:07 INFO - PROCESS | 10459 | RSS: Main: 220839936 09:03:07 INFO - PROCESS | 10459 | 09:03:11 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58409/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:11 INFO - PROCESS | 10459 | RSS: Main: 221245440 09:03:11 INFO - PROCESS | 10459 | 09:03:14 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58409/tests/kraken/driver.html?testName=json-parse-financial) 09:03:15 INFO - PROCESS | 10459 | RSS: Main: 221220864 09:03:15 INFO - PROCESS | 10459 | 09:03:16 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:17 INFO - PROCESS | 10459 | RSS: Main: 206254080 09:03:17 INFO - PROCESS | 10459 | 09:03:19 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:19 INFO - PROCESS | 10459 | RSS: Main: 212127744 09:03:19 INFO - PROCESS | 10459 | 09:03:22 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:22 INFO - PROCESS | 10459 | RSS: Main: 217812992 09:03:22 INFO - PROCESS | 10459 | 09:03:25 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:26 INFO - PROCESS | 10459 | RSS: Main: 224821248 09:03:26 INFO - PROCESS | 10459 | 09:03:29 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:29 INFO - PROCESS | 10459 | RSS: Main: 223793152 09:03:29 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | Cycle 1(1): loaded http://localhost:58409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58409/tests/kraken/driver.html?testName=ai-astar) 09:03:31 INFO - PROCESS | 10459 | RSS: Main: 266289152 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | __start_tp_report 09:03:31 INFO - PROCESS | 10459 | _x_x_mozilla_page_load 09:03:31 INFO - PROCESS | 10459 | _x_x_mozilla_page_load_details 09:03:31 INFO - PROCESS | 10459 | |i|pagename|runs| 09:03:31 INFO - PROCESS | 10459 | |0;ai-astar;114;109;116;114;114;115;115;115;114;114 09:03:31 INFO - PROCESS | 10459 | |1;audio-beat-detection;157;139;133;183;131;132;154;134;171;131 09:03:31 INFO - PROCESS | 10459 | |2;audio-dft;160;161;160;161;160;161;162;160;162;161 09:03:31 INFO - PROCESS | 10459 | |3;audio-fft;76;76;75;120;77;78;74;76;115;75 09:03:31 INFO - PROCESS | 10459 | |4;audio-oscillator;84;84;112;84;85;85;127;84;83;128 09:03:31 INFO - PROCESS | 10459 | |5;imaging-gaussian-blur;117;116;117;117;116;117;118;116;118;117 09:03:31 INFO - PROCESS | 10459 | |6;imaging-darkroom;145;145;146;147;146;145;145;145;146;146 09:03:31 INFO - PROCESS | 10459 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 09:03:31 INFO - PROCESS | 10459 | |8;json-parse-financial;64;66;65;65;65;67;64;63;63;64 09:03:31 INFO - PROCESS | 10459 | |9;json-stringify-tinderbox;65;65;65;65;76;65;65;65;65;65 09:03:31 INFO - PROCESS | 10459 | |10;stanford-crypto-aes;89;85;83;90;83;89;91;85;120;86 09:03:31 INFO - PROCESS | 10459 | |11;stanford-crypto-ccm;145;134;134;145;134;139;144;136;160;138 09:03:31 INFO - PROCESS | 10459 | |12;stanford-crypto-pbkdf2;174;174;177;169;170;171;168;172;171;171 09:03:31 INFO - PROCESS | 10459 | |13;stanford-crypto-sha256-iterative;70;67;67;67;76;72;67;66;65;66 09:03:31 INFO - PROCESS | 10459 | __end_tp_report 09:03:31 INFO - PROCESS | 10459 | __start_cc_report 09:03:31 INFO - PROCESS | 10459 | _x_x_mozilla_cycle_collect,1922 09:03:31 INFO - PROCESS | 10459 | __end_cc_report 09:03:31 INFO - PROCESS | 10459 | __startTimestamp1464883411949__endTimestamp 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | ------- Summary: start ------- 09:03:31 INFO - PROCESS | 10459 | Number of tests: 14 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.89 (1.6%) stddev-sans-first:2.00 09:03:31 INFO - PROCESS | 10459 | Values: 114.0 109.0 116.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:146.50 stddev:18.81 (12.8%) stddev-sans-first:19.56 09:03:31 INFO - PROCESS | 10459 | Values: 157.0 139.0 133.0 183.0 131.0 132.0 154.0 134.0 171.0 131.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:03:31 INFO - PROCESS | 10459 | Values: 160.0 161.0 160.0 161.0 160.0 161.0 162.0 160.0 162.0 161.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:17.62 (23.2%) stddev-sans-first:18.44 09:03:31 INFO - PROCESS | 10459 | Values: 76.0 76.0 75.0 120.0 77.0 78.0 74.0 76.0 115.0 75.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:18.93 (22.5%) stddev-sans-first:19.61 09:03:31 INFO - PROCESS | 10459 | Values: 84.0 84.0 112.0 84.0 85.0 85.0 127.0 84.0 83.0 128.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:03:31 INFO - PROCESS | 10459 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 118.0 116.0 118.0 117.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:03:31 INFO - PROCESS | 10459 | Values: 145.0 145.0 146.0 147.0 146.0 145.0 145.0 145.0 146.0 146.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:03:31 INFO - PROCESS | 10459 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 09:03:31 INFO - PROCESS | 10459 | Values: 64.0 66.0 65.0 65.0 65.0 67.0 64.0 63.0 63.0 64.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.00 stddev:3.48 (5.4%) stddev-sans-first:3.67 09:03:31 INFO - PROCESS | 10459 | Values: 65.0 65.0 65.0 65.0 76.0 65.0 65.0 65.0 65.0 65.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:87.50 stddev:10.89 (12.4%) stddev-sans-first:11.54 09:03:31 INFO - PROCESS | 10459 | Values: 89.0 85.0 83.0 90.0 83.0 89.0 91.0 85.0 120.0 86.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:141.50 stddev:8.08 (5.7%) stddev-sans-first:8.43 09:03:31 INFO - PROCESS | 10459 | Values: 145.0 134.0 134.0 145.0 134.0 139.0 144.0 136.0 160.0 138.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:171.50 stddev:2.67 (1.6%) stddev-sans-first:2.70 09:03:31 INFO - PROCESS | 10459 | Values: 174.0 174.0 177.0 169.0 170.0 171.0 168.0 172.0 171.0 171.0 09:03:31 INFO - PROCESS | 10459 | 09:03:31 INFO - PROCESS | 10459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.00 stddev:3.40 (5.1%) stddev-sans-first:3.55 09:03:31 INFO - PROCESS | 10459 | Values: 70.0 67.0 67.0 67.0 76.0 72.0 67.0 66.0 65.0 66.0 09:03:31 INFO - PROCESS | 10459 | -------- Summary: end -------- 09:03:31 INFO - PROCESS | 10459 | 09:03:33 INFO - TEST-INFO | 10459: exit 0 09:03:33 INFO - TEST-OK | kraken | took 64175ms 09:03:33 INFO - SUITE-END | took 1183s 09:03:33 INFO - Completed test suite (00:19:43) 09:03:33 INFO - javascript benchmark 09:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2677.79916506262, 2690.4753573053263, 2720.2655283073573, 2730.563109902416, 2748.9037883674077, 4557.088582283548, 4644.535546445354, 4746.145693775124, 4774.355462012627, 4852.102361063201, 4713.0, 4722.315264286676, 4726.361941137945, 4772.642051846108, 4777.880552986168, 4117.649999750025, 4271.551487093865, 4346.456692913386, 4373.103513779683, 4489.483709373431, 4391.121775644868, 4425.026494171278, 4443.577860103301, 4455.732656040648, 4472.038511719979, 4224.957750422503, 4258.659307255412, 4278.443802305712, 4350.064736081726, 4356.390105385249, 4292.613664770154, 4297.39836422901, 4298.828046878121, 4326.199653064194, 4343.370211319372, 4312.159128969852, 4325.52419233884, 4342.869713908588, 4370.847020354304, 4371.650267978554, 4559.863204103882, 4606.976965115186, 4656.231721765905, 4660.460049273154, 4682.789274482657, 5135.4094279157625, 5137.357830271216, 5156.071907056728, 5162.432132465426, 5164.354455693038, 5134.229865520165, 5160.587153027749, 5175.922361164586, 5184.274201611777, 5186.040582492214, 4623.0, 4683.320918466803, 4729.243321068612, 4732.195526760459, 4788.3056956741075, 5216.843494695166, 5248.160294352885, 5248.947510524922, 5249.895002100013, 5252.080885844962, 4962.354893863775, 4986.650934434628, 5033.0940430722085, 5033.144365457881, 5035.395752509649, 4943.4809345018975, 5066.03745288394, 5122.87192820175, 5180.300659411007, 5183.2743415921805, 5145.305383773143, 5149.485051494896, 5150.768215430315, 5150.922736158961, 5154.458781827929, 5119.232115182753, 5119.897602048012, 5120.385553733501, 5125.743712814345, 5157.406898206679, 4228.746275223435, 4269.957300427018, 4270.658347332268, 4302.462192225972, 4303.505096913832, 3743.157789497341, 3754.1740817020213, 3772.1889793694486, 3800.4489349044234, 3812.3519001769764, 4360.280553708666, 4362.062156636339, 4365.126974605092, 4412.24991751403, 4424.446944131983, 4874.975625121851, 4975.278584605212, 5062.9746851266245, 5077.720725360141, 5123.769430375642, 4358.3244597087505, 4387.188370151533, 4390.714603550823, 4394.428724265825, 4401.22978478765, 4611.100835337077, 4614.97692511542, 4633.582977532038, 4657.883552911137, 4661.557152070548, 4606.976965115153, 4658.184817656965, 4830.565249127595, 4833.9033219335415, 4836.709797412166, 5083.0, 5122.641415100908, 5129.9743501282255, 5131.948680513147, 5133.486651334837, 4817.084753896748, 4840.661153719347, 4843.24929635907, 4854.757262136808, 4896.069746748107, 4866.513348665105, 4977.701337919736, 5058.418281897481, 5071.492850715046, 5105.412877518985, 5083.694978301313, 5096.133657278346, 5110.361204849394, 5113.53978141969, 5151.1243088675765, 4967.975160124176, 4982.7508624569355, 4992.226204938241, 4993.650444468853, 5041.1430056889685, 4810.95189048119, 4934.161192597196, 4969.975150124226, 4982.950170498394, 4999.0501804657, 4941.65408421407, 4953.628477864103, 4972.105021096238, 4974.602031837372, 4984.75076246179, 5009.749512524432, 5011.649184557046, 5018.749062546931, 5018.824341148188, 5058.0, 4724.574788269072, 4828.227483602747, 4894.486078961801, 4902.117618828645, 4919.237518184687], "value": 4673.907106593566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0744038854141, 584.9853753656159, 597.8624916269258, 598.6109029131067, 613.5153228949131, 27067.323316917063, 40727.185456290856, 41370.17259654805, 41400.79299603505, 41615.58384416155, 40944.59055409445, 41508.79245603768, 41590.37614435786, 41599.37600935988, 41644.79177604115, 7269.74555890544, 7425.888611670829, 7436.814079647998, 7651.201967537624, 7837.608119594026, 7585.81035474112, 9854.40873547586, 10158.034986676292, 10159.288849780482, 10409.739756506073, 10086.041826026552, 10151.949240253789, 10152.137068349199, 10163.339382940085, 10166.745831354201, 7586.772396828104, 7815.062192536875, 10014.248931330143, 10111.191104711605, 10114.645987390479, 7411.7035318587195, 9612.807743845155, 10025.19798416125, 10031.498425078717, 10304.845427318596, 37719.245615087544, 38173.61826381728, 38197.80901095505, 38209.61790382089, 38232.235355293014, 3012.6686064532882, 3122.73456756176, 3291.5062740589105, 3619.963800361989, 3734.9253014939823, 29012.12963611095, 29266.85366573175, 29422.852885735647, 29472.41055178906, 29587.556186657217, 3521.330947120039, 3564.1267889367014, 3570.9285814283567, 3576.302620988908, 3609.0, 246010.0, 246523.0, 246560.9999999982, 247877.0, 247995.0, 51015.234771478456, 51244.0, 51412.74293628508, 51478.48521514812, 51547.0, 48823.0, 49086.509134908905, 49094.50905490971, 49121.0, 49142.50857491451, 14710.485133020293, 15252.542423727306, 15253.0, 15255.694886102216, 15258.847411525965, 10561.0, 11595.76808463826, 11816.70458238551, 11908.583199587973, 11987.100967427477, 14763.188024658532, 14877.18175500358, 14922.40310387594, 14996.400143994337, 15009.474668386554, 5736.827895163152, 5745.540356771448, 5778.768849245983, 5814.622049566765, 5923.940760592425, 879.3624622149018, 918.4122161816442, 921.7787730944525, 957.3346524165777, 977.7408986618552, 26571.335716606853, 27764.861175693994, 27926.72073279282, 28028.85985570059, 28142.0, 1003.8343673293971, 1014.5079636376352, 1057.143713591993, 1072.9624463143753, 1117.8882111788755, 14216.644583885485, 14798.334074966653, 14809.555713328617, 15152.16663083541, 15248.695026099416, 363232.0, 364559.0, 365848.0, 367336.0, 368281.0, 47987.76006120017, 48106.75946620244, 48155.0, 48180.5181948183, 48194.5180548197, 1101.9393933333743, 1179.422083179236, 1180.7697498987616, 1214.9392530373445, 1237.6287113865803, 25203.495930081663, 28398.0, 28816.567751483326, 29560.113196604136, 29612.0, 42082.368764467945, 42609.78695106505, 42626.36060459157, 42904.0, 42977.78511107424, 329141.0, 335263.0, 335861.0, 336231.0, 338553.0, 30935.381292373575, 32519.674803252612, 38165.236695266496, 41202.38196427116, 41782.79108604559, 41728.0, 41891.7905410471, 42261.78869105635, 42870.57129428666, 42936.0, 35405.468917965736, 36007.279854402244, 36191.0, 36297.0, 36506.26987460289, 34598.30803383968, 35138.648613513535, 35241.82379088088, 35478.290434190654, 35944.281114378085, 31690.207744806565, 31772.841135795097, 31980.36039279155, 32008.67991320057, 35803.28393432169, 28657.996970105945, 32958.01125966225, 33066.0, 33390.0, 33656.32687346288, 25293.367665807767, 25358.366040849127, 25407.237782866545, 25416.0, 25424.745752542978], "value": 17939.181649406313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.80480247869866, 373.07477455909344, 377.6054023545396, 390.6074395232791, 391.6572998626202, 15610.531684049483, 16628.916855415737, 17128.400505982292, 17279.74080388795, 17448.651026979453, 16040.438584649539, 16442.588935276595, 17001.91499042503, 17003.064831434265, 17010.914945425287, 5013.799448022084, 5115.693058416488, 5139.948600513984, 5187.948120518784, 5192.844214673566, 3693.2982733280724, 3886.514185726784, 5101.770420331075, 5592.0, 5933.940660593404, 5965.373635768247, 5973.4623883850445, 5990.760369585211, 5991.131285963533, 5994.700264986734, 5851.210086638292, 5886.970565147169, 5978.40215978403, 5981.043033114703, 6007.068904319837, 3359.3617212729746, 4927.7536123193695, 5228.47715228478, 5242.973785131088, 5274.2879711238875, 19371.3220037298, 19734.80265197344, 19738.111784969566, 20052.89973550123, 20121.698174527395, 1964.2928545723528, 2022.2012305139535, 2060.7939206079423, 2070.8861012644297, 2100.2649072824543, 12632.68418289541, 12746.235225886476, 12778.0, 12873.613791586267, 13242.337883105805, 1733.7139372003605, 1775.573862273058, 1779.2704990953646, 1801.1354549816162, 1853.8424233940132, 62491.37508624946, 65152.0, 65366.0, 65504.344956550776, 65692.3430765691, 9070.637174512945, 9144.771380715401, 9550.331476796697, 9761.853572196424, 9872.654457093968, 12883.54907578249, 12981.545645902537, 13025.283609401575, 13044.152130111703, 13053.0, 7342.4493163012985, 7360.300771426706, 7557.168711441737, 7662.118856331482, 7704.26809453101, 7428.588568172138, 7480.5885676287235, 7493.100827900686, 7605.353544948631, 7638.083429988437, 5982.700864956735, 5986.970065149646, 6074.726637301332, 6101.633901965896, 6143.32423433422, 1556.7898333724802, 1634.3789360043108, 1643.194834531095, 1692.8307169283219, 1750.4836073358135, 823.2138307915926, 872.8952525696957, 897.2059727141527, 905.7328088213993, 933.2067742419025, 16067.598310042342, 16423.260953257133, 16558.503244902673, 16832.495025149266, 17388.565285867953, 912.5847739278612, 925.5973651461636, 941.6657086734248, 953.6750834963408, 957.4446820843893, 9360.4383736976, 9817.705468835946, 9897.703068907944, 9913.653022144335, 10093.343932644355, 336529.0, 344526.0, 354562.0, 354680.0, 355944.0, 41869.1626167475, 48590.0, 66983.33016669868, 67158.32841671619, 67523.66238168876, 917.4495302818389, 946.3517490519016, 971.6016433262329, 997.551102004101, 1002.0981116994617, 14948.626284342978, 15065.774013390028, 15154.3180556873, 15187.620309492351, 15272.770908436605, 31510.0, 31615.525767113053, 31900.36199275955, 32124.0, 32375.0, 43088.569114308455, 43203.567964319955, 43313.35029974616, 43352.13295734004, 43397.349039763794, 7698.499597526367, 7757.961210193913, 7825.200203953009, 7830.0, 7962.044554653478, 11347.48936297852, 11599.478023489131, 11804.468798903898, 12106.878931210575, 12368.690782730504, 9398.248140148908, 9638.180754635934, 9884.802303954024, 10117.038881306264, 10256.38461692301, 9835.754106147404, 9956.751081222737, 9993.950030249802, 10254.538545765608, 10537.57849686004, 8749.862517872636, 10273.486325683836, 10460.529276182742, 10572.682819515427, 10719.249652524248, 7685.308322251024, 7719.228077192236, 7738.458307918391, 7793.337566306927, 7883.448158628841, 10460.68617941463, 10656.840147397641, 10668.1998850085, 10671.839922401015, 10713.089387402159], "value": 8213.297542037537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.4647478346915, 1359.238826257296, 1383.8892888568917, 1469.4416121873694, 1691.3065643086336, 6509.251436084852, 7259.60072196029, 7520.586367749772, 7527.774166774999, 7685.269899359552, 7358.705651773936, 7504.061992250969, 7517.924820751791, 7519.436042296836, 7521.172671006185, 2177.9782202177976, 2204.944876378095, 2208.5251670890757, 2208.856424332413, 2209.359285807114, 2149.279991202949, 2173.0547211962767, 2202.6695995600708, 2205.0297868937696, 2207.348832094536, 2172.120291282033, 2179.498715295483, 2180.8473406861526, 2181.6291230490856, 2220.8001279884807, 2129.361191642501, 2130.2331160782105, 2135.0178917697876, 2135.658294672845, 2136.9465763355884, 2086.457521044539, 2126.851120421571, 2131.9680204796787, 2135.4234356723755, 2136.316378758798, 7316.414686825041, 7506.43701722373, 7509.173990861001, 7539.095308563007, 7551.660175292125, 4565.840195593139, 4640.814367425299, 4664.32367306742, 4676.485586585472, 4679.9298010529865, 2765.294849813305, 2977.166393409827, 2996.8951086712077, 3026.4854974654363, 3027.197792584967, 974.6686126716879, 979.3732011512637, 989.5448093876753, 997.0428388746811, 1004.0762498501323, 9909.504524773733, 9921.55353009109, 9930.106290433896, 10020.0, 10027.197824174049, 3995.440638310639, 4065.776382299002, 4105.733127346773, 4124.0, 4129.525104612948, 7874.527528348203, 7901.762947111596, 7927.722529711433, 7949.244821741925, 7954.045514538292, 4608.585227329557, 4609.377734005866, 4612.0, 4613.746243956548, 4615.423072115986, 3616.475611036385, 3810.6379893910034, 4198.769067701306, 4230.936535951963, 4232.513260974965, 3398.6091599465885, 3436.2096717755057, 3460.3944309745693, 3492.738044646611, 3504.2115524007404, 1040.9011143941314, 1041.2919214933918, 1043.3270540501485, 1043.436544266103, 1048.5543643951444, 730.3536370312312, 862.215384000569, 865.8701194820701, 873.3013589128672, 877.6884206106868, 4893.21708526634, 5076.0863044652315, 5202.635815492879, 5206.843794686166, 5214.634975551751, 401.59639562240346, 414.78223932435714, 419.5699408106715, 421.2081287180082, 426.098801035807, 3512.6838584527513, 3542.309249696336, 3554.3424466473784, 3582.1223800169128, 3632.3824949758605, 8903.777405564782, 9111.772205694779, 9240.676576319931, 9248.491332976751, 9256.583453744597, 9011.684591039282, 9047.547622618975, 9054.81890362189, 9077.727668169966, 9154.816903662022, 6786.321367863175, 6821.624810635462, 6880.2431732509385, 6919.654017299215, 6964.721411143498, 5100.438951715382, 5117.130087884994, 5179.1195496766395, 5230.084735171406, 5280.287161233185, 8499.10759370282, 8540.804457113898, 8546.957265213883, 8740.956295218482, 8760.51817150063, 8692.869606956026, 8771.254443372129, 8822.2060014599, 8823.602937867683, 8843.159899809507, 5430.592705547178, 5612.747426365905, 5616.354119276172, 5719.48524632785, 5720.11338242573, 6967.303269672992, 7169.247229040876, 7197.856042879009, 7381.704731810667, 7394.186639469762, 6455.48356131499, 6643.900341494785, 6679.532432729662, 6761.628110453972, 6797.218319893275, 6380.170577824853, 6390.648514331757, 6451.838704032437, 6581.769638062645, 6625.337466253336, 6068.423499767515, 6111.236095488064, 6119.908201376894, 6130.141780150871, 6134.78528251509, 4361.8255269790125, 4544.909101818012, 4619.445666520039, 4663.976680116578, 4744.240921452551, 4354.346847972829, 4454.0, 4564.201264778584, 4656.883577910579, 4692.319613656069], "value": 3935.317990317259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.85702862625936, 301.36261806279697, 302.0861892774357, 305.5599936092026, 308.02049482645185, 4877.170880950238, 4907.779149938252, 4912.680675756078, 4929.433115191754, 4968.975155124228, 4841.685290456118, 4883.072216278904, 4889.511048895109, 4897.608191344692, 4919.532644398785, 3849.9037524061982, 3857.40210267409, 3859.5754467008605, 3864.7487913285545, 3895.590962948892, 3647.6352364763575, 3869.3361854402597, 3869.8645547405845, 3895.2988462076814, 3904.882853514399, 3771.924561508768, 3807.847686092553, 3832.501774769276, 3845.4808600838946, 3860.82626281818, 3824.1969186470874, 3825.9426108608254, 3833.2333533293313, 3841.8271177797064, 3854.342632667952, 3267.950980735291, 3298.670132986706, 3411.3688967541084, 3423.9486407703903, 3437.656234376542, 4669.556392142775, 4681.5318468153255, 4689.81923405618, 4696.295555666643, 4710.434747830248, 4377.737335759833, 4382.474103107647, 4401.955980440187, 4402.581754733295, 4412.75729834859, 4833.468318484964, 4938.160512712848, 5092.439831618519, 5110.744462776846, 5113.616478764107, 3717.1636381814146, 3742.6257374262627, 3747.156889699823, 3749.343864823645, 3755.1363186466992, 5337.2527846101575, 5376.220448035052, 5395.271638328814, 5417.647852889589, 5424.267723857308, 3640.7633503822167, 3810.666266806651, 3841.5582208045876, 3854.5181852268465, 3854.5374555053013, 3914.1388894443176, 3918.7648741075627, 3918.8824335269987, 3920.7647541147053, 3941.231459865299, 4398.252297109499, 4411.933820992687, 4427.955720442818, 4430.579094985971, 4447.533009034005, 4973.701577905337, 5100.770465329069, 5136.486351364908, 5143.639945203875, 5174.9482505174465, 1332.393760838816, 1347.3398034962797, 1350.1898860683511, 1361.7140400515805, 1365.7951307303786, 846.3863698818308, 871.73412109306, 871.7951281448854, 881.0528681667233, 893.3255392178993, 4070.674346052309, 4079.287273962841, 4092.7135100542678, 4096.40602112692, 4130.562967848923, 4721.952780472151, 4725.834595789131, 4735.431748190239, 4744.596709279681, 4746.857594272177, 4081.714280000431, 4091.7954102294766, 4099.836006559704, 4107.979460102681, 4120.7321524100835, 2417.830751847354, 2544.9618255726177, 2569.8843552040203, 2716.9456610867674, 2801.3836955869674, 4823.758812059383, 4881.755912204376, 4910.705357678551, 4923.507649235048, 4926.359573255526, 5367.443441402028, 5387.703676297763, 5392.73036348181, 5410.404855465896, 5421.810236641699, 4791.5687588117235, 4976.850694479099, 4981.551660350586, 5042.445331013512, 5086.61850361217, 5096.872578185575, 5132.820351287687, 5342.118550439134, 5362.1420572708175, 5409.756560954846, 5201.115810312181, 5213.661112027706, 5226.608004399609, 5236.895262094813, 5250.18622113573, 5002.574781143643, 5038.168702164102, 5054.393472783289, 5057.418396884405, 5086.847394578169, 3659.4144936809985, 3682.963170368262, 3740.2332521832413, 3761.887143385703, 3766.472693822922, 5293.364796224478, 5296.761645726028, 5307.787688492417, 5319.8612818437305, 5324.201369794562, 5140.7429628517675, 5151.356080489939, 5163.793448262028, 5179.22311653255, 5214.0, 4936.3089167515855, 5154.61340399479, 5175.637705360739, 5215.791368345375, 5243.68537887728, 5045.596352291881, 5062.620303477181, 5070.670406423571, 5080.46655101209, 5087.669301495391, 5161.741912904265, 5174.534291913746, 5188.195829646411, 5201.375834899836, 5206.297149884717, 4895.608351331956, 5023.924641130459, 5026.7828589701885, 5027.4218464877, 5036.6726162799305], "value": 3847.172063827385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.894617914955, 649.870025994801, 665.6339013542554, 687.821166496711, 733.7211859493392, 11801.350925699095, 12477.875221247785, 12478.376081195938, 12492.875071249286, 12494.062945279107, 12178.81731774024, 13025.674358141052, 13026.73946521069, 13052.73894522109, 13092.672683182902, 617.9351168127349, 630.9022101574263, 777.3004296133469, 790.3242727468004, 800.0119851982796, 795.2564352330561, 796.7291121018852, 797.8444203380315, 798.3573223555036, 798.6725442568548, 843.8270154618319, 845.2308399356587, 845.5053793530792, 845.5434065604566, 845.5687599324358, 640.036744699227, 657.4805903336359, 657.5758635680007, 659.8515334049848, 834.1325021977136, 581.6393835821775, 596.2308621877772, 599.06246723877, 600.3456232706371, 600.6756351570147, 12875.356232188447, 12892.355382230851, 13315.467381304736, 13361.398737056856, 13378.264195469244, 12343.876561234452, 12776.297303648296, 12834.486620535168, 12925.935370323183, 13231.801522977163, 11692.649220523313, 11874.16880818343, 11955.342456164908, 11986.700332491757, 12120.151589388746, 4063.9593604063875, 4102.917941641151, 4156.459660244179, 4186.476690413699, 4205.768682722449, 55641.44358556443, 55850.16224756632, 57219.713901430645, 59416.70291648514, 59945.70027149836, 10367.844482332772, 10558.736031599272, 10606.098481628993, 10619.84070238947, 10921.945390272998, 19127.0, 19194.808051919583, 19201.61596768057, 19202.327918522784, 19364.0, 6961.547499412522, 7002.0, 7020.7893763187185, 7113.395361394236, 7121.394681452135, 3742.139307959185, 3743.887683369503, 3811.8284677189595, 3828.636279553438, 3837.76973381598, 2789.27478855499, 2872.6121973533723, 2879.5248783950833, 2882.2218001139577, 2882.783791215625, 507.1049597460485, 524.8635354807777, 531.7208465555536, 533.5411546070376, 534.6898798696747, 434.81085727708546, 499.22370713540795, 533.6157966264361, 554.8335499350179, 582.1413415212528, 7850.607469626496, 8170.305524030405, 8176.6320515576945, 8195.0, 8432.78918027042, 458.58498059256425, 505.9544640982329, 519.1304564853855, 527.2223470381157, 547.1464515356057, 3836.5396152461885, 3883.417487376916, 3899.2201559688174, 4049.3318602430268, 4084.264832330209, 81694.59152704317, 94965.0, 96153.0, 97009.0, 97268.0, 80456.0, 83221.58389208015, 83586.5820670905, 83692.0, 85485.57257213673, 74150.62924685342, 74726.62636686781, 74902.62548687331, 75144.24855751482, 77091.0, 7899.921000790148, 8029.638666260149, 8067.152948940511, 8074.273315401642, 8121.837563248584, 41944.3708344369, 43059.35410968775, 43855.34216986684, 44303.33544996763, 44326.55673443224, 42377.57622423736, 54891.725541372034, 62899.371006291185, 63968.0, 67105.66447167733, 11644.475998579916, 11831.34927578957, 11922.165448418527, 12110.576129835414, 12570.622881313575, 12780.872191277967, 12867.163634363736, 12884.806727898902, 12917.612471625866, 12997.220166790023, 11984.520619175484, 12251.75496490083, 12495.750084998068, 12550.748985020431, 13059.673508162372, 11901.702457438634, 11962.0, 12034.196506009168, 12097.669809112651, 12529.93735031319, 11414.771704566028, 11724.355160466257, 11772.70568235801, 11813.350265735124, 12118.515259389525, 9508.144267016001, 9694.854577181206, 9755.902440975784, 9807.55865986018, 10095.343802652804, 10101.292909496266, 10432.947835260775, 10494.317869338469, 10538.315009524356, 10629.734256643645], "value": 6552.053648029915, "unit": "score"}], "name": "dromaeo_css", "value": 6393.792232618511, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 139.0, 133.0, 183.0, 131.0, 132.0, 154.0, 134.0, 171.0, 131.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 120.0, 77.0, 78.0, 74.0, 76.0, 115.0, 75.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 85.0, 85.0, 127.0, 84.0, 83.0, 128.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 67.0, 64.0, 63.0, 63.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 76.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 83.0, 90.0, 83.0, 89.0, 91.0, 85.0, 120.0, 86.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 134.0, 145.0, 134.0, 139.0, 144.0, 136.0, 160.0, 138.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 177.0, 169.0, 170.0, 171.0, 168.0, 172.0, 171.0, 171.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 67.0, 76.0, 72.0, 67.0, 66.0, 65.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1560.1, "alertThreshold": 2.0}]} 09:03:33 INFO - Return code: 0 09:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:33 ERROR - # TBPL SUCCESS # 09:03:33 INFO - Running post-action listener: _resource_record_post_action 09:03:33 INFO - ##### 09:03:33 INFO - ##### Finished run-tests step (success) 09:03:33 INFO - ##### 09:03:33 INFO - Running post-run listener: _resource_record_post_run 09:03:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532758528; Read time: 12; Write time: 545912 09:03:33 INFO - TinderboxPrint: CPU usage
13.1% 09:03:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:03:33 INFO - TinderboxPrint: I/O write bytes / time
532,758,528 / 545,912 09:03:33 INFO - TinderboxPrint: CPU idle
8,318.4 (86.8%) 09:03:33 INFO - TinderboxPrint: CPU user
1,214.5 (12.7%) 09:03:33 INFO - TinderboxPrint: Swap in / out
0 / 0 09:03:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243699712; Read time: 0; Write time: 266052 09:03:33 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287346688; Read time: 12; Write time: 279640 09:03:33 INFO - Running post-run listener: _upload_blobber_files 09:03:33 INFO - Blob upload gear active. 09:03:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:33 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 09:03:33 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'] 09:03:33 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 09:03:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:35 INFO - (blobuploader) - INFO - Done attempting. 09:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:35 INFO - (blobuploader) - INFO - Done attempting. 09:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:40 INFO - (blobuploader) - INFO - Done attempting. 09:03:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:40 INFO - Return code: 0 09:03:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd674f5b844ba68a0f720f904327876c2f1f5b58ea731e28d04a9be4a75cf1c9b43a6543fadb47e3ee7babfa0c0fcab2486df3d376ddce9601f0ba0981580c13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/780a787cbdb280fc2017aea60538c76dae031ad1a756dd6551ef2611e1060f1b375df5964e10df5465d6e46ceccea4658a8adecf30278f9ae64c3741a2793662", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bfc0b1e1a7280197e90bb54edff40a50ac51f35ff7872c8305588fc739fbde004858447a23ee910fb65925ec56f38b9a3f355d945d337461f0fa7961c01f85"} 09:03:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:40 INFO - Contents: 09:03:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd674f5b844ba68a0f720f904327876c2f1f5b58ea731e28d04a9be4a75cf1c9b43a6543fadb47e3ee7babfa0c0fcab2486df3d376ddce9601f0ba0981580c13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/780a787cbdb280fc2017aea60538c76dae031ad1a756dd6551ef2611e1060f1b375df5964e10df5465d6e46ceccea4658a8adecf30278f9ae64c3741a2793662", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bfc0b1e1a7280197e90bb54edff40a50ac51f35ff7872c8305588fc739fbde004858447a23ee910fb65925ec56f38b9a3f355d945d337461f0fa7961c01f85"} 09:03:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:40 INFO - Copying logs to upload dir... 09:03:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.103148 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 09:03:40.546980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:03:40.550967) ========= 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=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd674f5b844ba68a0f720f904327876c2f1f5b58ea731e28d04a9be4a75cf1c9b43a6543fadb47e3ee7babfa0c0fcab2486df3d376ddce9601f0ba0981580c13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/780a787cbdb280fc2017aea60538c76dae031ad1a756dd6551ef2611e1060f1b375df5964e10df5465d6e46ceccea4658a8adecf30278f9ae64c3741a2793662", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bfc0b1e1a7280197e90bb54edff40a50ac51f35ff7872c8305588fc739fbde004858447a23ee910fb65925ec56f38b9a3f355d945d337461f0fa7961c01f85"} build_url:https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/Yx0pzvFsQyqX9oWKHy3Y9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd674f5b844ba68a0f720f904327876c2f1f5b58ea731e28d04a9be4a75cf1c9b43a6543fadb47e3ee7babfa0c0fcab2486df3d376ddce9601f0ba0981580c13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/780a787cbdb280fc2017aea60538c76dae031ad1a756dd6551ef2611e1060f1b375df5964e10df5465d6e46ceccea4658a8adecf30278f9ae64c3741a2793662", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2bfc0b1e1a7280197e90bb54edff40a50ac51f35ff7872c8305588fc739fbde004858447a23ee910fb65925ec56f38b9a3f355d945d337461f0fa7961c01f85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:03:40.575967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:03:40.576318) ========= 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=7de08804244eb36560b44971000001c3-1464882175.973899-14616332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:03:40.658579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:03:40.658941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:03:40.659272) ========= ========= Total master_lag: 0.17 =========