builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1449231393.43 results: success (0) buildid: 20151204030722 builduid: bf676e69535d4b98936ae935b5fcbc0d revision: e02b17a2b5b8df7bb84f325fc08eedd2f3cab755 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.429002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.429498) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.429824) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.472139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.472488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.539930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.540264) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.621643) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.622056) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.623016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.623444) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 04:16:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.8M=0s 2015-12-04 04:16:34 (60.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.821549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.821882) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014947 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:33.873036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 04:16:33.873428) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e02b17a2b5b8df7bb84f325fc08eedd2f3cab755 --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 e02b17a2b5b8df7bb84f325fc08eedd2f3cab755 --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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 04:16:34,335 truncating revision to first 12 chars 2015-12-04 04:16:34,335 Setting DEBUG logging. 2015-12-04 04:16:34,335 attempt 1/10 2015-12-04 04:16:34,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e02b17a2b5b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 04:16:35,533 unpacking tar archive at: fx-team-e02b17a2b5b8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 04:16:35.334056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:35.334464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:35.593513) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:35.594038) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:16:35.594713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-04 04:16:35.595184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:36 INFO - MultiFileLogger online at 20151204 04:16:36 in /builds/slave/test 04:16:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:16:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:36 INFO - {'append_to_log': False, 04:16:36 INFO - 'base_work_dir': '/builds/slave/test', 04:16:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:16:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:36 INFO - 'branch': 'Fx-Team-Non-PGO', 04:16:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:36 INFO - 'config_files': ('talos/linux_config.py',), 04:16:36 INFO - 'default_actions': ('clobber', 04:16:36 INFO - 'read-buildbot-config', 04:16:36 INFO - 'download-and-extract', 04:16:36 INFO - 'populate-webroot', 04:16:36 INFO - 'create-virtualenv', 04:16:36 INFO - 'install', 04:16:36 INFO - 'run-tests'), 04:16:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:36 INFO - 'download_minidump_stackwalk': True, 04:16:36 INFO - 'download_symbols': 'ondemand', 04:16:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:36 INFO - 'installer_path': 'installer.exe', 04:16:36 INFO - 'log_level': 'info', 04:16:36 INFO - 'log_name': 'talos', 04:16:36 INFO - 'log_to_console': True, 04:16:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:36 INFO - 'opt_config_files': (), 04:16:36 INFO - 'pip_index': False, 04:16:36 INFO - 'sps_profile': False, 04:16:36 INFO - 'sps_profile_interval': 0, 04:16:36 INFO - 'suite': 'dromaeojs', 04:16:36 INFO - 'system_bits': '64', 04:16:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:36 INFO - 'title': 'talos-linux64-ix-019', 04:16:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:36 INFO - 'use_talos_json': True, 04:16:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:36 INFO - 'work_dir': 'build'} 04:16:36 INFO - ##### 04:16:36 INFO - ##### Running clobber step. 04:16:36 INFO - ##### 04:16:36 INFO - Running pre-action listener: _resource_record_pre_action 04:16:36 INFO - Running main action method: clobber 04:16:36 INFO - rmtree: /builds/slave/test/build 04:16:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:36 INFO - Running post-action listener: _resource_record_post_action 04:16:36 INFO - ##### 04:16:36 INFO - ##### Running read-buildbot-config step. 04:16:36 INFO - ##### 04:16:36 INFO - Running pre-action listener: _resource_record_pre_action 04:16:36 INFO - Running main action method: read_buildbot_config 04:16:36 INFO - Using buildbot properties: 04:16:36 INFO - { 04:16:36 INFO - "properties": { 04:16:36 INFO - "buildnumber": 986, 04:16:36 INFO - "product": "firefox", 04:16:36 INFO - "script_repo_revision": "production", 04:16:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:16:36 INFO - "repository": "", 04:16:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:16:36 INFO - "buildid": "20151204030722", 04:16:36 INFO - "slavename": "talos-linux64-ix-019", 04:16:36 INFO - "pgo_build": "False", 04:16:36 INFO - "basedir": "/builds/slave/test", 04:16:36 INFO - "project": "", 04:16:36 INFO - "platform": "ubuntu64_hw", 04:16:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:16:36 INFO - "slavebuilddir": "test", 04:16:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:16:36 INFO - "branch": "fx-team", 04:16:36 INFO - "repo_path": "integration/fx-team", 04:16:36 INFO - "stage_platform": "linux64", 04:16:36 INFO - "builduid": "bf676e69535d4b98936ae935b5fcbc0d", 04:16:36 INFO - "revision": "e02b17a2b5b8df7bb84f325fc08eedd2f3cab755" 04:16:36 INFO - }, 04:16:36 INFO - "sourcestamp": { 04:16:36 INFO - "repository": "", 04:16:36 INFO - "hasPatch": false, 04:16:36 INFO - "project": "", 04:16:36 INFO - "branch": "fx-team-linux64-talos", 04:16:36 INFO - "changes": [ 04:16:36 INFO - { 04:16:36 INFO - "category": null, 04:16:36 INFO - "files": [ 04:16:36 INFO - { 04:16:36 INFO - "url": null, 04:16:36 INFO - "name": "https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:16:36 INFO - } 04:16:36 INFO - ], 04:16:36 INFO - "repository": "", 04:16:36 INFO - "rev": "e02b17a2b5b8df7bb84f325fc08eedd2f3cab755", 04:16:36 INFO - "who": "cbook@mozilla.com", 04:16:36 INFO - "when": 1449231366, 04:16:36 INFO - "number": 6743868, 04:16:36 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:16:36 INFO - "project": "", 04:16:36 INFO - "at": "Fri 04 Dec 2015 04:16:06", 04:16:36 INFO - "branch": "fx-team-linux64-talos", 04:16:36 INFO - "revlink": "", 04:16:36 INFO - "properties": [ 04:16:36 INFO - [ 04:16:36 INFO - "buildid", 04:16:36 INFO - "20151204030722", 04:16:36 INFO - "Change" 04:16:36 INFO - ], 04:16:36 INFO - [ 04:16:36 INFO - "builduid", 04:16:36 INFO - "bf676e69535d4b98936ae935b5fcbc0d", 04:16:36 INFO - "Change" 04:16:36 INFO - ], 04:16:36 INFO - [ 04:16:36 INFO - "pgo_build", 04:16:36 INFO - "False", 04:16:36 INFO - "Change" 04:16:36 INFO - ] 04:16:36 INFO - ], 04:16:36 INFO - "revision": "e02b17a2b5b8df7bb84f325fc08eedd2f3cab755" 04:16:36 INFO - } 04:16:36 INFO - ], 04:16:36 INFO - "revision": "e02b17a2b5b8df7bb84f325fc08eedd2f3cab755" 04:16:36 INFO - } 04:16:36 INFO - } 04:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:16:36 INFO - Running post-action listener: _resource_record_post_action 04:16:36 INFO - ##### 04:16:36 INFO - ##### Running download-and-extract step. 04:16:36 INFO - ##### 04:16:36 INFO - Running pre-action listener: _resource_record_pre_action 04:16:36 INFO - Running main action method: download_and_extract 04:16:36 INFO - mkdir: /builds/slave/test/build/tests 04:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:36 INFO - https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/test_packages.json 04:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/test_packages.json 04:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:16:45 INFO - Downloaded 1302 bytes. 04:16:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:16:45 INFO - Using the following test package requirements: 04:16:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'jsshell-linux-x86_64.zip'], 04:16:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:45 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')]} 04:16:45 INFO - https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:50 INFO - Downloaded 21849064 bytes. 04:16:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:16:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:16:51 INFO - Return code: 0 04:16:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:51 INFO - https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:53 INFO - Downloaded 21849064 bytes. 04:16:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:16:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:16:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:16:54 INFO - Return code: 0 04:16:54 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')]} 04:16:54 INFO - https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:16:55 INFO - Downloaded 11132001 bytes. 04:16:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:16:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:16:55 INFO - Return code: 0 04:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:55 INFO - https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:16:57 INFO - Downloaded 57699278 bytes. 04:16:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:16:57 INFO - mkdir: /builds/slave/test/properties 04:16:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:57 INFO - Contents: 04:16:57 INFO - build_url:https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:16:57 INFO - Running post-action listener: _resource_record_post_action 04:16:57 INFO - Running post-action listener: set_extra_try_arguments 04:16:57 INFO - ##### 04:16:57 INFO - ##### Running populate-webroot step. 04:16:57 INFO - ##### 04:16:57 INFO - Running pre-action listener: _resource_record_pre_action 04:16:57 INFO - Running main action method: populate_webroot 04:16:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:16:57 INFO - '../fennec_ids.txt'], 04:16:57 INFO - 'tests': ['tcheck2']}, 04:16:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:57 INFO - '--tppagecycles', 04:16:57 INFO - '7'], 04:16:57 INFO - 'tests': ['tsvgm']}}, 04:16:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'tests': ['damp', 'tps']}, 04:16:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['damp', 'tps']}, 04:16:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:57 INFO - 'other': {'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'other_l64': {'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:57 INFO - 'ts_paint', 04:16:57 INFO - 'tpaint', 04:16:57 INFO - 'sessionrestore', 04:16:57 INFO - 'sessionrestore_no_auto_restore']}, 04:16:57 INFO - 'svgr': {'tests': ['tsvgx', 04:16:57 INFO - 'tsvgr_opacity', 04:16:57 INFO - 'tart', 04:16:57 INFO - 'tscrollx', 04:16:57 INFO - 'cart']}, 04:16:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['tsvgx', 04:16:57 INFO - 'tsvgr_opacity', 04:16:57 INFO - 'tart', 04:16:57 INFO - 'tscrollx', 04:16:57 INFO - 'cart']}, 04:16:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'tests': ['tp5o']}, 04:16:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'talos_options': ['--e10s'], 04:16:57 INFO - 'tests': ['tp5o']}, 04:16:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'talos_options': ['--xperf_path', 04:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:57 INFO - 'tests': ['tp5n']}, 04:16:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:57 INFO - 'talos_options': ['--e10s', 04:16:57 INFO - '--xperf_path', 04:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:57 INFO - 'tests': ['tp5n']}}, 04:16:57 INFO - 'talos.zip': {'path': '', 04:16:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:57 INFO - Running post-action listener: _resource_record_post_action 04:16:57 INFO - ##### 04:16:57 INFO - ##### Running create-virtualenv step. 04:16:57 INFO - ##### 04:16:57 INFO - Running pre-action listener: _resource_record_pre_action 04:16:57 INFO - Running main action method: create_virtualenv 04:16:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:57 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 04:16:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:57 INFO - Using real prefix '/usr' 04:16:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:59 INFO - Installing pip.................done. 04:16:59 INFO - Return code: 0 04:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:16:59 INFO - Using env: {'DISPLAY': ':0', 04:16:59 INFO - 'HOME': '/home/cltbld', 04:16:59 INFO - 'LANG': 'en_US.UTF-8', 04:16:59 INFO - 'LANGUAGE': 'en_US:en', 04:16:59 INFO - 'LOGNAME': 'cltbld', 04:16:59 INFO - 'MAIL': '/var/mail/cltbld', 04:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:59 INFO - 'MOZ_NO_REMOTE': '1', 04:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:59 INFO - 'NO_EM_RESTART': '1', 04:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:59 INFO - 'PWD': '/builds/slave/test', 04:16:59 INFO - 'SHELL': '/bin/bash', 04:16:59 INFO - 'SHLVL': '1', 04:16:59 INFO - 'TERM': 'linux', 04:16:59 INFO - 'TMOUT': '86400', 04:16:59 INFO - 'USER': 'cltbld', 04:16:59 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:59 INFO - '_': '/tools/buildbot/bin/python'} 04:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:00 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 04:17:00 INFO - Cleaning up... 04:17:00 INFO - Return code: 0 04:17:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:17:00 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')]} 04:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:00 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')]} 04:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:17:00 INFO - Using env: {'DISPLAY': ':0', 04:17:00 INFO - 'HOME': '/home/cltbld', 04:17:00 INFO - 'LANG': 'en_US.UTF-8', 04:17:00 INFO - 'LANGUAGE': 'en_US:en', 04:17:00 INFO - 'LOGNAME': 'cltbld', 04:17:00 INFO - 'MAIL': '/var/mail/cltbld', 04:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:00 INFO - 'MOZ_NO_REMOTE': '1', 04:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:00 INFO - 'NO_EM_RESTART': '1', 04:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:00 INFO - 'PWD': '/builds/slave/test', 04:17:00 INFO - 'SHELL': '/bin/bash', 04:17:00 INFO - 'SHLVL': '1', 04:17:00 INFO - 'TERM': 'linux', 04:17:00 INFO - 'TMOUT': '86400', 04:17:00 INFO - 'USER': 'cltbld', 04:17:00 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:00 INFO - '_': '/tools/buildbot/bin/python'} 04:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:00 INFO - Downloading/unpacking psutil>=0.7.1 04:17:00 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 04:17:00 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 04:17:00 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 04:17:00 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 04:17:00 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 04:17:00 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 04:17:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:17:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:02 INFO - Installing collected packages: psutil 04:17:02 INFO - Running setup.py install for psutil 04:17:02 INFO - building 'psutil._psutil_linux' extension 04:17:02 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 04:17:02 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 04:17:02 INFO - building 'psutil._psutil_posix' extension 04:17:02 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 04:17:02 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 04:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:02 INFO - Successfully installed psutil 04:17:02 INFO - Cleaning up... 04:17:02 INFO - Return code: 0 04:17:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:17:02 INFO - Using env: {'DISPLAY': ':0', 04:17:02 INFO - 'HOME': '/home/cltbld', 04:17:02 INFO - 'LANG': 'en_US.UTF-8', 04:17:02 INFO - 'LANGUAGE': 'en_US:en', 04:17:02 INFO - 'LOGNAME': 'cltbld', 04:17:02 INFO - 'MAIL': '/var/mail/cltbld', 04:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:02 INFO - 'MOZ_NO_REMOTE': '1', 04:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:02 INFO - 'NO_EM_RESTART': '1', 04:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:02 INFO - 'PWD': '/builds/slave/test', 04:17:02 INFO - 'SHELL': '/bin/bash', 04:17:02 INFO - 'SHLVL': '1', 04:17:02 INFO - 'TERM': 'linux', 04:17:02 INFO - 'TMOUT': '86400', 04:17:02 INFO - 'USER': 'cltbld', 04:17:02 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:02 INFO - '_': '/tools/buildbot/bin/python'} 04:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:02 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 04:17:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:17:04 INFO - Installing collected packages: mozsystemmonitor 04:17:04 INFO - Running setup.py install for mozsystemmonitor 04:17:04 INFO - Successfully installed mozsystemmonitor 04:17:04 INFO - Cleaning up... 04:17:04 INFO - Return code: 0 04:17:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:17:04 INFO - Using env: {'DISPLAY': ':0', 04:17:04 INFO - 'HOME': '/home/cltbld', 04:17:04 INFO - 'LANG': 'en_US.UTF-8', 04:17:04 INFO - 'LANGUAGE': 'en_US:en', 04:17:04 INFO - 'LOGNAME': 'cltbld', 04:17:04 INFO - 'MAIL': '/var/mail/cltbld', 04:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:04 INFO - 'MOZ_NO_REMOTE': '1', 04:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:04 INFO - 'NO_EM_RESTART': '1', 04:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:04 INFO - 'PWD': '/builds/slave/test', 04:17:04 INFO - 'SHELL': '/bin/bash', 04:17:04 INFO - 'SHLVL': '1', 04:17:04 INFO - 'TERM': 'linux', 04:17:04 INFO - 'TMOUT': '86400', 04:17:04 INFO - 'USER': 'cltbld', 04:17:04 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:04 INFO - '_': '/tools/buildbot/bin/python'} 04:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:07 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 04:17:07 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 04:17:07 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 04:17:07 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 04:17:07 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 04:17:07 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 04:17:07 INFO - Downloading docopt-0.6.1.tar.gz 04:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:07 INFO - Running setup.py install for blobuploader 04:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:07 INFO - Running setup.py install for requests 04:17:07 INFO - Running setup.py install for docopt 04:17:07 INFO - Successfully installed blobuploader requests docopt 04:17:07 INFO - Cleaning up... 04:17:07 INFO - Return code: 0 04:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:07 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')]} 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 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')]} 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 04:17:07 INFO - Using env: {'DISPLAY': ':0', 04:17:07 INFO - 'HOME': '/home/cltbld', 04:17:07 INFO - 'LANG': 'en_US.UTF-8', 04:17:07 INFO - 'LANGUAGE': 'en_US:en', 04:17:07 INFO - 'LOGNAME': 'cltbld', 04:17:07 INFO - 'MAIL': '/var/mail/cltbld', 04:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:07 INFO - 'MOZ_NO_REMOTE': '1', 04:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:07 INFO - 'NO_EM_RESTART': '1', 04:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:07 INFO - 'PWD': '/builds/slave/test', 04:17:07 INFO - 'SHELL': '/bin/bash', 04:17:07 INFO - 'SHLVL': '1', 04:17:07 INFO - 'TERM': 'linux', 04:17:07 INFO - 'TMOUT': '86400', 04:17:07 INFO - 'USER': 'cltbld', 04:17:07 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:07 INFO - '_': '/tools/buildbot/bin/python'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 INFO - Running setup.py (path:/tmp/pip-S1HhN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 INFO - Running setup.py (path:/tmp/pip-NXte6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 INFO - Running setup.py (path:/tmp/pip-vy2XPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:08 INFO - Running setup.py (path:/tmp/pip-tijlQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:08 INFO - Running setup.py (path:/tmp/pip-cCsGXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:08 INFO - Running setup.py (path:/tmp/pip-nHljnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:08 INFO - Running setup.py (path:/tmp/pip-3WBfVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:08 INFO - Running setup.py (path:/tmp/pip-grpNnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:08 INFO - Running setup.py (path:/tmp/pip-A21jmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:08 INFO - Running setup.py (path:/tmp/pip-5OPCgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:08 INFO - Running setup.py (path:/tmp/pip-hQfqcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:08 INFO - Running setup.py (path:/tmp/pip-UJ_jOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 INFO - Running setup.py (path:/tmp/pip-Y4dfPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 INFO - Running setup.py (path:/tmp/pip-pFiGMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 INFO - Running setup.py (path:/tmp/pip-7S4Pi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:09 INFO - Running setup.py (path:/tmp/pip-WkiKDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:09 INFO - Running setup.py (path:/tmp/pip-cl6keU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:09 INFO - Running setup.py install for manifestparser 04:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:09 INFO - Running setup.py install for mozcrash 04:17:09 INFO - Running setup.py install for mozdebug 04:17:09 INFO - Running setup.py install for mozdevice 04:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:09 INFO - Running setup.py install for mozfile 04:17:09 INFO - Running setup.py install for mozhttpd 04:17:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:09 INFO - Running setup.py install for mozinfo 04:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for mozInstall 04:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for mozleak 04:17:10 INFO - Running setup.py install for mozlog 04:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for moznetwork 04:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for mozprocess 04:17:10 INFO - Running setup.py install for mozprofile 04:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for mozrunner 04:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:10 INFO - Running setup.py install for mozscreenshot 04:17:10 INFO - Running setup.py install for moztest 04:17:11 INFO - Running setup.py install for mozversion 04:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:11 INFO - Cleaning up... 04:17:11 INFO - Return code: 0 04:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:17:11 INFO - Using env: {'DISPLAY': ':0', 04:17:11 INFO - 'HOME': '/home/cltbld', 04:17:11 INFO - 'LANG': 'en_US.UTF-8', 04:17:11 INFO - 'LANGUAGE': 'en_US:en', 04:17:11 INFO - 'LOGNAME': 'cltbld', 04:17:11 INFO - 'MAIL': '/var/mail/cltbld', 04:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:11 INFO - 'MOZ_NO_REMOTE': '1', 04:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:11 INFO - 'NO_EM_RESTART': '1', 04:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:11 INFO - 'PWD': '/builds/slave/test', 04:17:11 INFO - 'SHELL': '/bin/bash', 04:17:11 INFO - 'SHLVL': '1', 04:17:11 INFO - 'TERM': 'linux', 04:17:11 INFO - 'TMOUT': '86400', 04:17:11 INFO - 'USER': 'cltbld', 04:17:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:11 INFO - '_': '/tools/buildbot/bin/python'} 04:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:11 INFO - Running setup.py (path:/tmp/pip-NpyeSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:11 INFO - Running setup.py (path:/tmp/pip-ii9DM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:11 INFO - Running setup.py (path:/tmp/pip-OMTlLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:11 INFO - Running setup.py (path:/tmp/pip-msVF55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:11 INFO - Running setup.py (path:/tmp/pip-4o2wUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:11 INFO - Running setup.py (path:/tmp/pip-5XeaHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:11 INFO - Running setup.py (path:/tmp/pip-JrDH8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:11 INFO - Running setup.py (path:/tmp/pip-ATkMKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:11 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)) 04:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:11 INFO - Running setup.py (path:/tmp/pip-1pMI84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:12 INFO - Running setup.py (path:/tmp/pip-1vgIrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:12 INFO - Running setup.py (path:/tmp/pip-OVrg99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:12 INFO - Running setup.py (path:/tmp/pip-l3msjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:12 INFO - Running setup.py (path:/tmp/pip-KIoKRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:12 INFO - Running setup.py (path:/tmp/pip-bZ1UAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:12 INFO - Running setup.py (path:/tmp/pip-GUzC99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:12 INFO - Running setup.py (path:/tmp/pip-C_KrQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:12 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)) 04:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:12 INFO - Running setup.py (path:/tmp/pip-UG3f3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:12 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)) 04:17:12 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:12 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:12 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)) 04:17:12 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:12 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:12 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 04:17:12 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 04:17:12 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 04:17:12 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 04:17:12 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 04:17:12 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 04:17:14 INFO - Downloading blessings-1.5.1.tar.gz 04:17:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:14 INFO - Installing collected packages: blessings 04:17:14 INFO - Running setup.py install for blessings 04:17:14 INFO - Successfully installed blessings 04:17:14 INFO - Cleaning up... 04:17:14 INFO - Return code: 0 04:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:14 INFO - Reading from file tmpfile_stdout 04:17:14 INFO - Current package versions: 04:17:14 INFO - argparse == 1.2.1 04:17:14 INFO - blessings == 1.5.1 04:17:14 INFO - blobuploader == 1.2.4 04:17:14 INFO - docopt == 0.6.1 04:17:14 INFO - manifestparser == 1.1 04:17:14 INFO - mozInstall == 1.12 04:17:14 INFO - mozcrash == 0.16 04:17:14 INFO - mozdebug == 0.1 04:17:14 INFO - mozdevice == 0.47 04:17:14 INFO - mozfile == 1.2 04:17:14 INFO - mozhttpd == 0.7 04:17:14 INFO - mozinfo == 0.9 04:17:14 INFO - mozleak == 0.1 04:17:14 INFO - mozlog == 3.1 04:17:14 INFO - moznetwork == 0.27 04:17:14 INFO - mozprocess == 0.22 04:17:14 INFO - mozprofile == 0.27 04:17:14 INFO - mozrunner == 6.11 04:17:14 INFO - mozscreenshot == 0.1 04:17:14 INFO - mozsystemmonitor == 0.0 04:17:14 INFO - moztest == 0.7 04:17:14 INFO - mozversion == 1.4 04:17:14 INFO - psutil == 3.1.1 04:17:14 INFO - requests == 1.2.3 04:17:14 INFO - wsgiref == 0.1.2 04:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:17:14 INFO - Using env: {'DISPLAY': ':0', 04:17:14 INFO - 'HOME': '/home/cltbld', 04:17:14 INFO - 'LANG': 'en_US.UTF-8', 04:17:14 INFO - 'LANGUAGE': 'en_US:en', 04:17:14 INFO - 'LOGNAME': 'cltbld', 04:17:14 INFO - 'MAIL': '/var/mail/cltbld', 04:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:14 INFO - 'MOZ_NO_REMOTE': '1', 04:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:14 INFO - 'NO_EM_RESTART': '1', 04:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:14 INFO - 'PWD': '/builds/slave/test', 04:17:14 INFO - 'SHELL': '/bin/bash', 04:17:14 INFO - 'SHLVL': '1', 04:17:14 INFO - 'TERM': 'linux', 04:17:14 INFO - 'TMOUT': '86400', 04:17:14 INFO - 'USER': 'cltbld', 04:17:14 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:14 INFO - '_': '/tools/buildbot/bin/python'} 04:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:14 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 1)) 04:17:14 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 2)) 04:17:14 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 3)) 04:17:14 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 4)) 04:17:14 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 5)) 04:17:14 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 6)) 04:17:14 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 7)) 04:17:14 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 8)) 04:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:14 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 3)) 04:17:14 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:14 INFO - Cleaning up... 04:17:14 INFO - Return code: 0 04:17:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:17:14 INFO - Using env: {'DISPLAY': ':0', 04:17:14 INFO - 'HOME': '/home/cltbld', 04:17:14 INFO - 'LANG': 'en_US.UTF-8', 04:17:14 INFO - 'LANGUAGE': 'en_US:en', 04:17:14 INFO - 'LOGNAME': 'cltbld', 04:17:14 INFO - 'MAIL': '/var/mail/cltbld', 04:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:14 INFO - 'MOZ_NO_REMOTE': '1', 04:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:14 INFO - 'NO_EM_RESTART': '1', 04:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:14 INFO - 'PWD': '/builds/slave/test', 04:17:14 INFO - 'SHELL': '/bin/bash', 04:17:14 INFO - 'SHLVL': '1', 04:17:14 INFO - 'TERM': 'linux', 04:17:14 INFO - 'TMOUT': '86400', 04:17:14 INFO - 'USER': 'cltbld', 04:17:14 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:14 INFO - '_': '/tools/buildbot/bin/python'} 04:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:15 INFO - Downloading/unpacking jsonschema 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:17:16 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:17 INFO - warning: no files found matching '*.txt' 04:17:17 INFO - no previously-included directories found matching 'build' 04:17:17 INFO - no previously-included directories found matching 'dist' 04:17:17 INFO - no previously-included directories found matching '.git*' 04:17:17 INFO - Installing collected packages: jsonschema, functools32 04:17:17 INFO - Running setup.py install for functools32 04:17:17 INFO - warning: no files found matching '*.txt' 04:17:17 INFO - no previously-included directories found matching 'build' 04:17:17 INFO - no previously-included directories found matching 'dist' 04:17:17 INFO - no previously-included directories found matching '.git*' 04:17:17 INFO - Successfully installed jsonschema functools32 04:17:17 INFO - Cleaning up... 04:17:17 INFO - Return code: 0 04:17:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3d13e78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda0240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', '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 04:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:17:17 INFO - Using env: {'DISPLAY': ':0', 04:17:17 INFO - 'HOME': '/home/cltbld', 04:17:17 INFO - 'LANG': 'en_US.UTF-8', 04:17:17 INFO - 'LANGUAGE': 'en_US:en', 04:17:17 INFO - 'LOGNAME': 'cltbld', 04:17:17 INFO - 'MAIL': '/var/mail/cltbld', 04:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:17 INFO - 'MOZ_NO_REMOTE': '1', 04:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:17 INFO - 'NO_EM_RESTART': '1', 04:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:17 INFO - 'PWD': '/builds/slave/test', 04:17:17 INFO - 'SHELL': '/bin/bash', 04:17:17 INFO - 'SHLVL': '1', 04:17:17 INFO - 'TERM': 'linux', 04:17:17 INFO - 'TMOUT': '86400', 04:17:17 INFO - 'USER': 'cltbld', 04:17:17 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:17 INFO - '_': '/tools/buildbot/bin/python'} 04:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:17 INFO - Downloading/unpacking flake8 04:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:17:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:17:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:17:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:19 INFO - no previously-included directories found matching 'docs/_build' 04:17:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:19 INFO - Running setup.py install for pep8 04:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:19 INFO - no previously-included directories found matching 'docs/_build' 04:17:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:20 INFO - Cleaning up... 04:17:20 INFO - Return code: 0 04:17:20 INFO - Running post-action listener: _resource_record_post_action 04:17:20 INFO - Running post-action listener: _start_resource_monitoring 04:17:20 INFO - Starting resource monitoring. 04:17:20 INFO - ##### 04:17:20 INFO - ##### Running install step. 04:17:20 INFO - ##### 04:17:20 INFO - Running pre-action listener: _resource_record_pre_action 04:17:20 INFO - Running main action method: install 04:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:20 INFO - Reading from file tmpfile_stdout 04:17:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:20 INFO - Reading from file tmpfile_stdout 04:17:20 INFO - Output received: 04:17:20 INFO - Usage: mozinstall [options] installer 04:17:20 INFO - Options: 04:17:20 INFO - -h, --help show this help message and exit 04:17:20 INFO - -d DEST, --destination=DEST 04:17:20 INFO - Directory to install application into. [default: 04:17:20 INFO - "/builds/slave/test"] 04:17:20 INFO - --app=APP Application being installed. [default: firefox] 04:17:20 INFO - mkdir: /builds/slave/test/build/application 04:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:17:34 INFO - Reading from file tmpfile_stdout 04:17:34 INFO - Output received: 04:17:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:34 INFO - Running post-action listener: _resource_record_post_action 04:17:34 INFO - ##### 04:17:34 INFO - ##### Running run-tests step. 04:17:34 INFO - ##### 04:17:34 INFO - Running pre-action listener: _resource_record_pre_action 04:17:34 INFO - Running main action method: run_tests 04:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:34 INFO - Python 2.7.3 04:17:34 INFO - Return code: 0 04:17:34 INFO - grabbing minidump binary from tooltool 04:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2f0b0>, '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 0xe2ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe30440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:34 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 04:17:34 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 04:17:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:34 INFO - Return code: 0 04:17:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:35 INFO - Return code: 0 04:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 04:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 04:17:35 INFO - Using env: {'DISPLAY': ':0', 04:17:35 INFO - 'HOME': '/home/cltbld', 04:17:35 INFO - 'LANG': 'en_US.UTF-8', 04:17:35 INFO - 'LANGUAGE': 'en_US:en', 04:17:35 INFO - 'LOGNAME': 'cltbld', 04:17:35 INFO - 'MAIL': '/var/mail/cltbld', 04:17:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:35 INFO - 'MOZ_NO_REMOTE': '1', 04:17:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:35 INFO - 'NO_EM_RESTART': '1', 04:17:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:35 INFO - 'PWD': '/builds/slave/test', 04:17:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:35 INFO - 'SHELL': '/bin/bash', 04:17:35 INFO - 'SHLVL': '1', 04:17:35 INFO - 'TERM': 'linux', 04:17:35 INFO - 'TMOUT': '86400', 04:17:35 INFO - 'USER': 'cltbld', 04:17:35 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789', 04:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:35 INFO - '_': '/tools/buildbot/bin/python'} 04:17:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 04:17:36 INFO - mozversion INFO | application_buildid: 20151204030722 04:17:36 INFO - mozversion INFO | application_changeset: e02b17a2b5b8df7bb84f325fc08eedd2f3cab755 04:17:36 INFO - mozversion INFO | application_display_name: Nightly 04:17:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:36 INFO - mozversion INFO | application_name: Firefox 04:17:36 INFO - mozversion INFO | application_remotingname: firefox 04:17:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:17:36 INFO - mozversion INFO | application_vendor: Mozilla 04:17:36 INFO - mozversion INFO | application_version: 45.0a1 04:17:36 INFO - mozversion INFO | platform_buildid: 20151204030722 04:17:36 INFO - mozversion INFO | platform_changeset: e02b17a2b5b8df7bb84f325fc08eedd2f3cab755 04:17:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:17:36 INFO - mozversion INFO | platform_version: 45.0a1 04:17:36 INFO - 2015-12-04 04:17:36,127 DEBUG : using testdate: 1449231456 04:17:36 INFO - 2015-12-04 04:17:36,127 DEBUG : actual date: 1449231456 04:17:36 INFO - 2015-12-04 04:17:36,135 INFO : starting webserver on 'localhost:51521' 04:17:36 INFO - 2015-12-04 04:17:36,136 INFO : Starting test suite talos-linux64-ix-019 04:17:36 INFO - 2015-12-04 04:17:36,136 INFO : Starting test dromaeo_css 04:17:36 INFO - 2015-12-04 04:17:36,136 DEBUG : operating with platform_type : linux_ 04:17:36 INFO - 2015-12-04 04:17:36,137 INFO : Initialising browser for dromaeo_css test... 04:17:36 INFO - 2015-12-04 04:17:36,151 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRzNWW/profile http://localhost:51521/getInfo.html 04:17:40 INFO - 2015-12-04 04:17:40,636 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:17:40 INFO - 2015-12-04 04:17:40,636 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:17:40 INFO - 2015-12-04 04:17:40,636 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:17:40 INFO - 2015-12-04 04:17:40,636 DEBUG : BROWSER_OUTPUT: __metrics 04:17:40 INFO - 2015-12-04 04:17:40,879 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:17:40 INFO - 2015-12-04 04:17:40,940 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:41 INFO - 2015-12-04 04:17:41,971 INFO : Browser initialized. 04:17:41 INFO - 2015-12-04 04:17:41,972 INFO : Running cycle 1/1 for dromaeo_css test... 04:17:41 INFO - 2015-12-04 04:17:41,972 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRzNWW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:17:54 INFO - 2015-12-04 04:17:54,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 143114240 04:17:54 INFO - 2015-12-04 04:17:54,061 DEBUG : BROWSER_OUTPUT: 04:18:44 INFO - 2015-12-04 04:18:44,848 DEBUG : BROWSER_OUTPUT: 1449231524847 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] 04:20:58 INFO - 2015-12-04 04:20:58,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51521/tests/dromaeo/cssquery-ext.html) 04:20:59 INFO - 2015-12-04 04:20:59,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 245329920 04:20:59 INFO - 2015-12-04 04:20:59,333 DEBUG : BROWSER_OUTPUT: 04:24:01 INFO - 2015-12-04 04:24:01,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-ext.html (next: http://localhost:51521/tests/dromaeo/cssquery-jquery.html) 04:24:02 INFO - 2015-12-04 04:24:02,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 219246592 04:24:02 INFO - 2015-12-04 04:24:02,424 DEBUG : BROWSER_OUTPUT: 04:27:04 INFO - 2015-12-04 04:27:04,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51521/tests/dromaeo/cssquery-mootools.html) 04:27:05 INFO - 2015-12-04 04:27:05,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 216875008 04:27:05 INFO - 2015-12-04 04:27:05,114 DEBUG : BROWSER_OUTPUT: 04:30:07 INFO - 2015-12-04 04:30:07,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51521/tests/dromaeo/cssquery-prototype.html) 04:30:07 INFO - 2015-12-04 04:30:07,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 202551296 04:30:07 INFO - 2015-12-04 04:30:07,680 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-04 04:33:10,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51521/tests/dromaeo/cssquery-yui.html) 04:33:10 INFO - 2015-12-04 04:33:10,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 206286848 04:33:10 INFO - 2015-12-04 04:33:10,907 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-yui.html (next: http://localhost:51521/tests/dromaeo/cssquery-dojo.html) 04:36:13 INFO - 2015-12-04 04:36:13,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 226582528 04:36:13 INFO - 2015-12-04 04:36:13,840 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,840 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:36:13 INFO - 2015-12-04 04:36:13,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:36:13 INFO - 2015-12-04 04:36:13,841 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:36:13 INFO - 2015-12-04 04:36:13,841 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:36:13 INFO - 2015-12-04 04:36:13,841 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2654.548726716458;2728.4133911209087;2731.7951153663466;2739.3973325868315;2758.1174024312218;4612.423447069116;4738.786754596043;4767.523247675235;4794.976025119874;4814.205656066749;4685.4377474703;4694.061187762444;4755;4756.453007904092;4804.087223427547;4346.282863327548;4373.387725718386;4378.737275763448;4387.495438024636;4408.42690450241;4224.514180869209;4424.623906967911;4456.777161141946;4487.304467807495;4504.346869703891;4288.571142885718;4289.227938970984;4299.527052024306;4390.978045109786;4395.516493185747;4391.429114215131;4421.823127074913;4423.270160423526;4424.292113261895;4459.44256967879;4358.847440339605;4376.5623437656295;4387.42963414754;4444.288913773813;4461.933071003938;4441.289393696993;4554.658400619934;4564.8174073037035;4602.585767280927;4703.412073490814;5127.435982041972;5144.665596736238;5152.510511501401;5152.690838549699;5156.381234251914;5162.819301324435;5172.431032586413;5177.637565370425;5190.455002224788;5235.214717792362;4515;4621.953780462152;4622.607078398374;4657.836975705834;4758.904821903542;5247.475252474722;5294.788208471695;5296.232046353257;5303.761330740126;5354.170103633943;5060.089183946851;5064.366954130734;5066.847994560169;5070.61970352225;5114.028334616411;4853.344798452164;4968.478309777422;4973.452920178777;5158.329417175818;5172.612054095958;4971.502849715;5064.924026139611;5067.113255180402;5104.566111880532;5112.616553758483;5044.4198917125;5093.2105523643895;5094.363204599425;5097.566706829887;5141.408737995179;4041.07055377259;4223.408722778813;4274.10243848789;4277.508086570022;4318.913621727548;3650.105724097613;3689.317476266899;3718.7025037996896;3720.08857829828;3752.887413377603;4391.956080439219;4446.155230506193;4447.86656400302;4450.777461126931;4458.5318541553315;4841.3222148899185;5166.276721259027;5181.844544663666;5183.559397451183;5187.403448603383;4303.483581970184;4315;4332.588404101605;4382.8466003690355;4421.7346959181905;4493.865184044484;4575.633949284049;4583.564561366665;4589.701669391479;4615.815367385267;4663.067386522641;4941.036497882878;4942.654014218971;4945.010997800454;4961.5286547777905;5044.596432285482;5054.747262636927;5067.239914012927;5106.897862042664;5174.482551744795;4890.364252647133;4937.111319962298;4938.777755001105;4942.357493525818;4983.377077865267;4804.927926081042;5086.821961231339;5088.7201203932655;5103.591712662904;5111.821086261963;4996.025774973845;5015.699058056528;5075.137226671401;5210.218467229945;5210.97394513025;4982.427020892644;4989.775460104232;4991.176455884738;4994.80020799164;5034.0938631046765;4650.558196971282;4983.25251212321;4988.825391111293;4994.350734404649;4995.17579599362;4705.717656940595;4753.263244197155;4771.594414474808;4810.134175848241;4831.903361932671;4985.401751789808;5031.496850314939;5048.091343558195;5056.721880296619;5057.064443078042;4635.51327110662;4926.950730492649;4928.112939670894;4929.2359684248995;4946.530079642428 04:36:13 INFO - 2015-12-04 04:36:13,842 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.1816139791325;575.0597772641731;576.3573615418809;583.4661284924294;598.0311894730537;28104.718952810465;28715.569266460992;28718.138455846332;36920.26159476809;37750.24499510008;40412.79793601035;40795.12446317603;40913.795431022874;41056.17887642253;41140.38289425654;7895.0920644125945;8064.112947575762;8073.475224110443;8078.596070196496;8080.070791858923;7166.64166791661;7353.852922941538;10209.336393134423;10485.370877747322;10496.947515262413;10050.89949100507;10200.540975656113;10201.540930658139;10203.744906377362;10213.642522511713;7183.42532597391;7373.594452305121;9960.452175130366;10008.149307308851;10075.294729368947;7094.929050709478;10185.134263587604;10512.842307365396;10521.579136834518;10523.94738026305;37210.44184337237;37663.4350484743;37683.434748478794;37703;37725.811370943244;2598.350412396901;2744.0944488318805;2826.4771017361854;3027.7275045246033;3124.937779990045;27095.729042709518;27645.308867278276;27959.440811183867;28024.959977795665;28287.575686364722;3336.115929278743;3388.678075582816;3461.671141241578;3496.7202623790035;3503.4919936609303;214768;215011;217000.91499542558;217013;217424;46703.766481167375;47645.28532072021;54230.728846355516;54771.726141369836;54802.72598637061;63445;64447.67776161089;64963.35036649668;64993.35006649873;65032.34967650263;13887.236202008784;14094.859051409354;14146.646333841736;14186.787198192036;14188.503402380868;10340.896591034143;10374.17006639467;10382.844257336146;10385.84421233682;10393.688189354332;18608.627827443375;18816;18831.435056948314;18843.152058157415;18880.24479020824;6961.756338528127;7203.38771204443;7211.423086153095;7222.927770722225;7320.487565870444;896.3680605173337;928.5542939389131;952.2715122930963;1043.1811028342715;1052.6684094510206;26428.8678556606;26822.463550728877;26881.596776047983;27108.32229194286;27171.592426113624;957.5164541906432;970.7379007668031;983.0415345038673;1004.5830980143159;1063.3566692151292;13803.516876909462;13899.583012509642;13959.79060314096;14057;14303.856961430462;260118;261625;262045;262864;263458;46008;46236.7688161557;46397.536024639994;46409.5359046412;46452;1179.775842589905;1202.2005366431226;1207.849018872641;1209.473878862715;1219.1283232488813;25209.621855672547;26297.21108366752;26619.41307459804;26885.327866802705;26920.461590768467;40445.191096177325;40754.79622601868;40762;40784.388234175916;40817.1836563273;240922;242556;243110;243529;243636;24767;25238;28763.28091797722;29156.562651560667;30445;35190.824045879606;35962.64037359593;38852;39064.2187156261;39341.60658393494;32359.51460728138;32683;33244.1688957778;33309.16727081843;33852;27041.78311976005;30158;30742.385152297276;31127.53308700326;31247.168919086904;33097.669023310424;33188.50217246695;33604.83197583997;33796.831015844764;33909.152271193416;28382.290442739097;30010.399792004475;30055.782116938753;30446;30656.693433065382;30373.24066898257;32517.349653006335;32581.837090814395;32603.673963260062;33611.327773444886 04:36:13 INFO - 2015-12-04 04:36:13,843 DEBUG : BROWSER_OUTPUT: |2;jquery.html;321.1809884793775;325.48248285226487;325.9478483442648;327.7034283973004;328.87667124828187;12456.31490268035;12772.169808962411;15000.924995375022;15450.536483905487;15580.688386232268;12369.938150309235;14095.78856317156;14275.643108922282;14275.928620356884;15055.77416338753;5017.096922553938;5032.874178145539;5039.899202015958;5058.721770302632;5167.612429067835;3606.4049431843846;3714.4242642390473;5063;5104.6937183768905;5615.4665306796;5803.506701930341;5819.214406055171;5837.941620583782;5893.941060589382;5912.142739302799;5601.187827764971;5667.404922483162;5672.829815105553;5674.262345895048;5776.018076926933;4897.33885925399;4906.9263961040615;4923.8276660316715;4961.677490963076;5012.598992080625;19168.424947251606;19202;19497;19660.311889083812;19680.212791488324;1748.1870930017603;1794.9551261218444;1814.3468351393487;1895.4503194073702;1914.8468122550162;12456;12658;12846.935765321206;12917.547885824046;13042.478300868048;1594.5296137639425;1611.9355225790955;1656.1470842516114;1659.7842280503578;1748.9562760931078;52134.739326303505;54062.72968635132;54285.45714542844;54573.454265457236;54602.453975460136;8898;8993;9301.767455813659;9303.255739540957;9322.1610055094;11685.707857303465;11701.824472632918;11708.473118709679;11719.238249513754;11726;6994.090768200102;7239.9276007240305;7260.2739726026975;7276.6725497352745;7417.666205020787;6773.593584384854;7044.330788575077;7113.972517832393;7149.749758758522;7175.712971481186;5742.196092547047;5745.770169193185;5755.280589926259;5760.855978600569;5786.3056433228285;1531.8544738249848;1531.9387224510895;1584.3187429405236;1587.563420059493;1620.2222932992229;896.6951236579595;902.8826252587253;912.4069354919355;958.5734348214977;1028.8353863381824;15074.472393466176;16133.274002669908;16135.677286454205;16309.102999335151;16750.329986800636;782.6282515804947;791.1297572670017;820.8235229425702;825.405707890318;870.0820634230947;8407.70573029941;8864.290856731575;9074.183323500916;9084.545772711337;9166.22087122602;438348;440391;444171;444310;454588;68876;69066;69617.17105559142;69634;70581.64709176421;1068.0707784227773;1087.7770057138268;1096.353151640536;1102.32207192576;1119.6361182615683;13873.722525549634;13878.236696981763;13948.58154255374;14167;14236.145831250158;31724.682753172172;31754.72981080731;32122.67877321197;32660.836695816368;33380.83309583534;42302.576974229865;42923;43585.782071089445;44442;44738.776306119566;8889.866652000095;8997.775055623662;9276.840394950632;9281.582328795355;9289.581968811555;16027.358905643643;16262.756058658893;16379.181040948144;16463.753043704113;16675.583110422336;13678.247696376397;13700.93149534246;13729.382177801823;13901.23543205093;14047.438102475786;11940.940295298467;12301.507939682313;13636.181829090287;13742.312884355542;13873.306334683428;10058.417578244145;11634.825477618011;13318.267495287851;13951.441942322599;14148.717025659635;8372.7906802328;8649.8702519461;8666.566671666518;8698.695545655872;8745.956270218609;9040.367174297999;9116;12682.87317126817;13080.672983175116;13396.26320552379 04:36:13 INFO - 2015-12-04 04:36:13,845 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1452.8765054970327;1676.79040119985;1731.4719010701738;1742.059287984489;1755.9122043897803;5971.193888825007;6209.503239740821;7228;7455;7456.5898875561825;7317.59753213573;7343.485955983083;7426.071741032371;7428.405727541797;7434.479586428939;1705.4201571465699;1776.094191962102;2030.7055476955832;2069.689546568012;2072.575122099966;1760.489458057162;2053.1992522916075;2104.8737075775425;2106.115431518766;2106.6208082545136;2045.7442819647545;2060.5878824235137;2062.61841559312;2067.1111422088497;2093.665013597825;2046.3553980496097;2073.8029887160696;2077.5948690005457;2078.6674132138937;2080.334293026232;2045.7033730109051;2080.6046851098245;2081.739782527184;2081.7918208179212;2085.270155445597;7234.168070671887;7296.306850849161;7299.379552738023;7305.525140865827;7313.670884810196;4203.3064544350145;4290.163418133465;4313.590208930146;4314.633256173229;4327.221100201962;2601.8308809927485;2602.648642433266;2640.4983053219826;2648.562987107125;2655.9734402655918;795.6618437164182;824.468217999387;834.1200033964166;848.3043903998723;858.9312854971587;10029.247806414474;10032.147267482273;10050.346727462691;10056.296059275854;10068.798624027551;3855.479510266134;3930.5283365996265;3969.940450893239;3982.542007669097;3987.1029018470613;8540.231379175904;8545;8545.444546104483;8545.914540854636;8548.914510854936;4240.109576988867;4259.233337999128;4261.488621365456;4266.765327906933;4271.039016221325;3855.4024126260474;3875.7286989911;3877.592852750477;3879.8254078566533;3882.611738826095;3010.473167195732;3057.3579548295106;3381.1378098584705;3475.0269924421204;3486.9476957845654;1072.4423299884018;1094.63876920616;1102.3441052573705;1106.634810512529;1118.2004866520315;929.0570071377557;930.4835816122118;969.2149359019216;984.7538115471132;1225.8896699297106;6917.9308206918295;6965.930340696629;6983.441324694012;6993.685284162225;6998.650067496605;1037.7353774787382;1043.8642976413018;1044.2637940252255;1054.4411461925192;1069.9296860574814;5199.610029247821;5220.791168353299;5237.450067742909;5242.7640756166065;5247.606429517801;8566.657333706706;8682.91317086821;8723.738287851374;8771.342149338825;8808.339374546806;8763.255123314462;8770.693025744069;8776.078511756301;8792.42849214799;8796.07641197665;6797.626130562867;6883.070785444002;6909.27452617478;6917.861642767117;6920.30796920304;6609.504287178577;6609.801705948829;6636.037774522763;6637.535372523877;6646.83382915431;7653.081630204411;7785.727499537489;7824.4131690124605;7830.804229894298;7901.920980790119;7873.212678732081;7982.361411086983;8003.3597312213715;8119.5534245617055;8124.715634952749;5809;6334.208223972004;6337.732453509225;6360.236771587439;6364.363563643598;5859.824205273849;6072.757089716361;6644.634545100066;6854.383105520527;6907.20567134786;6354.1104245406605;6585.835354116185;6597.472202223907;6684.832879177865;6710.664466776544;6445.129907462432;6508.576942498722;6522.086907833002;6531.216254049545;6585.868282634417;5700.401457846866;5857.560682948711;5863.73613187399;5868.94131058684;5875.059990401515;5821.243238379153;5841.299044114563;5852.648841069549;5856.267966504187;5861.35525092248;5803.680797556175;5855.180274761452;5876.911846322223;5913.026221130743;5964.731587078505 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: |4;prototype.html;268.31044216363944;271.9986400068001;274.04085700049825;281.6816996793623;285.0919820372116;5350.063738845701;5377.973110134449;5380.838574842751;5418.539424148952;5439.048166570844;5317.521423071923;5340.759665815038;5344.572434205264;5351.197320401941;5352.625316227865;3856.826442810066;3946.4474973503734;3953.169834334793;4060.127072679373;4120.381942708587;4101.938470922939;4102.610252026067;4112.2803509385885;4115.979420102895;4120.732152410099;3821.2739579479808;3945.2306800173833;4074.7555146691293;4078.163976384849;4084.101497670508;3941.1723538057045;3997.080671445555;4002.2195671844;4050.10897602527;4053.1893621275863;3516.6307537708685;3523.4186359250693;3530.841112149934;3538.982305088484;3544.8227588620466;5174.767135478913;5180.274761533388;5182.533571978503;5182.766775495074;5194.506521880416;4586.472555656109;4648.279516674921;4676.158291507527;4679.836205732817;4682.063587282557;5627.493525582717;5632.5212356949705;5645.294338207724;5645.379008309083;5648.661080335193;3886.6696330811915;3898.7465814721954;3903.6877049835944;3904.5900180480926;3904.824282907276;5915.881682366328;5927.7925272615685;5936.762529498815;5941;5941.287045554518;3864.1112544115012;3960.643542081169;4014.8996275093355;4020.6783457323345;4021.4973128358956;3949.980250098731;3950.525936887592;3957.782321972262;3961.465202197724;3972.0268534209304;4595.310703394518;4613.838515651936;4616.538346165356;4617.7691115444095;4622.86131416058;5614.606977511535;5615.185798059259;5621.353544342372;5652.095664693711;5667.404922483162;1389.3608939887765;1437.6621493948915;1439.7408466476136;1440.2150827798876;1440.2942558146433;925.4586067150792;938.9248860091176;955.1356022799378;957.2533423929347;959.7072892767773;4982.402111746541;4982.950170498321;4983.426905905795;4985.476524964826;4987.975060124676;5871.266091738533;5874;5880;5882.470577648032;5884.47039766423;4972.751362431936;4977.8257760978195;4978.352814134212;4982.551570358685;4983.227599721977;3052.496338104188;3089.9536506952413;3137.811731296084;3199.9840000800314;3202.327511222623;5619.044762390404;5634.295713035871;5640.746166422521;5642.181883626851;5649.350324712711;6087.908681369783;6094.146819445281;6100.206973093558;6105.900937831233;6108.3280839107665;5475.06923822951;5586.273784408001;5626.971865140648;5642.125470552071;5647.745851436695;5912.260967379078;5918.319393269657;5926.288845338587;5926.288845338587;5931.525477961666;5784.595078344475;5787.2187254720075;5789.884202316014;5795.275590551181;5800.042992906123;5461.235427040138;5614.494695477263;5616.550675945833;5618.831435056954;5621.044422448275;3899.3371126907928;3945.9408108878965;3946.703997200164;3950.980245098871;3952.189801090827;5919.733611987557;5922.881542369215;5925.229720136354;5931;5941.900748361567;5715.057015592547;5726.828195154152;5727.971360143172;5735.139729040678;5735.799247026334;5572.442755724395;5694.202811606461;5706.172604972173;5709.51469125129;5713.085906254979;5573.944260557342;5576.247206627054;5576.665400076008;5578.246936663499;5580.637258578179;5737.196792448977;5750.856228594319;5753.827385178452;5754.6547207167705;5761.452661997104;5422.728863556886;5559.72201389937;5564.054110801255;5575.303087114111;5593.825296687741 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: |5;yui.html;678.7386856060417;688.7795905310303;714.4748609771821;728.1626129950556;788.7909703928458;11910.82133767993;12014.339211343373;12028.218165819215;12076.275423474575;12088.274703517794;11201.495932683029;11338.319700817936;11342.376169310684;11367.772644547103;12974.805377919316;638.5721566550422;643.8197304754676;647.9838004049913;804.7304153108686;808.4946908182401;812.6911773526052;814.6130587970696;819.3731795176694;820.831729495455;821.5235163605124;664.2129077043719;675.199888132562;836.431226765799;840.7351684219451;840.865461526156;837.3008537870885;851.4210336970857;853.4623187391966;854.1373213054859;854.2866706300247;634.0805831544279;634.403660559073;634.578005626258;634.7905191286865;635.240887139868;11950;12097.39513024354;12097.576584819577;12101.636950891487;12103.39483025854;10858.891411085946;11324.660260192208;11459.312441253469;11511.827322590168;11581.826272605833;9390.48352340621;9503.762405939839;9512.619495220182;9521.23830093591;9546.949835518088;3226.677332266778;3243.96756032439;3274.4106060909025;3284.080457471912;3326.101952472843;40673.38989915154;40924.79537602323;41462.79268603668;41499.7925010373;41580.58419415797;8632.266257368194;8868.78186800392;8879.822403551892;9227.400218985878;9306.581203845843;16166.191690415431;16194.838051619568;16239.918800405922;16254.837451625332;16257;6215.782447614311;6405.839854003687;6424.582402143846;6534.313897040837;6647.966760166265;3503.1767534629344;3530;3641.214862425386;3665.3585622515952;3676.9080772980888;2742.4515096980285;2764.433291175304;2771;2774.250952242883;2776.7778577713734;474.23647926837765;481.82895072248846;482.9323894654751;486.4357345479227;486.5766782898901;495.982640607577;514.3724655919772;544.8474427160402;580.9738561764731;600.0159738029635;7135.179454362815;7275.163356214103;7322.1945585985495;7471.215522370181;7549.50928189666;437.2108344438319;478.12741746313117;544.6214880657984;570.934342550612;593.0955293177852;3202.1994501374656;3222.356598134968;3407.1993081625797;3963.9801800991386;4075.735077219971;47626.04747905023;48776.75611621919;48796.7560162204;48808.26787598189;48809.267860982116;43906.780466097465;44204.11591768211;44697.77651111789;45015.32477012847;45107.32339014918;38941.61058389436;39311.41032884509;39329.80335098363;40342;40419.39370909439;7434.814129646586;7639.503432276884;7844.438611002386;7986.680532778624;8002.959985200269;30909.8454507735;31154.532682009336;31334.529982049833;31475.055748327588;31624.209394765316;36647;37264.25471490501;38535.03662408462;39458.60541394664;39766.40350394689;9668.274879383933;9814.165795907142;9865.704028879145;10142;10147.137493313152;11514.596989105676;11678.379702292317;11732;11755.588554400554;11806.822897656713;10814.729631759268;10897.455127243764;10941.781164376827;11075.501602427748;11395.886041139482;9748.658796942073;9833.704988850346;10271.94864025675;10525.89474105249;10526.368417894644;9454.842062856611;9487.288453366164;9493.087557603796;9507.572159252712;9852.906145783809;8882.880473806385;9309.394889332172;9349.57926893305;9374.906250937403;9818.901810982084;8628.52543110135;9161.954190229273;9208.677696280598;9368.156865882103;9560.187384072153 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,890 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: __startTimestamp1449232573838__endTimestamp 04:36:13 INFO - 2015-12-04 04:36:13,846 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,847 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:36:13 INFO - 2015-12-04 04:36:13,847 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:36:13 INFO - 2015-12-04 04:36:13,847 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,847 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4707.28 Median:4814.21 stddev:503.16 (10.5%) stddev-sans-first:478.24 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: Values: 2654.5 2728.4 2731.8 2739.4 2758.1 4612.4 4738.8 4767.5 4795.0 4814.2 4685.4 4694.1 4755.0 4756.5 4804.1 4346.3 4373.4 4378.7 4387.5 4408.4 4224.5 4424.6 4456.8 4487.3 4504.3 4288.6 4289.2 4299.5 4391.0 4395.5 4391.4 4421.8 4423.3 4424.3 4459.4 4358.8 4376.6 4387.4 4444.3 4461.9 4441.3 4554.7 4564.8 4602.6 4703.4 5127.4 5144.7 5152.5 5152.7 5156.4 5162.8 5172.4 5177.6 5190.5 5235.2 4515.0 4622.0 4622.6 4657.8 4758.9 5247.5 5294.8 5296.2 5303.8 5354.2 5060.1 5064.4 5066.8 5070.6 5114.0 4853.3 4968.5 4973.5 5158.3 5172.6 4971.5 5064.9 5067.1 5104.6 5112.6 5044.4 5093.2 5094.4 5097.6 5141.4 4041.1 4223.4 4274.1 4277.5 4318.9 3650.1 3689.3 3718.7 3720.1 3752.9 4392.0 4446.2 4447.9 4450.8 4458.5 4841.3 5166.3 5181.8 5183.6 5187.4 4303.5 4315.0 4332.6 4382.8 4421.7 4493.9 4575.6 4583.6 4589.7 4615.8 4663.1 4941.0 4942.7 4945.0 4961.5 5044.6 5054.7 5067.2 5106.9 5174.5 4890.4 4937.1 4938.8 4942.4 4983.4 4804.9 5086.8 5088.7 5103.6 5111.8 4996.0 5015.7 5075.1 5210.2 5211.0 4982.4 4989.8 4991.2 4994.8 5034.1 4650.6 4983.3 4988.8 4994.4 4995.2 4705.7 4753.3 4771.6 4810.1 4831.9 4985.4 5031.5 5048.1 5056.7 5057.1 4635.5 4927.0 4928.1 4929.2 4946.5 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40573.46 Median:30445.50 stddev:62687.10 (205.9%) stddev-sans-first:62790.95 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: Values: 557.2 575.1 576.4 583.5 598.0 28104.7 28715.6 28718.1 36920.3 37750.2 40412.8 40795.1 40913.8 41056.2 41140.4 7895.1 8064.1 8073.5 8078.6 8080.1 7166.6 7353.9 10209.3 10485.4 10496.9 10050.9 10200.5 10201.5 10203.7 10213.6 7183.4 7373.6 9960.5 10008.1 10075.3 7094.9 10185.1 10512.8 10521.6 10523.9 37210.4 37663.4 37683.4 37703.0 37725.8 2598.4 2744.1 2826.5 3027.7 3124.9 27095.7 27645.3 27959.4 28025.0 28287.6 3336.1 3388.7 3461.7 3496.7 3503.5 214768.0 215011.0 217000.9 217013.0 217424.0 46703.8 47645.3 54230.7 54771.7 54802.7 63445.0 64447.7 64963.4 64993.4 65032.3 13887.2 14094.9 14146.6 14186.8 14188.5 10340.9 10374.2 10382.8 10385.8 10393.7 18608.6 18816.0 18831.4 18843.2 18880.2 6961.8 7203.4 7211.4 7222.9 7320.5 896.4 928.6 952.3 1043.2 1052.7 26428.9 26822.5 26881.6 27108.3 27171.6 957.5 970.7 983.0 1004.6 1063.4 13803.5 13899.6 13959.8 14057.0 14303.9 260118.0 261625.0 262045.0 262864.0 263458.0 46008.0 46236.8 46397.5 46409.5 46452.0 1179.8 1202.2 1207.8 1209.5 1219.1 25209.6 26297.2 26619.4 26885.3 26920.5 40445.2 40754.8 40762.0 40784.4 40817.2 240922.0 242556.0 243110.0 243529.0 243636.0 24767.0 25238.0 28763.3 29156.6 30445.0 35190.8 35962.6 38852.0 39064.2 39341.6 32359.5 32683.0 33244.2 33309.2 33852.0 27041.8 30158.0 30742.4 31127.5 31247.2 33097.7 33188.5 33604.8 33796.8 33909.2 28382.3 30010.4 30055.8 30446.0 30656.7 30373.2 32517.3 32581.8 32603.7 33611.3 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,848 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25103.70 Median:23008.50 stddev:72575.81 (315.4%) stddev-sans-first:72755.55 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: Values: 321.2 325.5 325.9 327.7 328.9 12456.3 12772.2 15000.9 15450.5 15580.7 12369.9 14095.8 14275.6 14275.9 15055.8 5017.1 5032.9 5039.9 5058.7 5167.6 3606.4 3714.4 5063.0 5104.7 5615.5 5803.5 5819.2 5837.9 5893.9 5912.1 5601.2 5667.4 5672.8 5674.3 5776.0 4897.3 4906.9 4923.8 4961.7 5012.6 19168.4 19202.0 19497.0 19660.3 19680.2 1748.2 1795.0 1814.3 1895.5 1914.8 12456.0 12658.0 12846.9 12917.5 13042.5 1594.5 1611.9 1656.1 1659.8 1749.0 52134.7 54062.7 54285.5 54573.5 54602.5 8898.0 8993.0 9301.8 9303.3 9322.2 11685.7 11701.8 11708.5 11719.2 11726.0 6994.1 7239.9 7260.3 7276.7 7417.7 6773.6 7044.3 7114.0 7149.7 7175.7 5742.2 5745.8 5755.3 5760.9 5786.3 1531.9 1531.9 1584.3 1587.6 1620.2 896.7 902.9 912.4 958.6 1028.8 15074.5 16133.3 16135.7 16309.1 16750.3 782.6 791.1 820.8 825.4 870.1 8407.7 8864.3 9074.2 9084.5 9166.2 438348.0 440391.0 444171.0 444310.0 454588.0 68876.0 69066.0 69617.2 69634.0 70581.6 1068.1 1087.8 1096.4 1102.3 1119.6 13873.7 13878.2 13948.6 14167.0 14236.1 31724.7 31754.7 32122.7 32660.8 33380.8 42302.6 42923.0 43585.8 44442.0 44738.8 8889.9 8997.8 9276.8 9281.6 9289.6 16027.4 16262.8 16379.2 16463.8 16675.6 13678.2 13700.9 13729.4 13901.2 14047.4 11940.9 12301.5 13636.2 13742.3 13873.3 10058.4 11634.8 13318.3 13951.4 14148.7 8372.8 8649.9 8666.6 8698.7 8746.0 9040.4 9116.0 12682.9 13080.7 13396.3 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5018.04 Median:5860.59 stddev:2644.44 (45.1%) stddev-sans-first:2638.28 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: Values: 1452.9 1676.8 1731.5 1742.1 1755.9 5971.2 6209.5 7228.0 7455.0 7456.6 7317.6 7343.5 7426.1 7428.4 7434.5 1705.4 1776.1 2030.7 2069.7 2072.6 1760.5 2053.2 2104.9 2106.1 2106.6 2045.7 2060.6 2062.6 2067.1 2093.7 2046.4 2073.8 2077.6 2078.7 2080.3 2045.7 2080.6 2081.7 2081.8 2085.3 7234.2 7296.3 7299.4 7305.5 7313.7 4203.3 4290.2 4313.6 4314.6 4327.2 2601.8 2602.6 2640.5 2648.6 2656.0 795.7 824.5 834.1 848.3 858.9 10029.2 10032.1 10050.3 10056.3 10068.8 3855.5 3930.5 3969.9 3982.5 3987.1 8540.2 8545.0 8545.4 8545.9 8548.9 4240.1 4259.2 4261.5 4266.8 4271.0 3855.4 3875.7 3877.6 3879.8 3882.6 3010.5 3057.4 3381.1 3475.0 3486.9 1072.4 1094.6 1102.3 1106.6 1118.2 929.1 930.5 969.2 984.8 1225.9 6917.9 6965.9 6983.4 6993.7 6998.7 1037.7 1043.9 1044.3 1054.4 1069.9 5199.6 5220.8 5237.5 5242.8 5247.6 8566.7 8682.9 8723.7 8771.3 8808.3 8763.3 8770.7 8776.1 8792.4 8796.1 6797.6 6883.1 6909.3 6917.9 6920.3 6609.5 6609.8 6636.0 6637.5 6646.8 7653.1 7785.7 7824.4 7830.8 7901.9 7873.2 7982.4 8003.4 8119.6 8124.7 5809.0 6334.2 6337.7 6360.2 6364.4 5859.8 6072.8 6644.6 6854.4 6907.2 6354.1 6585.8 6597.5 6684.8 6710.7 6445.1 6508.6 6522.1 6531.2 6585.9 5700.4 5857.6 5863.7 5868.9 5875.1 5821.2 5841.3 5852.6 5856.3 5861.4 5803.7 5855.2 5876.9 5913.0 5964.7 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4674.31 Median:5365.30 stddev:1413.01 (26.3%) stddev-sans-first:1377.73 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: Values: 268.3 272.0 274.0 281.7 285.1 5350.1 5378.0 5380.8 5418.5 5439.0 5317.5 5340.8 5344.6 5351.2 5352.6 3856.8 3946.4 3953.2 4060.1 4120.4 4101.9 4102.6 4112.3 4116.0 4120.7 3821.3 3945.2 4074.8 4078.2 4084.1 3941.2 3997.1 4002.2 4050.1 4053.2 3516.6 3523.4 3530.8 3539.0 3544.8 5174.8 5180.3 5182.5 5182.8 5194.5 4586.5 4648.3 4676.2 4679.8 4682.1 5627.5 5632.5 5645.3 5645.4 5648.7 3886.7 3898.7 3903.7 3904.6 3904.8 5915.9 5927.8 5936.8 5941.0 5941.3 3864.1 3960.6 4014.9 4020.7 4021.5 3950.0 3950.5 3957.8 3961.5 3972.0 4595.3 4613.8 4616.5 4617.8 4622.9 5614.6 5615.2 5621.4 5652.1 5667.4 1389.4 1437.7 1439.7 1440.2 1440.3 925.5 938.9 955.1 957.3 959.7 4982.4 4983.0 4983.4 4985.5 4988.0 5871.3 5874.0 5880.0 5882.5 5884.5 4972.8 4977.8 4978.4 4982.6 4983.2 3052.5 3090.0 3137.8 3200.0 3202.3 5619.0 5634.3 5640.7 5642.2 5649.4 6087.9 6094.1 6100.2 6105.9 6108.3 5475.1 5586.3 5627.0 5642.1 5647.7 5912.3 5918.3 5926.3 5926.3 5931.5 5784.6 5787.2 5789.9 5795.3 5800.0 5461.2 5614.5 5616.6 5618.8 5621.0 3899.3 3945.9 3946.7 3951.0 3952.2 5919.7 5922.9 5925.2 5931.0 5941.9 5715.1 5726.8 5728.0 5735.1 5735.8 5572.4 5694.2 5706.2 5709.5 5713.1 5573.9 5576.2 5576.7 5578.2 5580.6 5737.2 5750.9 5753.8 5754.7 5761.5 5422.7 5559.7 5564.1 5575.3 5593.8 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: 04:36:13 INFO - 2015-12-04 04:36:13,850 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12145.55 Median:484.68 stddev:13658.76 (2818.1%) stddev-sans-first:13669.93 04:36:13 INFO - 2015-12-04 04:36:13,852 DEBUG : BROWSER_OUTPUT: Values: 678.7 688.8 714.5 728.2 788.8 11910.8 12014.3 12028.2 12076.3 12088.3 11201.5 11338.3 11342.4 11367.8 12974.8 638.6 643.8 648.0 804.7 808.5 812.7 814.6 819.4 820.8 821.5 664.2 675.2 836.4 840.7 840.9 837.3 851.4 853.5 854.1 854.3 634.1 634.4 634.6 634.8 635.2 11950.0 12097.4 12097.6 12101.6 12103.4 10858.9 11324.7 11459.3 11511.8 11581.8 9390.5 9503.8 9512.6 9521.2 9546.9 3226.7 3244.0 3274.4 3284.1 3326.1 40673.4 40924.8 41462.8 41499.8 41580.6 8632.3 8868.8 8879.8 9227.4 9306.6 16166.2 16194.8 16239.9 16254.8 16257.0 6215.8 6405.8 6424.6 6534.3 6648.0 3503.2 3530.0 3641.2 3665.4 3676.9 2742.5 2764.4 2771.0 2774.3 2776.8 474.2 481.8 482.9 486.4 486.6 496.0 514.4 544.8 581.0 600.0 7135.2 7275.2 7322.2 7471.2 7549.5 437.2 478.1 544.6 570.9 593.1 3202.2 3222.4 3407.2 3964.0 4075.7 47626.0 48776.8 48796.8 48808.3 48809.3 43906.8 44204.1 44697.8 45015.3 45107.3 38941.6 39311.4 39329.8 40342.0 40419.4 7434.8 7639.5 7844.4 7986.7 8003.0 30909.8 31154.5 31334.5 31475.1 31624.2 36647.0 37264.3 38535.0 39458.6 39766.4 9668.3 9814.2 9865.7 10142.0 10147.1 11514.6 11678.4 11732.0 11755.6 11806.8 10814.7 10897.5 10941.8 11075.5 11395.9 9748.7 9833.7 10271.9 10525.9 10526.4 9454.8 9487.3 9493.1 9507.6 9852.9 8882.9 9309.4 9349.6 9374.9 9818.9 8628.5 9162.0 9208.7 9368.2 9560.2 04:36:13 INFO - 2015-12-04 04:36:13,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:36:13 INFO - 2015-12-04 04:36:13,852 DEBUG : BROWSER_OUTPUT: 04:36:14 INFO - 2015-12-04 04:36:14,561 INFO : Browser exited with error code: 0 04:36:14 INFO - 2015-12-04 04:36:14,580 INFO : Completed test dromaeo_css (00:18:38) 04:36:14 INFO - 2015-12-04 04:36:14,580 INFO : Starting test kraken 04:36:14 INFO - 2015-12-04 04:36:14,580 DEBUG : operating with platform_type : linux_ 04:36:14 INFO - 2015-12-04 04:36:14,580 INFO : Initialising browser for kraken test... 04:36:14 INFO - 2015-12-04 04:36:14,587 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoEFvJ/profile http://localhost:51521/getInfo.html 04:36:18 INFO - 2015-12-04 04:36:18,974 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:36:18 INFO - 2015-12-04 04:36:18,974 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:36:18 INFO - 2015-12-04 04:36:18,974 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:36:18 INFO - 2015-12-04 04:36:18,974 DEBUG : BROWSER_OUTPUT: __metrics 04:36:19 INFO - 2015-12-04 04:36:19,063 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:36:19 INFO - 2015-12-04 04:36:19,131 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:20 INFO - 2015-12-04 04:36:20,007 INFO : Browser initialized. 04:36:20 INFO - 2015-12-04 04:36:20,007 INFO : Running cycle 1/1 for kraken test... 04:36:20 INFO - 2015-12-04 04:36:20,007 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoEFvJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:36:32 INFO - 2015-12-04 04:36:32,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 142897152 04:36:32 INFO - 2015-12-04 04:36:32,097 DEBUG : BROWSER_OUTPUT: 04:36:34 INFO - 2015-12-04 04:36:34,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:35 INFO - 2015-12-04 04:36:35,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 179965952 04:36:35 INFO - 2015-12-04 04:36:35,292 DEBUG : BROWSER_OUTPUT: 04:36:37 INFO - 2015-12-04 04:36:37,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-dft) 04:36:38 INFO - 2015-12-04 04:36:38,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 167837696 04:36:38 INFO - 2015-12-04 04:36:38,571 DEBUG : BROWSER_OUTPUT: 04:36:41 INFO - 2015-12-04 04:36:41,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-fft) 04:36:42 INFO - 2015-12-04 04:36:42,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 155598848 04:36:42 INFO - 2015-12-04 04:36:42,145 DEBUG : BROWSER_OUTPUT: 04:36:44 INFO - 2015-12-04 04:36:44,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-oscillator) 04:36:44 INFO - 2015-12-04 04:36:44,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 156450816 04:36:44 INFO - 2015-12-04 04:36:44,739 DEBUG : BROWSER_OUTPUT: 04:36:46 INFO - 2015-12-04 04:36:46,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:47 INFO - 2015-12-04 04:36:47,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 157921280 04:36:47 INFO - 2015-12-04 04:36:47,556 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-04 04:36:50,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:51 INFO - 2015-12-04 04:36:51,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 158359552 04:36:51 INFO - 2015-12-04 04:36:51,109 DEBUG : BROWSER_OUTPUT: 04:36:54 INFO - 2015-12-04 04:36:54,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:55 INFO - 2015-12-04 04:36:55,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 158490624 04:36:55 INFO - 2015-12-04 04:36:55,103 DEBUG : BROWSER_OUTPUT: 04:36:57 INFO - 2015-12-04 04:36:57,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51521/tests/kraken/driver.html?testName=json-parse-financial) 04:36:58 INFO - 2015-12-04 04:36:58,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 157298688 04:36:58 INFO - 2015-12-04 04:36:58,517 DEBUG : BROWSER_OUTPUT: 04:37:00 INFO - 2015-12-04 04:37:00,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:00 INFO - 2015-12-04 04:37:00,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 170323968 04:37:00 INFO - 2015-12-04 04:37:00,875 DEBUG : BROWSER_OUTPUT: 04:37:02 INFO - 2015-12-04 04:37:02,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:03 INFO - 2015-12-04 04:37:03,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 168775680 04:37:03 INFO - 2015-12-04 04:37:03,378 DEBUG : BROWSER_OUTPUT: 04:37:05 INFO - 2015-12-04 04:37:05,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:06 INFO - 2015-12-04 04:37:06,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 179646464 04:37:06 INFO - 2015-12-04 04:37:06,161 DEBUG : BROWSER_OUTPUT: 04:37:08 INFO - 2015-12-04 04:37:08,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:09 INFO - 2015-12-04 04:37:09,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 185696256 04:37:09 INFO - 2015-12-04 04:37:09,292 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-12-04 04:37:11,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:12 INFO - 2015-12-04 04:37:12,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 185708544 04:37:12 INFO - 2015-12-04 04:37:12,475 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51521/tests/kraken/driver.html?testName=ai-astar) 04:37:14 INFO - 2015-12-04 04:37:14,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 242122752 04:37:14 INFO - 2015-12-04 04:37:14,509 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,512 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:14 INFO - 2015-12-04 04:37:14,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:14 INFO - 2015-12-04 04:37:14,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;103;110;110;111;100;109;110;117 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;151;163;132;157;154;136;165;129 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;159;161;162;159;162;162;162;162 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;95;92;73;76;71;94;88;72 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;134;94;95;94;125;94;94;127 04:37:14 INFO - 2015-12-04 04:37:14,513 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;110;109;109;109;110 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;147;147;146;147;147;147 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;71;71;72;73;72;70;72;68 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;70;71;70;72;69;70 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;82;90;85;87;84;86;96;85;85 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;125;119;125;133;128;125;121;122;122 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;147;144;150;137;132;145;143;156;142 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;70;69;68;69;68;71;71 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: __startTimestamp1449232634511__endTimestamp 04:37:14 INFO - 2015-12-04 04:37:14,514 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:4.62 (4.2%) stddev-sans-first:4.90 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 103.0 110.0 110.0 111.0 100.0 109.0 110.0 117.0 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:13.96 (9.1%) stddev-sans-first:14.58 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 151.0 163.0 132.0 157.0 154.0 136.0 165.0 129.0 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,518 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 159.0 161.0 162.0 159.0 162.0 162.0 162.0 162.0 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:82.00 stddev:10.45 (12.7%) stddev-sans-first:10.51 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 95.0 92.0 73.0 76.0 71.0 94.0 88.0 72.0 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:94.00 stddev:16.76 (17.8%) stddev-sans-first:17.41 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 134.0 94.0 95.0 94.0 125.0 94.0 94.0 127.0 04:37:14 INFO - 2015-12-04 04:37:14,519 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,520 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:72.00 stddev:1.45 (2.0%) stddev-sans-first:1.50 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 71.0 72.0 73.0 72.0 70.0 72.0 68.0 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 70.0 71.0 70.0 72.0 69.0 70.0 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:4.12 (4.8%) stddev-sans-first:4.12 04:37:14 INFO - 2015-12-04 04:37:14,521 DEBUG : BROWSER_OUTPUT: Values: 91.0 82.0 90.0 85.0 87.0 84.0 86.0 96.0 85.0 85.0 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.00 stddev:3.95 (3.2%) stddev-sans-first:4.19 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: Values: 124.0 125.0 119.0 125.0 133.0 128.0 125.0 121.0 122.0 122.0 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:144.50 stddev:7.58 (5.2%) stddev-sans-first:6.96 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: Values: 132.0 147.0 144.0 150.0 137.0 132.0 145.0 143.0 156.0 142.0 04:37:14 INFO - 2015-12-04 04:37:14,522 DEBUG : BROWSER_OUTPUT: 04:37:14 INFO - 2015-12-04 04:37:14,523 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.07 (1.5%) stddev-sans-first:1.12 04:37:14 INFO - 2015-12-04 04:37:14,523 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 70.0 69.0 68.0 69.0 68.0 71.0 71.0 04:37:14 INFO - 2015-12-04 04:37:14,523 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:14 INFO - 2015-12-04 04:37:14,523 DEBUG : BROWSER_OUTPUT: 04:37:15 INFO - 2015-12-04 04:37:15,385 INFO : Browser exited with error code: 0 04:37:15 INFO - 2015-12-04 04:37:15,439 INFO : Completed test kraken (00:01:00) 04:37:15 INFO - 2015-12-04 04:37:15,439 INFO : Starting test v8_7 04:37:15 INFO - 2015-12-04 04:37:15,439 DEBUG : operating with platform_type : linux_ 04:37:15 INFO - 2015-12-04 04:37:15,439 INFO : Initialising browser for v8_7 test... 04:37:15 INFO - 2015-12-04 04:37:15,446 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHJPoy8/profile http://localhost:51521/getInfo.html 04:37:19 INFO - 2015-12-04 04:37:19,634 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:37:19 INFO - 2015-12-04 04:37:19,634 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:37:19 INFO - 2015-12-04 04:37:19,634 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:37:19 INFO - 2015-12-04 04:37:19,634 DEBUG : BROWSER_OUTPUT: __metrics 04:37:19 INFO - 2015-12-04 04:37:19,735 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:37:19 INFO - 2015-12-04 04:37:19,791 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:20 INFO - 2015-12-04 04:37:20,966 INFO : Browser initialized. 04:37:20 INFO - 2015-12-04 04:37:20,967 INFO : Running cycle 1/1 for v8_7 test... 04:37:20 INFO - 2015-12-04 04:37:20,967 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHJPoy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:37:32 INFO - 2015-12-04 04:37:32,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 143060992 04:37:32 INFO - 2015-12-04 04:37:32,964 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51521/tests/v8_7/run.html (next: http://localhost:51521/tests/v8_7/run.html) 04:37:54 INFO - 2015-12-04 04:37:54,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 439009280 04:37:54 INFO - 2015-12-04 04:37:54,685 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,685 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:54 INFO - 2015-12-04 04:37:54,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |0;Richards;172.95053614666205 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.1821603312006 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 04:37:54 INFO - 2015-12-04 04:37:54,686 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2087.6826722338205 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: |7;RegExp;26230.76923076923 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: |8;Splay;603.728202044498 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:54 INFO - 2015-12-04 04:37:54,687 DEBUG : BROWSER_OUTPUT: __startTimestamp1449232674679__endTimestamp 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.95 Median:172.95 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: Values: 173.0 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,688 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.18 Median:188.18 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: Values: 188.2 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: Values: 277.9 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,689 DEBUG : BROWSER_OUTPUT: Values: 5196.9 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2087.68 Median:2087.68 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: Values: 2087.7 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: Values: 793.7 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,690 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: Values: 12048.2 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: Values: 26230.8 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.73 Median:603.73 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: Values: 603.7 04:37:54 INFO - 2015-12-04 04:37:54,691 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-12-04 04:37:54,692 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:37:54 INFO - 2015-12-04 04:37:54,692 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:37:54 INFO - 2015-12-04 04:37:54,692 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:54 INFO - 2015-12-04 04:37:54,692 DEBUG : BROWSER_OUTPUT: 04:37:55 INFO - 2015-12-04 04:37:55,517 INFO : Browser exited with error code: 0 04:37:55 INFO - 2015-12-04 04:37:55,534 INFO : Completed test v8_7 (00:00:40) 04:37:55 INFO - 2015-12-04 04:37:55,645 INFO : Completed test suite (00:20:19) 04:37:55 INFO - 2015-12-04 04:37:55,645 DEBUG : Working with test: dromaeo_css 04:37:55 INFO - 2015-12-04 04:37:55,645 DEBUG : Generating results file: dromaeo_css 04:37:55 INFO - 2015-12-04 04:37:55,646 DEBUG : Working with test: kraken 04:37:55 INFO - 2015-12-04 04:37:55,646 DEBUG : Generating results file: kraken 04:37:55 INFO - 2015-12-04 04:37:55,646 INFO : javascript benchmark 04:37:55 INFO - 2015-12-04 04:37:55,647 DEBUG : Working with test: v8_7 04:37:55 INFO - 2015-12-04 04:37:55,647 DEBUG : Generating results file: v8_7 04:37:55 INFO - 2015-12-04 04:37:55,647 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:55 INFO - 2015-12-04 04:37:55,698 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:37:55 INFO - 2015-12-04 04:37:55,699 DEBUG : process_Request line: dromaeo_css 6349.73 graph.html#tests=[[72,132,35]] 04:37:55 INFO - 2015-12-04 04:37:55,699 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:55 INFO - 2015-12-04 04:37:55,732 DEBUG : process_Request line: kraken 1518.10 graph.html#tests=[[232,132,35]] 04:37:55 INFO - 2015-12-04 04:37:55,732 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:55 INFO - 2015-12-04 04:37:55,770 DEBUG : process_Request line: v8_7 19665.85 graph.html#tests=[[230,132,35]] 04:37:55 INFO - 2015-12-04 04:37:55,772 INFO : javascript benchmark 04:37:55 INFO - 2015-12-04 04:37:55,775 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.548726716458, 2728.4133911209087, 2731.7951153663466, 2739.3973325868315, 2758.1174024312218, 4612.423447069116, 4738.786754596043, 4767.523247675235, 4794.976025119874, 4814.205656066749, 4685.4377474703, 4694.061187762444, 4755.0, 4756.453007904092, 4804.087223427547, 4346.282863327548, 4373.387725718386, 4378.737275763448, 4387.495438024636, 4408.42690450241, 4224.514180869209, 4424.623906967911, 4456.777161141946, 4487.304467807495, 4504.346869703891, 4288.571142885718, 4289.227938970984, 4299.527052024306, 4390.978045109786, 4395.516493185747, 4391.429114215131, 4421.823127074913, 4423.270160423526, 4424.292113261895, 4459.44256967879, 4358.847440339605, 4376.5623437656295, 4387.42963414754, 4444.288913773813, 4461.933071003938, 4441.289393696993, 4554.658400619934, 4564.8174073037035, 4602.585767280927, 4703.412073490814, 5127.435982041972, 5144.665596736238, 5152.510511501401, 5152.690838549699, 5156.381234251914, 5162.819301324435, 5172.431032586413, 5177.637565370425, 5190.455002224788, 5235.214717792362, 4515.0, 4621.953780462152, 4622.607078398374, 4657.836975705834, 4758.904821903542, 5247.475252474722, 5294.788208471695, 5296.232046353257, 5303.761330740126, 5354.170103633943, 5060.089183946851, 5064.366954130734, 5066.847994560169, 5070.61970352225, 5114.028334616411, 4853.344798452164, 4968.478309777422, 4973.452920178777, 5158.329417175818, 5172.612054095958, 4971.502849715, 5064.924026139611, 5067.113255180402, 5104.566111880532, 5112.616553758483, 5044.4198917125, 5093.2105523643895, 5094.363204599425, 5097.566706829887, 5141.408737995179, 4041.07055377259, 4223.408722778813, 4274.10243848789, 4277.508086570022, 4318.913621727548, 3650.105724097613, 3689.317476266899, 3718.7025037996896, 3720.08857829828, 3752.887413377603, 4391.956080439219, 4446.155230506193, 4447.86656400302, 4450.777461126931, 4458.5318541553315, 4841.3222148899185, 5166.276721259027, 5181.844544663666, 5183.559397451183, 5187.403448603383, 4303.483581970184, 4315.0, 4332.588404101605, 4382.8466003690355, 4421.7346959181905, 4493.865184044484, 4575.633949284049, 4583.564561366665, 4589.701669391479, 4615.815367385267, 4663.067386522641, 4941.036497882878, 4942.654014218971, 4945.010997800454, 4961.5286547777905, 5044.596432285482, 5054.747262636927, 5067.239914012927, 5106.897862042664, 5174.482551744795, 4890.364252647133, 4937.111319962298, 4938.777755001105, 4942.357493525818, 4983.377077865267, 4804.927926081042, 5086.821961231339, 5088.7201203932655, 5103.591712662904, 5111.821086261963, 4996.025774973845, 5015.699058056528, 5075.137226671401, 5210.218467229945, 5210.97394513025, 4982.427020892644, 4989.775460104232, 4991.176455884738, 4994.80020799164, 5034.0938631046765, 4650.558196971282, 4983.25251212321, 4988.825391111293, 4994.350734404649, 4995.17579599362, 4705.717656940595, 4753.263244197155, 4771.594414474808, 4810.134175848241, 4831.903361932671, 4985.401751789808, 5031.496850314939, 5048.091343558195, 5056.721880296619, 5057.064443078042, 4635.51327110662, 4926.950730492649, 4928.112939670894, 4929.2359684248995, 4946.530079642428], "unit": "ms", "name": "dojo.html", "value": 4675.590391063202}, {"lowerIsBetter": false, "replicates": [557.1816139791325, 575.0597772641731, 576.3573615418809, 583.4661284924294, 598.0311894730537, 28104.718952810465, 28715.569266460992, 28718.138455846332, 36920.26159476809, 37750.24499510008, 40412.79793601035, 40795.12446317603, 40913.795431022874, 41056.17887642253, 41140.38289425654, 7895.0920644125945, 8064.112947575762, 8073.475224110443, 8078.596070196496, 8080.070791858923, 7166.64166791661, 7353.852922941538, 10209.336393134423, 10485.370877747322, 10496.947515262413, 10050.89949100507, 10200.540975656113, 10201.540930658139, 10203.744906377362, 10213.642522511713, 7183.42532597391, 7373.594452305121, 9960.452175130366, 10008.149307308851, 10075.294729368947, 7094.929050709478, 10185.134263587604, 10512.842307365396, 10521.579136834518, 10523.94738026305, 37210.44184337237, 37663.4350484743, 37683.434748478794, 37703.0, 37725.811370943244, 2598.350412396901, 2744.0944488318805, 2826.4771017361854, 3027.7275045246033, 3124.937779990045, 27095.729042709518, 27645.308867278276, 27959.440811183867, 28024.959977795665, 28287.575686364722, 3336.115929278743, 3388.678075582816, 3461.671141241578, 3496.7202623790035, 3503.4919936609303, 214768.0, 215011.0, 217000.91499542558, 217013.0, 217424.0, 46703.766481167375, 47645.28532072021, 54230.728846355516, 54771.726141369836, 54802.72598637061, 63445.0, 64447.67776161089, 64963.35036649668, 64993.35006649873, 65032.34967650263, 13887.236202008784, 14094.859051409354, 14146.646333841736, 14186.787198192036, 14188.503402380868, 10340.896591034143, 10374.17006639467, 10382.844257336146, 10385.84421233682, 10393.688189354332, 18608.627827443375, 18816.0, 18831.435056948314, 18843.152058157415, 18880.24479020824, 6961.756338528127, 7203.38771204443, 7211.423086153095, 7222.927770722225, 7320.487565870444, 896.3680605173337, 928.5542939389131, 952.2715122930963, 1043.1811028342715, 1052.6684094510206, 26428.8678556606, 26822.463550728877, 26881.596776047983, 27108.32229194286, 27171.592426113624, 957.5164541906432, 970.7379007668031, 983.0415345038673, 1004.5830980143159, 1063.3566692151292, 13803.516876909462, 13899.583012509642, 13959.79060314096, 14057.0, 14303.856961430462, 260118.0, 261625.0, 262045.0, 262864.0, 263458.0, 46008.0, 46236.7688161557, 46397.536024639994, 46409.5359046412, 46452.0, 1179.775842589905, 1202.2005366431226, 1207.849018872641, 1209.473878862715, 1219.1283232488813, 25209.621855672547, 26297.21108366752, 26619.41307459804, 26885.327866802705, 26920.461590768467, 40445.191096177325, 40754.79622601868, 40762.0, 40784.388234175916, 40817.1836563273, 240922.0, 242556.0, 243110.0, 243529.0, 243636.0, 24767.0, 25238.0, 28763.28091797722, 29156.562651560667, 30445.0, 35190.824045879606, 35962.64037359593, 38852.0, 39064.2187156261, 39341.60658393494, 32359.51460728138, 32683.0, 33244.1688957778, 33309.16727081843, 33852.0, 27041.78311976005, 30158.0, 30742.385152297276, 31127.53308700326, 31247.168919086904, 33097.669023310424, 33188.50217246695, 33604.83197583997, 33796.831015844764, 33909.152271193416, 28382.290442739097, 30010.399792004475, 30055.782116938753, 30446.0, 30656.693433065382, 30373.24066898257, 32517.349653006335, 32581.837090814395, 32603.673963260062, 33611.327773444886], "unit": "ms", "name": "ext.html", "value": 17257.517695028513}, {"lowerIsBetter": false, "replicates": [321.1809884793775, 325.48248285226487, 325.9478483442648, 327.7034283973004, 328.87667124828187, 12456.31490268035, 12772.169808962411, 15000.924995375022, 15450.536483905487, 15580.688386232268, 12369.938150309235, 14095.78856317156, 14275.643108922282, 14275.928620356884, 15055.77416338753, 5017.096922553938, 5032.874178145539, 5039.899202015958, 5058.721770302632, 5167.612429067835, 3606.4049431843846, 3714.4242642390473, 5063.0, 5104.6937183768905, 5615.4665306796, 5803.506701930341, 5819.214406055171, 5837.941620583782, 5893.941060589382, 5912.142739302799, 5601.187827764971, 5667.404922483162, 5672.829815105553, 5674.262345895048, 5776.018076926933, 4897.33885925399, 4906.9263961040615, 4923.8276660316715, 4961.677490963076, 5012.598992080625, 19168.424947251606, 19202.0, 19497.0, 19660.311889083812, 19680.212791488324, 1748.1870930017603, 1794.9551261218444, 1814.3468351393487, 1895.4503194073702, 1914.8468122550162, 12456.0, 12658.0, 12846.935765321206, 12917.547885824046, 13042.478300868048, 1594.5296137639425, 1611.9355225790955, 1656.1470842516114, 1659.7842280503578, 1748.9562760931078, 52134.739326303505, 54062.72968635132, 54285.45714542844, 54573.454265457236, 54602.453975460136, 8898.0, 8993.0, 9301.767455813659, 9303.255739540957, 9322.1610055094, 11685.707857303465, 11701.824472632918, 11708.473118709679, 11719.238249513754, 11726.0, 6994.090768200102, 7239.9276007240305, 7260.2739726026975, 7276.6725497352745, 7417.666205020787, 6773.593584384854, 7044.330788575077, 7113.972517832393, 7149.749758758522, 7175.712971481186, 5742.196092547047, 5745.770169193185, 5755.280589926259, 5760.855978600569, 5786.3056433228285, 1531.8544738249848, 1531.9387224510895, 1584.3187429405236, 1587.563420059493, 1620.2222932992229, 896.6951236579595, 902.8826252587253, 912.4069354919355, 958.5734348214977, 1028.8353863381824, 15074.472393466176, 16133.274002669908, 16135.677286454205, 16309.102999335151, 16750.329986800636, 782.6282515804947, 791.1297572670017, 820.8235229425702, 825.405707890318, 870.0820634230947, 8407.70573029941, 8864.290856731575, 9074.183323500916, 9084.545772711337, 9166.22087122602, 438348.0, 440391.0, 444171.0, 444310.0, 454588.0, 68876.0, 69066.0, 69617.17105559142, 69634.0, 70581.64709176421, 1068.0707784227773, 1087.7770057138268, 1096.353151640536, 1102.32207192576, 1119.6361182615683, 13873.722525549634, 13878.236696981763, 13948.58154255374, 14167.0, 14236.145831250158, 31724.682753172172, 31754.72981080731, 32122.67877321197, 32660.836695816368, 33380.83309583534, 42302.576974229865, 42923.0, 43585.782071089445, 44442.0, 44738.776306119566, 8889.866652000095, 8997.775055623662, 9276.840394950632, 9281.582328795355, 9289.581968811555, 16027.358905643643, 16262.756058658893, 16379.181040948144, 16463.753043704113, 16675.583110422336, 13678.247696376397, 13700.93149534246, 13729.382177801823, 13901.23543205093, 14047.438102475786, 11940.940295298467, 12301.507939682313, 13636.181829090287, 13742.312884355542, 13873.306334683428, 10058.417578244145, 11634.825477618011, 13318.267495287851, 13951.441942322599, 14148.717025659635, 8372.7906802328, 8649.8702519461, 8666.566671666518, 8698.695545655872, 8745.956270218609, 9040.367174297999, 9116.0, 12682.87317126817, 13080.672983175116, 13396.26320552379], "unit": "ms", "name": "jquery.html", "value": 8307.817524810442}, {"lowerIsBetter": false, "replicates": [1452.8765054970327, 1676.79040119985, 1731.4719010701738, 1742.059287984489, 1755.9122043897803, 5971.193888825007, 6209.503239740821, 7228.0, 7455.0, 7456.5898875561825, 7317.59753213573, 7343.485955983083, 7426.071741032371, 7428.405727541797, 7434.479586428939, 1705.4201571465699, 1776.094191962102, 2030.7055476955832, 2069.689546568012, 2072.575122099966, 1760.489458057162, 2053.1992522916075, 2104.8737075775425, 2106.115431518766, 2106.6208082545136, 2045.7442819647545, 2060.5878824235137, 2062.61841559312, 2067.1111422088497, 2093.665013597825, 2046.3553980496097, 2073.8029887160696, 2077.5948690005457, 2078.6674132138937, 2080.334293026232, 2045.7033730109051, 2080.6046851098245, 2081.739782527184, 2081.7918208179212, 2085.270155445597, 7234.168070671887, 7296.306850849161, 7299.379552738023, 7305.525140865827, 7313.670884810196, 4203.3064544350145, 4290.163418133465, 4313.590208930146, 4314.633256173229, 4327.221100201962, 2601.8308809927485, 2602.648642433266, 2640.4983053219826, 2648.562987107125, 2655.9734402655918, 795.6618437164182, 824.468217999387, 834.1200033964166, 848.3043903998723, 858.9312854971587, 10029.247806414474, 10032.147267482273, 10050.346727462691, 10056.296059275854, 10068.798624027551, 3855.479510266134, 3930.5283365996265, 3969.940450893239, 3982.542007669097, 3987.1029018470613, 8540.231379175904, 8545.0, 8545.444546104483, 8545.914540854636, 8548.914510854936, 4240.109576988867, 4259.233337999128, 4261.488621365456, 4266.765327906933, 4271.039016221325, 3855.4024126260474, 3875.7286989911, 3877.592852750477, 3879.8254078566533, 3882.611738826095, 3010.473167195732, 3057.3579548295106, 3381.1378098584705, 3475.0269924421204, 3486.9476957845654, 1072.4423299884018, 1094.63876920616, 1102.3441052573705, 1106.634810512529, 1118.2004866520315, 929.0570071377557, 930.4835816122118, 969.2149359019216, 984.7538115471132, 1225.8896699297106, 6917.9308206918295, 6965.930340696629, 6983.441324694012, 6993.685284162225, 6998.650067496605, 1037.7353774787382, 1043.8642976413018, 1044.2637940252255, 1054.4411461925192, 1069.9296860574814, 5199.610029247821, 5220.791168353299, 5237.450067742909, 5242.7640756166065, 5247.606429517801, 8566.657333706706, 8682.91317086821, 8723.738287851374, 8771.342149338825, 8808.339374546806, 8763.255123314462, 8770.693025744069, 8776.078511756301, 8792.42849214799, 8796.07641197665, 6797.626130562867, 6883.070785444002, 6909.27452617478, 6917.861642767117, 6920.30796920304, 6609.504287178577, 6609.801705948829, 6636.037774522763, 6637.535372523877, 6646.83382915431, 7653.081630204411, 7785.727499537489, 7824.4131690124605, 7830.804229894298, 7901.920980790119, 7873.212678732081, 7982.361411086983, 8003.3597312213715, 8119.5534245617055, 8124.715634952749, 5809.0, 6334.208223972004, 6337.732453509225, 6360.236771587439, 6364.363563643598, 5859.824205273849, 6072.757089716361, 6644.634545100066, 6854.383105520527, 6907.20567134786, 6354.1104245406605, 6585.835354116185, 6597.472202223907, 6684.832879177865, 6710.664466776544, 6445.129907462432, 6508.576942498722, 6522.086907833002, 6531.216254049545, 6585.868282634417, 5700.401457846866, 5857.560682948711, 5863.73613187399, 5868.94131058684, 5875.059990401515, 5821.243238379153, 5841.299044114563, 5852.648841069549, 5856.267966504187, 5861.35525092248, 5803.680797556175, 5855.180274761452, 5876.911846322223, 5913.026221130743, 5964.731587078505], "unit": "ms", "name": "mootools.html", "value": 4104.4418027403635}, {"lowerIsBetter": false, "replicates": [268.31044216363944, 271.9986400068001, 274.04085700049825, 281.6816996793623, 285.0919820372116, 5350.063738845701, 5377.973110134449, 5380.838574842751, 5418.539424148952, 5439.048166570844, 5317.521423071923, 5340.759665815038, 5344.572434205264, 5351.197320401941, 5352.625316227865, 3856.826442810066, 3946.4474973503734, 3953.169834334793, 4060.127072679373, 4120.381942708587, 4101.938470922939, 4102.610252026067, 4112.2803509385885, 4115.979420102895, 4120.732152410099, 3821.2739579479808, 3945.2306800173833, 4074.7555146691293, 4078.163976384849, 4084.101497670508, 3941.1723538057045, 3997.080671445555, 4002.2195671844, 4050.10897602527, 4053.1893621275863, 3516.6307537708685, 3523.4186359250693, 3530.841112149934, 3538.982305088484, 3544.8227588620466, 5174.767135478913, 5180.274761533388, 5182.533571978503, 5182.766775495074, 5194.506521880416, 4586.472555656109, 4648.279516674921, 4676.158291507527, 4679.836205732817, 4682.063587282557, 5627.493525582717, 5632.5212356949705, 5645.294338207724, 5645.379008309083, 5648.661080335193, 3886.6696330811915, 3898.7465814721954, 3903.6877049835944, 3904.5900180480926, 3904.824282907276, 5915.881682366328, 5927.7925272615685, 5936.762529498815, 5941.0, 5941.287045554518, 3864.1112544115012, 3960.643542081169, 4014.8996275093355, 4020.6783457323345, 4021.4973128358956, 3949.980250098731, 3950.525936887592, 3957.782321972262, 3961.465202197724, 3972.0268534209304, 4595.310703394518, 4613.838515651936, 4616.538346165356, 4617.7691115444095, 4622.86131416058, 5614.606977511535, 5615.185798059259, 5621.353544342372, 5652.095664693711, 5667.404922483162, 1389.3608939887765, 1437.6621493948915, 1439.7408466476136, 1440.2150827798876, 1440.2942558146433, 925.4586067150792, 938.9248860091176, 955.1356022799378, 957.2533423929347, 959.7072892767773, 4982.402111746541, 4982.950170498321, 4983.426905905795, 4985.476524964826, 4987.975060124676, 5871.266091738533, 5874.0, 5880.0, 5882.470577648032, 5884.47039766423, 4972.751362431936, 4977.8257760978195, 4978.352814134212, 4982.551570358685, 4983.227599721977, 3052.496338104188, 3089.9536506952413, 3137.811731296084, 3199.9840000800314, 3202.327511222623, 5619.044762390404, 5634.295713035871, 5640.746166422521, 5642.181883626851, 5649.350324712711, 6087.908681369783, 6094.146819445281, 6100.206973093558, 6105.900937831233, 6108.3280839107665, 5475.06923822951, 5586.273784408001, 5626.971865140648, 5642.125470552071, 5647.745851436695, 5912.260967379078, 5918.319393269657, 5926.288845338587, 5926.288845338587, 5931.525477961666, 5784.595078344475, 5787.2187254720075, 5789.884202316014, 5795.275590551181, 5800.042992906123, 5461.235427040138, 5614.494695477263, 5616.550675945833, 5618.831435056954, 5621.044422448275, 3899.3371126907928, 3945.9408108878965, 3946.703997200164, 3950.980245098871, 3952.189801090827, 5919.733611987557, 5922.881542369215, 5925.229720136354, 5931.0, 5941.900748361567, 5715.057015592547, 5726.828195154152, 5727.971360143172, 5735.139729040678, 5735.799247026334, 5572.442755724395, 5694.202811606461, 5706.172604972173, 5709.51469125129, 5713.085906254979, 5573.944260557342, 5576.247206627054, 5576.665400076008, 5578.246936663499, 5580.637258578179, 5737.196792448977, 5750.856228594319, 5753.827385178452, 5754.6547207167705, 5761.452661997104, 5422.728863556886, 5559.72201389937, 5564.054110801255, 5575.303087114111, 5593.825296687741], "unit": "ms", "name": "prototype.html", "value": 4208.647131366091}, {"lowerIsBetter": false, "replicates": [678.7386856060417, 688.7795905310303, 714.4748609771821, 728.1626129950556, 788.7909703928458, 11910.82133767993, 12014.339211343373, 12028.218165819215, 12076.275423474575, 12088.274703517794, 11201.495932683029, 11338.319700817936, 11342.376169310684, 11367.772644547103, 12974.805377919316, 638.5721566550422, 643.8197304754676, 647.9838004049913, 804.7304153108686, 808.4946908182401, 812.6911773526052, 814.6130587970696, 819.3731795176694, 820.831729495455, 821.5235163605124, 664.2129077043719, 675.199888132562, 836.431226765799, 840.7351684219451, 840.865461526156, 837.3008537870885, 851.4210336970857, 853.4623187391966, 854.1373213054859, 854.2866706300247, 634.0805831544279, 634.403660559073, 634.578005626258, 634.7905191286865, 635.240887139868, 11950.0, 12097.39513024354, 12097.576584819577, 12101.636950891487, 12103.39483025854, 10858.891411085946, 11324.660260192208, 11459.312441253469, 11511.827322590168, 11581.826272605833, 9390.48352340621, 9503.762405939839, 9512.619495220182, 9521.23830093591, 9546.949835518088, 3226.677332266778, 3243.96756032439, 3274.4106060909025, 3284.080457471912, 3326.101952472843, 40673.38989915154, 40924.79537602323, 41462.79268603668, 41499.7925010373, 41580.58419415797, 8632.266257368194, 8868.78186800392, 8879.822403551892, 9227.400218985878, 9306.581203845843, 16166.191690415431, 16194.838051619568, 16239.918800405922, 16254.837451625332, 16257.0, 6215.782447614311, 6405.839854003687, 6424.582402143846, 6534.313897040837, 6647.966760166265, 3503.1767534629344, 3530.0, 3641.214862425386, 3665.3585622515952, 3676.9080772980888, 2742.4515096980285, 2764.433291175304, 2771.0, 2774.250952242883, 2776.7778577713734, 474.23647926837765, 481.82895072248846, 482.9323894654751, 486.4357345479227, 486.5766782898901, 495.982640607577, 514.3724655919772, 544.8474427160402, 580.9738561764731, 600.0159738029635, 7135.179454362815, 7275.163356214103, 7322.1945585985495, 7471.215522370181, 7549.50928189666, 437.2108344438319, 478.12741746313117, 544.6214880657984, 570.934342550612, 593.0955293177852, 3202.1994501374656, 3222.356598134968, 3407.1993081625797, 3963.9801800991386, 4075.735077219971, 47626.04747905023, 48776.75611621919, 48796.7560162204, 48808.26787598189, 48809.267860982116, 43906.780466097465, 44204.11591768211, 44697.77651111789, 45015.32477012847, 45107.32339014918, 38941.61058389436, 39311.41032884509, 39329.80335098363, 40342.0, 40419.39370909439, 7434.814129646586, 7639.503432276884, 7844.438611002386, 7986.680532778624, 8002.959985200269, 30909.8454507735, 31154.532682009336, 31334.529982049833, 31475.055748327588, 31624.209394765316, 36647.0, 37264.25471490501, 38535.03662408462, 39458.60541394664, 39766.40350394689, 9668.274879383933, 9814.165795907142, 9865.704028879145, 10142.0, 10147.137493313152, 11514.596989105676, 11678.379702292317, 11732.0, 11755.588554400554, 11806.822897656713, 10814.729631759268, 10897.455127243764, 10941.781164376827, 11075.501602427748, 11395.886041139482, 9748.658796942073, 9833.704988850346, 10271.94864025675, 10525.89474105249, 10526.368417894644, 9454.842062856611, 9487.288453366164, 9493.087557603796, 9507.572159252712, 9852.906145783809, 8882.880473806385, 9309.394889332172, 9349.57926893305, 9374.906250937403, 9818.901810982084, 8628.52543110135, 9161.954190229273, 9208.677696280598, 9368.156865882103, 9560.187384072153], "unit": "ms", "name": "yui.html", "value": 5659.60987568809}], "name": "dromaeo_css", "value": 6349.72748784443}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 110.0, 110.0, 111.0, 100.0, 109.0, 110.0, 117.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 151.0, 163.0, 132.0, 157.0, 154.0, 136.0, 165.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 159.0, 161.0, 162.0, 159.0, 162.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 95.0, 92.0, 73.0, 76.0, 71.0, 94.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 134.0, 94.0, 95.0, 94.0, 125.0, 94.0, 94.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 71.0, 72.0, 73.0, 72.0, 70.0, 72.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 70.0, 71.0, 70.0, 72.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [91.0, 82.0, 90.0, 85.0, 87.0, 84.0, 86.0, 96.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [124.0, 125.0, 119.0, 125.0, 133.0, 128.0, 125.0, 121.0, 122.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [132.0, 147.0, 144.0, 150.0, 137.0, 132.0, 145.0, 143.0, 156.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1518.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.95053614666205], "unit": "score", "name": "Richards", "value": 204.11616399999997}, {"lowerIsBetter": false, "replicates": [188.1821603312006], "unit": "score", "name": "DeltaBlue", "value": 351.351052}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [2087.6826722338205], "unit": "score", "name": "RayTrace", "value": 354.454731}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [603.728202044498], "unit": "score", "name": "Splay", "value": 134.97961454183266}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19665.847272601433}]} 04:37:55 INFO - RETURN: dromaeo_css: 6349.73 04:37:55 INFO - RETURN: kraken: 1518.10 04:37:55 INFO - RETURN: v8_7: 19665.85 04:37:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19665.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1518.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6349.73"}}} 04:37:55 INFO - Return code: 0 04:37:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:55 INFO - # TBPL SUCCESS # 04:37:55 INFO - Running post-action listener: _resource_record_post_action 04:37:55 INFO - Running post-run listener: _resource_record_post_run 04:37:56 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507797504; Read time: 12; Write time: 508716 04:37:56 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231473152; Read time: 0; Write time: 327016 04:37:56 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276324352; Read time: 12; Write time: 181700 04:37:56 INFO - Running post-run listener: _upload_blobber_files 04:37:56 INFO - Blob upload gear active. 04:37:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:37:56 INFO - Copying logs to upload dir... 04:37:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.980051 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-04 04:37:56.617359) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:37:56.622316) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009975 build_url: 'https://queue.taskcluster.net/v1/task/7tqiOWc5QMqehgymT4d7Fg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:37:56.675267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:37:56.675654) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1449229040.90652-561505789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:37:56.729610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:37:56.729956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:37:56.730356) ========= ========= Total master_lag: 0.32 =========