builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1450269634.03 results: success (0) buildid: 20151216033305 builduid: 6d4c30f8e4fb4268a20c73c212a4d0a9 revision: 01cff68d5e39022df92399bd8eb00b7165027e17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.035173) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.035725) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.036035) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004467 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.053816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.054118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.066758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.067093) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.115945) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.116199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.116559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.116828) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 04:40: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2015-12-16 04:40:34 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.321684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.322188) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021568 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:34.372164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:40:34.372519) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 01cff68d5e39022df92399bd8eb00b7165027e17 --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 01cff68d5e39022df92399bd8eb00b7165027e17 --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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 04:40:34,960 truncating revision to first 12 chars 2015-12-16 04:40:34,960 Setting DEBUG logging. 2015-12-16 04:40:34,960 attempt 1/10 2015-12-16 04:40:34,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/01cff68d5e39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 04:40:35,724 unpacking tar archive at: fx-team-01cff68d5e39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 04:40:35.419766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.420120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.429502) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.429793) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 04:40:35.430217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 04:40:35.430518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:36 INFO - MultiFileLogger online at 20151216 04:40:36 in /builds/slave/test 04:40:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:36 INFO - {'append_to_log': False, 04:40:36 INFO - 'base_work_dir': '/builds/slave/test', 04:40:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:36 INFO - 'branch': 'Fx-Team-Non-PGO', 04:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:36 INFO - 'config_files': ('talos/linux_config.py',), 04:40:36 INFO - 'default_actions': ('clobber', 04:40:36 INFO - 'read-buildbot-config', 04:40:36 INFO - 'download-and-extract', 04:40:36 INFO - 'populate-webroot', 04:40:36 INFO - 'create-virtualenv', 04:40:36 INFO - 'install', 04:40:36 INFO - 'run-tests'), 04:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:36 INFO - 'download_minidump_stackwalk': True, 04:40:36 INFO - 'download_symbols': 'ondemand', 04:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:36 INFO - 'installer_path': 'installer.exe', 04:40:36 INFO - 'log_level': 'info', 04:40:36 INFO - 'log_name': 'talos', 04:40:36 INFO - 'log_to_console': True, 04:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:36 INFO - 'opt_config_files': (), 04:40:36 INFO - 'pip_index': False, 04:40:36 INFO - 'sps_profile': False, 04:40:36 INFO - 'sps_profile_interval': 0, 04:40:36 INFO - 'suite': 'dromaeojs-e10s', 04:40:36 INFO - 'system_bits': '64', 04:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:36 INFO - 'title': 'talos-linux64-ix-062', 04:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:36 INFO - 'use_talos_json': True, 04:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:36 INFO - 'work_dir': 'build'} 04:40:36 INFO - ##### 04:40:36 INFO - ##### Running clobber step. 04:40:36 INFO - ##### 04:40:36 INFO - Running pre-action listener: _resource_record_pre_action 04:40:36 INFO - Running main action method: clobber 04:40:36 INFO - rmtree: /builds/slave/test/build 04:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:37 INFO - Running post-action listener: _resource_record_post_action 04:40:37 INFO - ##### 04:40:37 INFO - ##### Running read-buildbot-config step. 04:40:37 INFO - ##### 04:40:37 INFO - Running pre-action listener: _resource_record_pre_action 04:40:37 INFO - Running main action method: read_buildbot_config 04:40:37 INFO - Using buildbot properties: 04:40:37 INFO - { 04:40:37 INFO - "properties": { 04:40:37 INFO - "buildnumber": 580, 04:40:37 INFO - "product": "firefox", 04:40:37 INFO - "script_repo_revision": "production", 04:40:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:40:37 INFO - "repository": "", 04:40:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:40:37 INFO - "buildid": "20151216033305", 04:40:37 INFO - "slavename": "talos-linux64-ix-062", 04:40:37 INFO - "pgo_build": "False", 04:40:37 INFO - "basedir": "/builds/slave/test", 04:40:37 INFO - "project": "", 04:40:37 INFO - "platform": "ubuntu64_hw", 04:40:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:40:37 INFO - "slavebuilddir": "test", 04:40:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:40:37 INFO - "branch": "fx-team", 04:40:37 INFO - "repo_path": "integration/fx-team", 04:40:37 INFO - "stage_platform": "linux64", 04:40:37 INFO - "builduid": "6d4c30f8e4fb4268a20c73c212a4d0a9", 04:40:37 INFO - "revision": "01cff68d5e39022df92399bd8eb00b7165027e17" 04:40:37 INFO - }, 04:40:37 INFO - "sourcestamp": { 04:40:37 INFO - "repository": "", 04:40:37 INFO - "hasPatch": false, 04:40:37 INFO - "project": "", 04:40:37 INFO - "branch": "fx-team-linux64-talos", 04:40:37 INFO - "changes": [ 04:40:37 INFO - { 04:40:37 INFO - "category": null, 04:40:37 INFO - "files": [ 04:40:37 INFO - { 04:40:37 INFO - "url": null, 04:40:37 INFO - "name": "https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:40:37 INFO - } 04:40:37 INFO - ], 04:40:37 INFO - "repository": "", 04:40:37 INFO - "rev": "01cff68d5e39022df92399bd8eb00b7165027e17", 04:40:37 INFO - "who": "cbook@mozilla.com", 04:40:37 INFO - "when": 1450268997, 04:40:37 INFO - "number": 7365730, 04:40:37 INFO - "comments": "Bug 1226989 - Don't clip netmonitor Method header text. r=ntim", 04:40:37 INFO - "project": "", 04:40:37 INFO - "at": "Wed 16 Dec 2015 04:29:57", 04:40:37 INFO - "branch": "fx-team-linux64-talos", 04:40:37 INFO - "revlink": "", 04:40:37 INFO - "properties": [ 04:40:37 INFO - [ 04:40:37 INFO - "buildid", 04:40:37 INFO - "20151216033305", 04:40:37 INFO - "Change" 04:40:37 INFO - ], 04:40:37 INFO - [ 04:40:37 INFO - "builduid", 04:40:37 INFO - "6d4c30f8e4fb4268a20c73c212a4d0a9", 04:40:37 INFO - "Change" 04:40:37 INFO - ], 04:40:37 INFO - [ 04:40:37 INFO - "pgo_build", 04:40:37 INFO - "False", 04:40:37 INFO - "Change" 04:40:37 INFO - ] 04:40:37 INFO - ], 04:40:37 INFO - "revision": "01cff68d5e39022df92399bd8eb00b7165027e17" 04:40:37 INFO - } 04:40:37 INFO - ], 04:40:37 INFO - "revision": "01cff68d5e39022df92399bd8eb00b7165027e17" 04:40:37 INFO - } 04:40:37 INFO - } 04:40:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:40:37 INFO - Running post-action listener: _resource_record_post_action 04:40:37 INFO - ##### 04:40:37 INFO - ##### Running download-and-extract step. 04:40:37 INFO - ##### 04:40:37 INFO - Running pre-action listener: _resource_record_pre_action 04:40:37 INFO - Running main action method: download_and_extract 04:40:37 INFO - mkdir: /builds/slave/test/build/tests 04:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:37 INFO - https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/test_packages.json 04:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/test_packages.json 04:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:40:38 INFO - Downloaded 1302 bytes. 04:40:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:40:38 INFO - Using the following test package requirements: 04:40:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:40:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'jsshell-linux-x86_64.zip'], 04:40:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:40:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:40:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:40:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:40:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:40:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:40:38 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:40:38 INFO - https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:40:39 INFO - Downloaded 21869080 bytes. 04:40:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:40:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:40:40 INFO - Return code: 0 04:40:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:40:40 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:40:40 INFO - https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:40:41 INFO - Downloaded 21869080 bytes. 04:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:40:42 INFO - Return code: 0 04:40:42 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:40:42 INFO - https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:40:43 INFO - Downloaded 11132052 bytes. 04:40:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:40:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:40:43 INFO - Return code: 0 04:40:43 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:40:43 INFO - https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:40:44 INFO - Downloaded 57745451 bytes. 04:40:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:44 INFO - mkdir: /builds/slave/test/properties 04:40:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:44 INFO - Contents: 04:40:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - Running post-action listener: set_extra_try_arguments 04:40:44 INFO - ##### 04:40:44 INFO - ##### Running populate-webroot step. 04:40:44 INFO - ##### 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: populate_webroot 04:40:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:44 INFO - '--tppagecycles', 04:40:44 INFO - '7'], 04:40:44 INFO - 'tests': ['tsvgm']}}, 04:40:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'other': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other_l64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'other_nol64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore']}, 04:40:44 INFO - 'svgr': {'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart']}, 04:40:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart']}, 04:40:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'tests': ['tp5o']}, 04:40:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s'], 04:40:44 INFO - 'tests': ['tp5o']}, 04:40:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}, 04:40:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:44 INFO - 'talos_options': ['--e10s', 04:40:44 INFO - '--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}}, 04:40:44 INFO - 'talos.zip': {'path': '', 04:40:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - ##### 04:40:44 INFO - ##### Running create-virtualenv step. 04:40:44 INFO - ##### 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: create_virtualenv 04:40:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:44 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:40:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:44 INFO - Using real prefix '/usr' 04:40:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:47 INFO - Installing pip.................done. 04:40:47 INFO - Return code: 0 04:40:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:47 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:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:47 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:40:47 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:40:47 INFO - Using env: {'DISPLAY': ':0', 04:40:47 INFO - 'HOME': '/home/cltbld', 04:40:47 INFO - 'LANG': 'en_US.UTF-8', 04:40:47 INFO - 'LANGUAGE': 'en_US:en', 04:40:47 INFO - 'LOGNAME': 'cltbld', 04:40:47 INFO - 'MAIL': '/var/mail/cltbld', 04:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:47 INFO - 'MOZ_NO_REMOTE': '1', 04:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:47 INFO - 'NO_EM_RESTART': '1', 04:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:47 INFO - 'PWD': '/builds/slave/test', 04:40:47 INFO - 'SHELL': '/bin/bash', 04:40:47 INFO - 'SHLVL': '1', 04:40:47 INFO - 'TERM': 'linux', 04:40:47 INFO - 'TMOUT': '86400', 04:40:47 INFO - 'USER': 'cltbld', 04:40:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:47 INFO - '_': '/tools/buildbot/bin/python'} 04:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:47 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:40:47 INFO - Cleaning up... 04:40:47 INFO - Return code: 0 04:40:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:40:47 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:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:47 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:47 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:40:47 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:40:47 INFO - Using env: {'DISPLAY': ':0', 04:40:47 INFO - 'HOME': '/home/cltbld', 04:40:47 INFO - 'LANG': 'en_US.UTF-8', 04:40:47 INFO - 'LANGUAGE': 'en_US:en', 04:40:47 INFO - 'LOGNAME': 'cltbld', 04:40:47 INFO - 'MAIL': '/var/mail/cltbld', 04:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:47 INFO - 'MOZ_NO_REMOTE': '1', 04:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:47 INFO - 'NO_EM_RESTART': '1', 04:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:47 INFO - 'PWD': '/builds/slave/test', 04:40:47 INFO - 'SHELL': '/bin/bash', 04:40:47 INFO - 'SHLVL': '1', 04:40:47 INFO - 'TERM': 'linux', 04:40:47 INFO - 'TMOUT': '86400', 04:40:47 INFO - 'USER': 'cltbld', 04:40:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:47 INFO - '_': '/tools/buildbot/bin/python'} 04:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:47 INFO - Downloading/unpacking psutil>=0.7.1 04:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:40:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:49 INFO - Installing collected packages: psutil 04:40:49 INFO - Running setup.py install for psutil 04:40:49 INFO - building 'psutil._psutil_linux' extension 04:40:49 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:40:49 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:40:49 INFO - building 'psutil._psutil_posix' extension 04:40:49 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:40:50 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:40:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:50 INFO - Successfully installed psutil 04:40:50 INFO - Cleaning up... 04:40:50 INFO - Return code: 0 04:40:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:50 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:50 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:40:50 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:40:50 INFO - Using env: {'DISPLAY': ':0', 04:40:50 INFO - 'HOME': '/home/cltbld', 04:40:50 INFO - 'LANG': 'en_US.UTF-8', 04:40:50 INFO - 'LANGUAGE': 'en_US:en', 04:40:50 INFO - 'LOGNAME': 'cltbld', 04:40:50 INFO - 'MAIL': '/var/mail/cltbld', 04:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:50 INFO - 'MOZ_NO_REMOTE': '1', 04:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:50 INFO - 'NO_EM_RESTART': '1', 04:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:50 INFO - 'PWD': '/builds/slave/test', 04:40:50 INFO - 'SHELL': '/bin/bash', 04:40:50 INFO - 'SHLVL': '1', 04:40:50 INFO - 'TERM': 'linux', 04:40:50 INFO - 'TMOUT': '86400', 04:40:50 INFO - 'USER': 'cltbld', 04:40:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:50 INFO - '_': '/tools/buildbot/bin/python'} 04:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40:50 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:40:50 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:40:50 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:40:50 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:40:50 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:40:50 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:40:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:52 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:40:52 INFO - Installing collected packages: mozsystemmonitor 04:40:52 INFO - Running setup.py install for mozsystemmonitor 04:40:52 INFO - Successfully installed mozsystemmonitor 04:40:52 INFO - Cleaning up... 04:40:52 INFO - Return code: 0 04:40:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:52 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:52 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:40:52 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:40:52 INFO - Using env: {'DISPLAY': ':0', 04:40:52 INFO - 'HOME': '/home/cltbld', 04:40:52 INFO - 'LANG': 'en_US.UTF-8', 04:40:52 INFO - 'LANGUAGE': 'en_US:en', 04:40:52 INFO - 'LOGNAME': 'cltbld', 04:40:52 INFO - 'MAIL': '/var/mail/cltbld', 04:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:52 INFO - 'MOZ_NO_REMOTE': '1', 04:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:52 INFO - 'NO_EM_RESTART': '1', 04:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:52 INFO - 'PWD': '/builds/slave/test', 04:40:52 INFO - 'SHELL': '/bin/bash', 04:40:52 INFO - 'SHLVL': '1', 04:40:52 INFO - 'TERM': 'linux', 04:40:52 INFO - 'TMOUT': '86400', 04:40:52 INFO - 'USER': 'cltbld', 04:40:52 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:52 INFO - '_': '/tools/buildbot/bin/python'} 04:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 INFO - Downloading docopt-0.6.1.tar.gz 04:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:54 INFO - Running setup.py install for blobuploader 04:40:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:55 INFO - Running setup.py install for requests 04:40:55 INFO - Running setup.py install for docopt 04:40:55 INFO - Successfully installed blobuploader requests docopt 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40: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:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:55 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:40:55 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:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:55 INFO - Running setup.py (path:/tmp/pip-iHxHO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:55 INFO - Running setup.py (path:/tmp/pip-3V0UIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:55 INFO - Running setup.py (path:/tmp/pip-goW8xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:55 INFO - Running setup.py (path:/tmp/pip-mdryJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:56 INFO - Running setup.py (path:/tmp/pip-L1aLdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:56 INFO - Running setup.py (path:/tmp/pip-lQY0J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:56 INFO - Running setup.py (path:/tmp/pip-zUSyJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:56 INFO - Running setup.py (path:/tmp/pip-w0Lzxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:56 INFO - Running setup.py (path:/tmp/pip-caKIlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:56 INFO - Running setup.py (path:/tmp/pip-36lxQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:56 INFO - Running setup.py (path:/tmp/pip-MWasn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:56 INFO - Running setup.py (path:/tmp/pip-S40f34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:56 INFO - Running setup.py (path:/tmp/pip-KIa50W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:56 INFO - Running setup.py (path:/tmp/pip-zLSjeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:56 INFO - Running setup.py (path:/tmp/pip-0pNn5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:56 INFO - Running setup.py (path:/tmp/pip-Ac7aav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:56 INFO - Running setup.py (path:/tmp/pip-MMD2Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:56 INFO - Running setup.py install for manifestparser 04:40:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozcrash 04:40:57 INFO - Running setup.py install for mozdebug 04:40:57 INFO - Running setup.py install for mozdevice 04:40:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozfile 04:40:57 INFO - Running setup.py install for mozhttpd 04:40:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozinfo 04:40:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozInstall 04:40:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for mozleak 04:40:57 INFO - Running setup.py install for mozlog 04:40:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:57 INFO - Running setup.py install for moznetwork 04:40:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Running setup.py install for mozprocess 04:40:58 INFO - Running setup.py install for mozprofile 04:40:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Running setup.py install for mozrunner 04:40:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Running setup.py install for mozscreenshot 04:40:58 INFO - Running setup.py install for moztest 04:40:58 INFO - Running setup.py install for mozversion 04:40:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:58 INFO - Cleaning up... 04:40:58 INFO - Return code: 0 04:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:40:58 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:40:58 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:40:58 INFO - Using env: {'DISPLAY': ':0', 04:40:58 INFO - 'HOME': '/home/cltbld', 04:40:58 INFO - 'LANG': 'en_US.UTF-8', 04:40:58 INFO - 'LANGUAGE': 'en_US:en', 04:40:58 INFO - 'LOGNAME': 'cltbld', 04:40:58 INFO - 'MAIL': '/var/mail/cltbld', 04:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:58 INFO - 'MOZ_NO_REMOTE': '1', 04:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:58 INFO - 'NO_EM_RESTART': '1', 04:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:58 INFO - 'PWD': '/builds/slave/test', 04:40:58 INFO - 'SHELL': '/bin/bash', 04:40:58 INFO - 'SHLVL': '1', 04:40:58 INFO - 'TERM': 'linux', 04:40:58 INFO - 'TMOUT': '86400', 04:40:58 INFO - 'USER': 'cltbld', 04:40:58 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:58 INFO - '_': '/tools/buildbot/bin/python'} 04:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:58 INFO - Running setup.py (path:/tmp/pip-3taVps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:59 INFO - Running setup.py (path:/tmp/pip-iPdtVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:59 INFO - Running setup.py (path:/tmp/pip-XTOmAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:59 INFO - Running setup.py (path:/tmp/pip-F5PGmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:59 INFO - Running setup.py (path:/tmp/pip-kUQqWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:59 INFO - Running setup.py (path:/tmp/pip-aOrJen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:59 INFO - Running setup.py (path:/tmp/pip-KHkL9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:59 INFO - Running setup.py (path:/tmp/pip-pN2G07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:59 INFO - Running setup.py (path:/tmp/pip-gWiuku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:59 INFO - Running setup.py (path:/tmp/pip-ianS3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:59 INFO - Running setup.py (path:/tmp/pip-7kTk3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:59 INFO - Running setup.py (path:/tmp/pip-ZanWf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:59 INFO - Running setup.py (path:/tmp/pip-mV_QTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:59 INFO - Running setup.py (path:/tmp/pip-nZjX7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:59 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:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:59 INFO - Running setup.py (path:/tmp/pip-iY5QTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:00 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:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:00 INFO - Running setup.py (path:/tmp/pip-nPKINN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:00 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:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:00 INFO - Running setup.py (path:/tmp/pip-abZ4QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:01 INFO - Downloading blessings-1.5.1.tar.gz 04:41:01 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:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:01 INFO - Installing collected packages: blessings 04:41:01 INFO - Running setup.py install for blessings 04:41:02 INFO - Successfully installed blessings 04:41:02 INFO - Cleaning up... 04:41:02 INFO - Return code: 0 04:41:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:02 INFO - Reading from file tmpfile_stdout 04:41:02 INFO - Current package versions: 04:41:02 INFO - argparse == 1.2.1 04:41:02 INFO - blessings == 1.5.1 04:41:02 INFO - blobuploader == 1.2.4 04:41:02 INFO - docopt == 0.6.1 04:41:02 INFO - manifestparser == 1.1 04:41:02 INFO - mozInstall == 1.12 04:41:02 INFO - mozcrash == 0.16 04:41:02 INFO - mozdebug == 0.1 04:41:02 INFO - mozdevice == 0.47 04:41:02 INFO - mozfile == 1.2 04:41:02 INFO - mozhttpd == 0.7 04:41:02 INFO - mozinfo == 0.9 04:41:02 INFO - mozleak == 0.1 04:41:02 INFO - mozlog == 3.1 04:41:02 INFO - moznetwork == 0.27 04:41:02 INFO - mozprocess == 0.22 04:41:02 INFO - mozprofile == 0.27 04:41:02 INFO - mozrunner == 6.11 04:41:02 INFO - mozscreenshot == 0.1 04:41:02 INFO - mozsystemmonitor == 0.0 04:41:02 INFO - moztest == 0.7 04:41:02 INFO - mozversion == 1.4 04:41:02 INFO - psutil == 3.1.1 04:41:02 INFO - requests == 1.2.3 04:41:02 INFO - wsgiref == 0.1.2 04:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', '-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 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:41:02 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:41:02 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:41:02 INFO - Using env: {'DISPLAY': ':0', 04:41:02 INFO - 'HOME': '/home/cltbld', 04:41:02 INFO - 'LANG': 'en_US.UTF-8', 04:41:02 INFO - 'LANGUAGE': 'en_US:en', 04:41:02 INFO - 'LOGNAME': 'cltbld', 04:41:02 INFO - 'MAIL': '/var/mail/cltbld', 04:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:02 INFO - 'MOZ_NO_REMOTE': '1', 04:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:02 INFO - 'NO_EM_RESTART': '1', 04:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:02 INFO - 'PWD': '/builds/slave/test', 04:41:02 INFO - 'SHELL': '/bin/bash', 04:41:02 INFO - 'SHLVL': '1', 04:41:02 INFO - 'TERM': 'linux', 04:41:02 INFO - 'TMOUT': '86400', 04:41:02 INFO - 'USER': 'cltbld', 04:41:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:02 INFO - '_': '/tools/buildbot/bin/python'} 04:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 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:41:02 INFO - Cleaning up... 04:41:02 INFO - Return code: 0 04:41:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41: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:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:41: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', 'jsonschema'] in /builds/slave/test/build 04:41: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 jsonschema 04:41:02 INFO - Using env: {'DISPLAY': ':0', 04:41:02 INFO - 'HOME': '/home/cltbld', 04:41:02 INFO - 'LANG': 'en_US.UTF-8', 04:41:02 INFO - 'LANGUAGE': 'en_US:en', 04:41:02 INFO - 'LOGNAME': 'cltbld', 04:41:02 INFO - 'MAIL': '/var/mail/cltbld', 04:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:02 INFO - 'MOZ_NO_REMOTE': '1', 04:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:02 INFO - 'NO_EM_RESTART': '1', 04:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:02 INFO - 'PWD': '/builds/slave/test', 04:41:02 INFO - 'SHELL': '/bin/bash', 04:41:02 INFO - 'SHLVL': '1', 04:41:02 INFO - 'TERM': 'linux', 04:41:02 INFO - 'TMOUT': '86400', 04:41:02 INFO - 'USER': 'cltbld', 04:41:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:02 INFO - '_': '/tools/buildbot/bin/python'} 04:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:02 INFO - Downloading/unpacking jsonschema 04:41: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:41: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:41: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:41: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:41: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:41: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:41:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:04 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:41:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:04 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:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:04 INFO - warning: no files found matching '*.txt' 04:41:04 INFO - no previously-included directories found matching 'build' 04:41:04 INFO - no previously-included directories found matching 'dist' 04:41:04 INFO - no previously-included directories found matching '.git*' 04:41:04 INFO - Installing collected packages: jsonschema, functools32 04:41:04 INFO - Running setup.py install for functools32 04:41:04 INFO - warning: no files found matching '*.txt' 04:41:04 INFO - no previously-included directories found matching 'build' 04:41:04 INFO - no previously-included directories found matching 'dist' 04:41:04 INFO - no previously-included directories found matching '.git*' 04:41:04 INFO - Successfully installed jsonschema functools32 04:41:04 INFO - Cleaning up... 04:41:04 INFO - Return code: 0 04:41:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:41: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:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc5fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', '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:41: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', 'flake8'] in /builds/slave/test/build 04:41: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 flake8 04:41:04 INFO - Using env: {'DISPLAY': ':0', 04:41:04 INFO - 'HOME': '/home/cltbld', 04:41:04 INFO - 'LANG': 'en_US.UTF-8', 04:41:04 INFO - 'LANGUAGE': 'en_US:en', 04:41:04 INFO - 'LOGNAME': 'cltbld', 04:41:04 INFO - 'MAIL': '/var/mail/cltbld', 04:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:04 INFO - 'MOZ_NO_REMOTE': '1', 04:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:04 INFO - 'NO_EM_RESTART': '1', 04:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:04 INFO - 'PWD': '/builds/slave/test', 04:41:04 INFO - 'SHELL': '/bin/bash', 04:41:04 INFO - 'SHLVL': '1', 04:41:04 INFO - 'TERM': 'linux', 04:41:04 INFO - 'TMOUT': '86400', 04:41:04 INFO - 'USER': 'cltbld', 04:41:04 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:04 INFO - '_': '/tools/buildbot/bin/python'} 04:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:05 INFO - Downloading/unpacking flake8 04:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:41:06 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:41:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:41:06 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:41:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:07 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:41:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:07 INFO - no previously-included directories found matching 'docs/_build' 04:41:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:41:07 INFO - Running setup.py install for pep8 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:07 INFO - no previously-included directories found matching 'docs/_build' 04:41:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:41:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:41:07 INFO - Cleaning up... 04:41:07 INFO - Return code: 0 04:41:07 INFO - Running post-action listener: _resource_record_post_action 04:41:07 INFO - Running post-action listener: _start_resource_monitoring 04:41:07 INFO - Starting resource monitoring. 04:41:07 INFO - ##### 04:41:07 INFO - ##### Running install step. 04:41:07 INFO - ##### 04:41:07 INFO - Running pre-action listener: _resource_record_pre_action 04:41:07 INFO - Running main action method: install 04:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:07 INFO - Reading from file tmpfile_stdout 04:41:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:08 INFO - Reading from file tmpfile_stdout 04:41:08 INFO - Output received: 04:41:08 INFO - Usage: mozinstall [options] installer 04:41:08 INFO - Options: 04:41:08 INFO - -h, --help show this help message and exit 04:41:08 INFO - -d DEST, --destination=DEST 04:41:08 INFO - Directory to install application into. [default: 04:41:08 INFO - "/builds/slave/test"] 04:41:08 INFO - --app=APP Application being installed. [default: firefox] 04:41:08 INFO - mkdir: /builds/slave/test/build/application 04:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:41:22 INFO - Reading from file tmpfile_stdout 04:41:22 INFO - Output received: 04:41:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:41:22 INFO - Running post-action listener: _resource_record_post_action 04:41:22 INFO - ##### 04:41:22 INFO - ##### Running run-tests step. 04:41:22 INFO - ##### 04:41:22 INFO - Running pre-action listener: _resource_record_pre_action 04:41:22 INFO - Running main action method: run_tests 04:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:22 INFO - Python 2.7.3 04:41:22 INFO - Return code: 0 04:41:22 INFO - grabbing minidump binary from tooltool 04:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:22 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 0x25dc0b0>, '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 0x25dcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:22 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:41:22 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:41:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:22 INFO - Return code: 0 04:41:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:41:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:41:23 INFO - Return code: 0 04:41:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test/build 04:41:23 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 04:41:23 INFO - Using env: {'DISPLAY': ':0', 04:41:23 INFO - 'HOME': '/home/cltbld', 04:41:23 INFO - 'LANG': 'en_US.UTF-8', 04:41:23 INFO - 'LANGUAGE': 'en_US:en', 04:41:23 INFO - 'LOGNAME': 'cltbld', 04:41:23 INFO - 'MAIL': '/var/mail/cltbld', 04:41:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:23 INFO - 'MOZ_NO_REMOTE': '1', 04:41:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:23 INFO - 'NO_EM_RESTART': '1', 04:41:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:23 INFO - 'PWD': '/builds/slave/test', 04:41:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:23 INFO - 'SHELL': '/bin/bash', 04:41:23 INFO - 'SHLVL': '1', 04:41:23 INFO - 'TERM': 'linux', 04:41:23 INFO - 'TMOUT': '86400', 04:41:23 INFO - 'USER': 'cltbld', 04:41:23 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859', 04:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:23 INFO - '_': '/tools/buildbot/bin/python'} 04:41:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 04:41:23 INFO - mozversion INFO | application_buildid: 20151216033305 04:41:23 INFO - mozversion INFO | application_changeset: 01cff68d5e39022df92399bd8eb00b7165027e17 04:41:23 INFO - mozversion INFO | application_display_name: Nightly 04:41:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:23 INFO - mozversion INFO | application_name: Firefox 04:41:23 INFO - mozversion INFO | application_remotingname: firefox 04:41:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:41:23 INFO - mozversion INFO | application_vendor: Mozilla 04:41:23 INFO - mozversion INFO | application_version: 46.0a1 04:41:23 INFO - mozversion INFO | platform_buildid: 20151216033305 04:41:23 INFO - mozversion INFO | platform_changeset: 01cff68d5e39022df92399bd8eb00b7165027e17 04:41:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:41:23 INFO - mozversion INFO | platform_version: 46.0a1 04:41:23 INFO - 2015-12-16 04:41:23,944 DEBUG : using testdate: 1450269683 04:41:23 INFO - 2015-12-16 04:41:23,944 DEBUG : actual date: 1450269683 04:41:23 INFO - 2015-12-16 04:41:23,992 INFO : starting webserver on 'localhost:32982' 04:41:23 INFO - 2015-12-16 04:41:23,993 INFO : Starting test suite talos-linux64-ix-062.e 04:41:23 INFO - 2015-12-16 04:41:23,993 INFO : Starting test dromaeo_css 04:41:23 INFO - 2015-12-16 04:41:23,993 DEBUG : operating with platform_type : linux_ 04:41:23 INFO - 2015-12-16 04:41:23,994 INFO : Initialising browser for dromaeo_css test... 04:41:24 INFO - 2015-12-16 04:41:24,007 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUNyCME/profile http://localhost:32982/getInfo.html 04:41:28 INFO - 2015-12-16 04:41:28,839 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:28 INFO - 2015-12-16 04:41:28,839 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:28 INFO - 2015-12-16 04:41:28,839 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:41:28 INFO - 2015-12-16 04:41:28,839 DEBUG : BROWSER_OUTPUT: __metrics 04:41:28 INFO - 2015-12-16 04:41:28,956 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:41:29 INFO - 2015-12-16 04:41:29,921 INFO : Browser initialized. 04:41:29 INFO - 2015-12-16 04:41:29,922 INFO : Running cycle 1/1 for dromaeo_css test... 04:41:29 INFO - 2015-12-16 04:41:29,922 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUNyCME/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:41 INFO - 2015-12-16 04:41:41,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 142954496 04:41:41 INFO - 2015-12-16 04:41:41,969 DEBUG : BROWSER_OUTPUT: 04:42:31 INFO - 2015-12-16 04:42:31,614 DEBUG : BROWSER_OUTPUT: 1450269751610 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:44:43 INFO - 2015-12-16 04:44:43,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32982/tests/dromaeo/cssquery-ext.html) 04:44:44 INFO - 2015-12-16 04:44:44,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 145821696 04:44:44 INFO - 2015-12-16 04:44:44,435 DEBUG : BROWSER_OUTPUT: 04:47:46 INFO - 2015-12-16 04:47:46,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-ext.html (next: http://localhost:32982/tests/dromaeo/cssquery-jquery.html) 04:47:47 INFO - 2015-12-16 04:47:47,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 144605184 04:47:47 INFO - 2015-12-16 04:47:47,190 DEBUG : BROWSER_OUTPUT: 04:50:48 INFO - 2015-12-16 04:50:48,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32982/tests/dromaeo/cssquery-mootools.html) 04:50:49 INFO - 2015-12-16 04:50:49,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 144515072 04:50:49 INFO - 2015-12-16 04:50:49,578 DEBUG : BROWSER_OUTPUT: 04:53:51 INFO - 2015-12-16 04:53:51,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32982/tests/dromaeo/cssquery-prototype.html) 04:53:51 INFO - 2015-12-16 04:53:51,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 143044608 04:53:51 INFO - 2015-12-16 04:53:51,997 DEBUG : BROWSER_OUTPUT: 04:56:54 INFO - 2015-12-16 04:56:54,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32982/tests/dromaeo/cssquery-yui.html) 04:56:55 INFO - 2015-12-16 04:56:55,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 145354752 04:56:55 INFO - 2015-12-16 04:56:55,336 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-12-16 04:59:57,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/dromaeo/cssquery-yui.html (next: http://localhost:32982/tests/dromaeo/cssquery-dojo.html) 04:59:58 INFO - 2015-12-16 04:59:58,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 147140608 04:59:58 INFO - 2015-12-16 04:59:58,037 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,038 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:59:58 INFO - 2015-12-16 04:59:58,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:59:58 INFO - 2015-12-16 04:59:58,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:59:58 INFO - 2015-12-16 04:59:58,039 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:59:58 INFO - 2015-12-16 04:59:58,040 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2678.7321267873217;2713.59296105584;2746.6841313248983;2759.1170825335894;2760.696323404425;4644.721316720999;4784.928226076611;4807.519248075191;4822.614190864731;4822.951770482294;4683.4379874415035;4711.458182309036;4734.526547345264;4826.9758651206785;4831.251156070814;4253.106847562;4303.870883873489;4373.868783936471;4389.736615803046;4443.866683999485;4276.700630955835;4434.645228381722;4452.042810795679;4490.326451032339;4510.458744950611;4300.569943005706;4362.541933097027;4413.337999300099;4440.600345968878;4449.377087207794;4387.078713470175;4432.667549933735;4456.844010459618;4482.618977386926;4492.865214043584;4270.5515920828175;4365.43249377582;4409;4415.271480205763;4465.486469056068;4554;4606.309053641947;4694;4728.527147285278;4766.73782941938;5075.314832497603;5152.819651312224;5161.432242453365;5171.844844654666;5210.062188806013;4916.287138364953;5050.469700681412;5200.193969934666;5206.297149884755;5211.530962213419;4648.697834640738;4722.929156062662;4745.098431298043;4760.404949381327;4783.402074740658;5312.946870531323;5337.839864804062;5341.145416733304;5345.599080069011;5358.11591087474;4823.879403014953;4926.5073492650445;4929.383827021622;5041.2438134280155;5109.3613298337705;5186.92219616706;5208.427073021964;5212.50481204285;5215.061288968022;5258.605604579672;5055.0648130095315;5068.670536415121;5113.079645663742;5137.768800403991;5166.276721259027;4797.9040419192115;4957.900841983213;4964.950350496521;5112.744362781846;5113.1052065888325;4239;4249.5113061997645;4258.87223383299;4277.443932288783;4311.396404503372;3745.7190710696805;3770.8680196193;3778.4332350147697;3787.223619158066;3798.5441746990537;4253.893652658709;4344.804483798237;4360.106178233455;4365.192439398721;4369.628581570539;5197.194434862602;5201.401838788588;5220.765065572058;5240.973795131076;5243.501867322599;4487.6634252431195;4495.505494395614;4502.842400515966;4503.954960450354;4526;4394.2969124939855;4472.530384309665;4499.752513611783;4589.79345929434;4598.908021839545;4890.853274401774;4917.729524876095;4921.384826896638;4942.530459606475;4961.751912404293;5122.743862806919;5130.923036154386;5176.327077479904;5188.7405629717605;5238.71187084714;4737.526247375235;4802.975985120052;4850.975745121252;4862.878428039327;4889.022195560831;5093.617978651542;5125.231215317732;5153.896922061463;5158.432572416956;5183.067047931258;4994.101061808764;5232.869178270574;5247.16045432729;5253.527182553588;5258.368995720538;4857.611391088775;4906.337644417958;4921.581665558468;4937.259411088366;5001.974990125026;4999.8750031248055;5023.447420783784;5030.723310217973;5035.370578677665;5079.339685840817;4746.288056791509;4930.802767889388;4932.506749325039;4939.506049395031;4947.554720075211;4916.385451818523;4953.529414705597;4981.37732783402;4998.60011199096;5026.170681837456;4948.727819969792;4959.305697202467;4974.751262436791;4986.825461108844;5001.349824522788 04:59:58 INFO - 2015-12-16 04:59:58,041 DEBUG : BROWSER_OUTPUT: |1;ext.html;536.1796451429313;557.3952261795953;565.5447364871279;571.9456651618098;617.287033476335;32169.678303216962;32727.509087363647;32749.345013099723;32768.180795480126;32831.99999999997;35858.46212306811;35997.64002359976;36367.636323636754;36377.81811090947;36573;7402.518836275652;7542.509736867086;7575.128860181095;7609;7611.733589324374;7540.3967682585535;7612.657430415645;7640.35057020154;7640.7325743598985;7662.348700360476;7655.464117511777;7741.651625676858;7745;7749.225077492262;7758;7588.772336829904;7711.652975616111;7759.224077592252;7763.728269510569;7772.494787838829;7631.580263085528;7759.340456061242;7779.455438119334;7787.610619469004;7794.649240784178;34196.658033419844;34751.4787278191;34903.650963490545;34993.475097873554;34998.65001349979;2834.4472827798586;2956.9260768480744;3122.1414111119398;3257.218267615779;3631.4371272452813;27624.447511049668;27938.860305698545;27983.440331193262;28176.295592610142;28317.85841070802;3330.68358505944;3341.248219150696;3365.2764655599162;3378.1048022274117;3481.773684710511;195468;197056;197398;197824;198475;54802;55694.44305556973;55734.72132639311;55751.44248557543;55779.721101394236;54946.450535494136;56231;65772.67113664401;67691.26161168769;68001.65999169972;14737.484188053366;14831;14917.179555124572;14920.17939013343;15021.248937553079;11111.666650000512;11225.943870280596;11237.438128093563;11272.210945233755;11294.378809165575;19021.71467427962;19073;19223.807761922202;19269.325573605136;19332.32336868231;7507;7805.71639829931;7851.254130857559;7866.842663146705;7949.562774047367;822.5064961023338;830.0620299062142;831.0110967948123;877.8332116897769;898.573177740568;26034.73965260323;26521.46957060848;26580.335491612477;26669.466610667678;26720.866395667897;938.2540880000416;979.583676937313;982.6953644370268;983.6114734679761;991.9256055795844;13524.526641567498;13715.451381944611;13878.097923635134;13901.513447029305;14989.175595342362;296358;298757;299464;300903;301404;46441.30338044932;46466;46787;47117.293240601415;47191.5280847194;1217.6286232699113;1223.6206775899323;1224.7489264700714;1239.832622595938;1246.2709315050615;26438.94244230286;26539;27159.86420067887;27202.863985679945;27307.180784576496;38602;39086;39158.41262381124;39213.41179882247;39229.215415692095;244530;244809;244943;245146;245619;28514.714852851204;41907;42245;42984.78507607442;43279.567204327555;43629.34555981599;45644.54355456536;45926.54073459223;46333;46380;31569.368612628077;36962.8151859239;38905.6109438902;39208.607913920496;39435.21129577335;31950.201244969063;31960;32123.51814722828;32223;36533.26933461369;32622;32910;33025.66974330226;33146.50280245847;33171.33657326888;28785.856070719514;29543.409131816814;29899.701002989692;34037.65962340444;35555;23125.537489249786;23276;23300.650490242322;23312.3006309811;23601.40996475102 04:59:58 INFO - 2015-12-16 04:59:58,044 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.0540392305466;341.7300332737138;341.9794812311261;342.2590092449846;345.0098218114013;14913.701725965475;15254.694906101886;16136.919315403407;16751.162441877917;17318.91340543297;10072.949635251833;10430.895691043088;14726.852731472682;16217.83782162178;16330;4575.1078539684695;4720.622350211992;4744.5492678195515;4850.951490485103;4935.383077115361;4986.626003049786;5011.298418221452;5019.046381187581;5029.497050294978;5181.6113791465605;4733.5976442002475;4897.951020489785;4923.089228492722;5867.501262392701;5907.468327850493;5052.545270925616;5058.24126381044;5071.239314102877;5074.619403544749;5079.568236699885;5086.491350864884;5136.845894623168;5142.971405718871;5152.9484705152845;5174.068667639824;10569.630062947837;10757.623483178051;14522.782158267635;19394.515137121543;19544.12051457688;1837.3569250762125;1862.8602854785809;1888.4712280561464;1895.7440745499318;1938.709193620954;8981.640734370618;9353.204977576914;11002.33985960837;12704.555340563036;13016.763407476275;1694.4238958754083;1714.1086634949756;1730.2127531972922;1756.8418842304127;1773.8580913526887;53019;55420.72289638526;55856.16215756767;55859;56330;9777;9887.851682224773;9910.702678919644;9947.10476057144;10026.949865250626;12626.873731262753;12647.43086561107;12677.429515671816;12688.238705677504;12730.745385092247;6877;6943.722251109899;6971.860562788817;6976.127984002;7053.612051337123;6596.406323430914;6621.370969757865;6626.56927299724;6654.234763002317;6673.065770792093;4037.0916543778003;4070.470838790938;4194.203101410722;4201.180769749931;4262.957370426318;1602.9759553606705;1747.1700942052678;1793.1661777273368;1804.404546499652;1805.7562229098903;865.9220670139717;925.9398139121071;995.1740055753708;998.9850152247722;1023.2070145637042;15606.45377411808;16889;16989.23548440323;17308.394206202724;17580.560485987953;826.9856373518492;850.6002178975872;850.8425941200898;853.0914575976689;879.8416285068749;8353.122922093215;8415.621297041647;8606.78483037929;8695.043545210021;8797.956010219908;443075;449784;468727;473706;475333;70793.64603177054;71798.2820171802;71814;72455;74396.51206975938;1122.6126986189752;1130.886911308879;1171.8886705762939;1181.8345431639405;1190.6487586162102;13811.447542098605;13977.650558736113;13981.720365592835;13988.930055349658;14168.433262669378;31066.582675906084;31164;31601.89393371221;32151.839240803645;32614.83692581522;39267.80366098151;39479.407808882315;40296.597034030456;40889.38665919954;40982.38526422166;8036.67853285862;8403.285720713564;8419.8737018946;8735.956320218358;8741.256993155654;9923.900760992297;9932.950335248277;9977.351472154287;10004.699859004242;12242.632721018384;13427.19436833793;13484.730305393641;13510.121842080232;13519.188848668718;13773.449062037405;12669.93665031669;13005.349732513147;13119.803202951773;13327.133736307496;13473.191608503521;13230.735385292433;13759.79360309576;13821.585352439442;14460.927695361455;14572.635684107558;8269;8722.738317850475;9306.162445379949;9326.160645541933;9376.062393760569;9234.307426942873;12296.81554776697;13220.867791321964;13570.185788852701;13629.38667759973 04:59:58 INFO - 2015-12-16 04:59:58,045 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1471.345251363144;1681.840225178608;1723.6294196747704;1733.7486064520645;1752.2290192315381;7042.260562640926;7312.780616581511;7463.738769143081;7614.124375696797;7651.4261430392735;7460.962695186517;7496.137944136412;7515.736949206779;7583.393328533718;7658.731944381948;2083.697863809743;2117.2589593642256;2118.5762847430497;2120;2123.5115923337644;2082.208760670943;2122.7877212278804;2133.605283022646;2134.8078672919432;2151.741790985076;1988.2245924089616;2079.1267667579577;2086.9791302087015;2106.73665791776;2135.2099723102474;2028.7362642856408;2092.424583239606;2104.5580428110115;2108.325335892515;2118.639831228687;2073.5749171419825;2115.471132216946;2122.0450797141193;2134.274346722122;2144.9571008579896;7409.296116868943;7462.291082347168;7464.626768661546;7465.664045117983;7471.7011319547155;4195.307774217251;4258.829646814123;4261.382099595572;4283.871483855458;4305.9569404306185;2793.539066054099;2822.1815673454676;2850.087971849009;2876.8417737024456;2887.2781804548863;872.1365847810686;906.0984320600978;908.1009800297658;1726.9050202238873;1747.274880924415;9713.271504637181;9848.606055757833;9873.703788886345;9881.950590247076;9924.255680823968;3798.4872042273937;3817.8663746769284;3868.400397938324;3883.49514563105;3889.3582558878034;7928.65212913806;7938.880916786253;8052.758417247492;8077.919220807834;8080.19198080199;4218;4259.212045771542;4266.2960611499375;4267.210566045292;4281.715485354382;3968.3253846846105;3987.1228329767405;3990.2219067281603;3999.140184860269;4022.9798851006144;3107.5960125183583;3120.547520609499;3121.484954982448;3151.0389331254187;3152.2592190835135;953.1040821627648;955.4458414119932;955.8183945050557;962.6534447598859;965.8116667249819;795.3835777272544;871.4379225399582;953.3136141977765;1014.4420568687193;1112.866456025282;6746.831329216809;6864.862702745917;6867.622280774505;6877.105976223059;6877.312268773083;1061.2412125330425;1067.9698619502076;1072.1690689715533;1091.7161538000018;1109.378747901178;5231.346081739783;5302.178162384759;5319.069162896478;5335.932813437328;5348.57211423093;8657.610407531676;8895.421797583136;8958.10418958099;8996.190342869173;9019.503927284062;8598.226159645537;8742.431741936754;8781.2535934445;8803.69187078462;8843.204111629984;6571.244306904767;6655.534112612071;6694.129763130762;6733.696983635748;6745.56153850008;6690.799276021728;6753.898691519533;6768.56004359715;6801.707675541631;6826.556273842184;7254.129504459287;7626.8093297668;7790.532568045709;7794.532328060334;7847;7825.843483130419;7851;7879.803004924923;7968.402369822171;8023.759287221393;6417.7753778617525;6422;6447.2263328400895;6473.449756770728;6480.967595161994;7009.1939426966555;7016.859662806817;7036.401905837856;7067.646617669199;7099.964500177466;6312.147860038836;6464.644444555406;6493.8701225976165;6620.735170593122;6753;6375.139356186855;6390.52071094679;6401.3598640135615;6409.198850143732;6533.477321814338;6379.649119298483;6402.6158430494315;6428.774992875227;6447.935520644921;6461.806145815445;5716.571257155813;5935.169076329404;5968.970155149196;5970.5522085844605;6037.366076561898;6022.728977196124;6088.695565221809;6097.420745029215;6151.200343955257;6197.132401463708 04:59:58 INFO - 2015-12-16 04:59:58,047 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.99850500747493;304.7029146582083;310.4551512096272;311.50315247180737;314.4293108008962;5616.241807356011;5649.6892670903135;5652.180433837091;5821.3305469870975;5851.005329094053;5597.4402559744;5677.48902598766;5679.971600142004;5698.202251684757;5707.286589176353;4231.132617813356;4332;4333.544977777336;4339.2406328892475;4358.673099517533;4348.21732088224;4379.846705365313;4380.211561918869;4384.89037774055;4395.318725597537;4344.847930322439;4346.369776382423;4347.826086956534;4348.760818155;4349.673774466912;4321.308590625516;4346.500152482442;4350.825966961318;4353.368761529577;4377.693561450668;3699.426588878728;3810.1427178884805;3812.504374431334;3828.5214348206473;3844.480995065658;5270.631055826094;5355.758990845421;5409.83770486886;5410.1343784994215;5426.457354264581;4949.034938187055;4978.626603004753;4981.501849815026;4986.2769898364895;4992.101421744084;5945.910811337833;5957;5961.374055724174;5962.747822957184;5992.790252341147;3988.760674359519;4108;4125.1749650069805;4142.565030671796;4167.2082304362075;6176.938230617681;6209.9379006210265;6225.346338634424;6251.468625166866;6256.343083976162;4262.339337402707;4292.978535107304;4293.184294983943;4295.72077814941;4296.334068219431;4338.175746608134;4362.367456718758;4375.606195442426;4387.2103021455805;4407.581279778416;4826.372571565674;4949.876253093701;4969;4972.701637901665;5004.699718016858;5924.822255332347;5930.05119180929;5940.910886336708;5950.375210602911;5974.850628734316;1530.3878448620642;1542.0978727444347;1556.167450414023;1557.0346385241223;1558.462330495977;1046.1839764983324;1063.2557209952909;1067.4449286371043;1072.962446314391;1087.1628845788857;5147.0992576298995;5149.124648809711;5149.356330458692;5157.922631160535;5163.845084647392;6114.388561143939;6123.4795042421;6162.322144564095;6176.845578860564;6183.752649894044;5107.668001579886;5120.61595380348;5126.512981266774;5144.254083157921;5154.793808247703;3233.1593785615437;3302.620198677135;3317.568716066896;3318.93362132756;3332.0670212340583;5685.630434021776;5803.477687008105;5820.351739958309;5843.737031833578;5872.559558033079;6326.177596912464;6365.777197798147;6397.808065758035;6404.103425520431;6412.807615771534;5762.596618236683;5802.593818432753;5806.970965145232;5812.68030258323;5820.854478638068;5981.700914954148;6171.47542458896;6197.504199664107;6201.6899155041165;6207.689615519115;6052.092186172109;6059.121427393092;6061.848453788691;6076.665783381956;6083.117947897442;5823.94176058234;5850.970745146247;5857.619254748428;5869.765209391577;5869.7945571904775;4111.97944010278;4149.792510374529;4151.501819781645;4152.2525945330135;4161.167766446662;6028.698565071817;6205.81382558524;6206;6207.689615519296;6227.19046523949;5850.356460789225;5850.619709719025;5860.736266867916;5916.201312822714;5944.940550594439;5903.439173278532;5914.053751399755;5920.911186332122;5929.644221346733;5934.080217566284;5698.14197521645;5751.539876809761;5805.216295800182;5814.069748840166;5826.679532625746;5984.341722410619;5990.880182396415;5991.430814072656;5992.460678538952;5994.130851026664;5796.159556864315;5826.41735826414;5828.184054232495;5832.475077243069;5835.708214589338 04:59:58 INFO - 2015-12-16 04:59:58,050 DEBUG : BROWSER_OUTPUT: |5;yui.html;623.2489849731074;647.7085311609777;720.6324774365072;732.9628575565575;752.6876346316279;11390.943045284772;11539.249948753346;11616.24494407863;11693.181477296592;11700.473478693459;13515.189088654688;14085.507007254748;14100.78848817266;14119.647008824759;14177.291135443238;810.3881569415083;812.8333691593209;825.1707034430389;827.6772058897035;831.3390854270839;814.8451794159091;821.8438496685641;826.8470332988386;827.0241115483727;827.730987429085;856.9100244474334;857.4598003257938;858.3776761847641;861.2162931732125;861.8448679237734;847.9406441549094;849.235687880906;856.7729551668782;856.7858035491128;859.896812382515;630.2185290240116;630.4357599948021;639.4788247578256;639.6034458635629;642.139533025743;12393.318367489876;12453.315067671274;12453.813192802025;12553.246805191719;12665.493380264777;10819.945900270526;10902.781944361148;11129.833052504138;11259.042981346596;11331.43342832855;9094.226990705798;9141.54292285383;9339.3462457628;9650.08324209199;9759.072888075621;3084.4910589752662;3104.161876293411;3124.2814152744995;3167.4773662345915;3220.3237320162793;40432.59567404318;40863.7956810214;40940.79529602333;41093.79453102745;41186.588134118574;8955.238804701543;8979.551022448852;9090.727278181665;9203.113361760823;9292.488913109844;15722.606934826721;15729.056256624639;15731;15765.054096754231;15791.921040394724;6131.693415329216;6238.65687387189;6250.562460627712;6351.237851457762;6555.311692272243;3446.362422951712;3577.5885773136424;3583.1937813991644;3587.8698210063744;3602.657747513982;2464.9137280195464;2500.912468063609;2513.5852584323748;2516.5218608464334;2537.4163942293376;468.08255818595933;471.9315699223662;472.9408823897013;480.9374781278481;480.9495003024632;471.9362886010413;532.8747744280091;570.5806232419169;601.6119602856133;634.511426201822;7913.564753938474;8175.67297308101;8187.918120818835;8201.13888041759;8337.82462023672;461.5937974582346;476.12630822441207;528.6193940362932;586.4370204603543;605.5942518512519;3845.5962123977138;3861.9806900965314;3865.8646947356706;3908.964124507008;4009.2382447334912;47773.76113119482;48091;48103.278450823265;48363;48575;39185;39271.41092883609;39586.60413395887;40893.591064089575;43512;38971.22057558889;39095.41356879649;39381.40927886084;39553.2089358217;40608.39087413691;7861.567613781297;8142.389320801082;8270.214329638675;8277.710280140167;8299.128591498047;30058;30272;30309.39381212319;30669.8466507666;30732.84633576818;35833.1041723959;37021.62978370182;38789.41815872708;39009.2198156041;39101.6089839098;10088.64689735885;10217.1826253901;10267.94866025665;10335.586576537155;10371.481425928825;11217.326960382403;11456.828147577626;11494.195406321478;11570.710732231762;11616.244944078608;10449.529771160469;10575.841362379724;10578.682639520826;10634.468276586294;10693.304935179189;10689.465526723789;11001.339919604849;11010.944945275221;11116.610918618133;11147.108231341635;10629.734256643645;11249.66251012471;11292.49183786748;11339.092872570009;11373.658790236306;8449.28181104613;8594.957025214833;8805.42764720291;8978.55107244622;9118.726438206864;8517.701880434155;8780.692675756318;8795.824083518422;9035.954820225857;9225.630974761203 04:59:58 INFO - 2015-12-16 04:59:58,050 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:59:58 INFO - 2015-12-16 04:59:58,050 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:59:58 INFO - 2015-12-16 04:59:58,050 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270798036__endTimestamp 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,051 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4735.28 Median:4862.88 stddev:505.66 (10.4%) stddev-sans-first:480.78 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: Values: 2678.7 2713.6 2746.7 2759.1 2760.7 4644.7 4784.9 4807.5 4822.6 4823.0 4683.4 4711.5 4734.5 4827.0 4831.3 4253.1 4303.9 4373.9 4389.7 4443.9 4276.7 4434.6 4452.0 4490.3 4510.5 4300.6 4362.5 4413.3 4440.6 4449.4 4387.1 4432.7 4456.8 4482.6 4492.9 4270.6 4365.4 4409.0 4415.3 4465.5 4554.0 4606.3 4694.0 4728.5 4766.7 5075.3 5152.8 5161.4 5171.8 5210.1 4916.3 5050.5 5200.2 5206.3 5211.5 4648.7 4722.9 4745.1 4760.4 4783.4 5312.9 5337.8 5341.1 5345.6 5358.1 4823.9 4926.5 4929.4 5041.2 5109.4 5186.9 5208.4 5212.5 5215.1 5258.6 5055.1 5068.7 5113.1 5137.8 5166.3 4797.9 4957.9 4965.0 5112.7 5113.1 4239.0 4249.5 4258.9 4277.4 4311.4 3745.7 3770.9 3778.4 3787.2 3798.5 4253.9 4344.8 4360.1 4365.2 4369.6 5197.2 5201.4 5220.8 5241.0 5243.5 4487.7 4495.5 4502.8 4504.0 4526.0 4394.3 4472.5 4499.8 4589.8 4598.9 4890.9 4917.7 4921.4 4942.5 4961.8 5122.7 5130.9 5176.3 5188.7 5238.7 4737.5 4803.0 4851.0 4862.9 4889.0 5093.6 5125.2 5153.9 5158.4 5183.1 4994.1 5232.9 5247.2 5253.5 5258.4 4857.6 4906.3 4921.6 4937.3 5002.0 4999.9 5023.4 5030.7 5035.4 5079.3 4746.3 4930.8 4932.5 4939.5 4947.6 4916.4 4953.5 4981.4 4998.6 5026.2 4948.7 4959.3 4974.8 4986.8 5001.3 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41380.61 Median:19192.71 stddev:65495.70 (341.3%) stddev-sans-first:65607.63 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: Values: 536.2 557.4 565.5 571.9 617.3 32169.7 32727.5 32749.3 32768.2 32832.0 35858.5 35997.6 36367.6 36377.8 36573.0 7402.5 7542.5 7575.1 7609.0 7611.7 7540.4 7612.7 7640.4 7640.7 7662.3 7655.5 7741.7 7745.0 7749.2 7758.0 7588.8 7711.7 7759.2 7763.7 7772.5 7631.6 7759.3 7779.5 7787.6 7794.6 34196.7 34751.5 34903.7 34993.5 34998.7 2834.4 2956.9 3122.1 3257.2 3631.4 27624.4 27938.9 27983.4 28176.3 28317.9 3330.7 3341.2 3365.3 3378.1 3481.8 195468.0 197056.0 197398.0 197824.0 198475.0 54802.0 55694.4 55734.7 55751.4 55779.7 54946.5 56231.0 65772.7 67691.3 68001.7 14737.5 14831.0 14917.2 14920.2 15021.2 11111.7 11225.9 11237.4 11272.2 11294.4 19021.7 19073.0 19223.8 19269.3 19332.3 7507.0 7805.7 7851.3 7866.8 7949.6 822.5 830.1 831.0 877.8 898.6 26034.7 26521.5 26580.3 26669.5 26720.9 938.3 979.6 982.7 983.6 991.9 13524.5 13715.5 13878.1 13901.5 14989.2 296358.0 298757.0 299464.0 300903.0 301404.0 46441.3 46466.0 46787.0 47117.3 47191.5 1217.6 1223.6 1224.7 1239.8 1246.3 26438.9 26539.0 27159.9 27202.9 27307.2 38602.0 39086.0 39158.4 39213.4 39229.2 244530.0 244809.0 244943.0 245146.0 245619.0 28514.7 41907.0 42245.0 42984.8 43279.6 43629.3 45644.5 45926.5 46333.0 46380.0 31569.4 36962.8 38905.6 39208.6 39435.2 31950.2 31960.0 32123.5 32223.0 36533.3 32622.0 32910.0 33025.7 33146.5 33171.3 28785.9 29543.4 29899.7 34037.7 35555.0 23125.5 23276.0 23300.7 23312.3 23601.4 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25328.32 Median:22479.93 stddev:75559.01 (336.1%) stddev-sans-first:75747.67 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: Values: 339.1 341.7 342.0 342.3 345.0 14913.7 15254.7 16136.9 16751.2 17318.9 10072.9 10430.9 14726.9 16217.8 16330.0 4575.1 4720.6 4744.5 4851.0 4935.4 4986.6 5011.3 5019.0 5029.5 5181.6 4733.6 4898.0 4923.1 5867.5 5907.5 5052.5 5058.2 5071.2 5074.6 5079.6 5086.5 5136.8 5143.0 5152.9 5174.1 10569.6 10757.6 14522.8 19394.5 19544.1 1837.4 1862.9 1888.5 1895.7 1938.7 8981.6 9353.2 11002.3 12704.6 13016.8 1694.4 1714.1 1730.2 1756.8 1773.9 53019.0 55420.7 55856.2 55859.0 56330.0 9777.0 9887.9 9910.7 9947.1 10026.9 12626.9 12647.4 12677.4 12688.2 12730.7 6877.0 6943.7 6971.9 6976.1 7053.6 6596.4 6621.4 6626.6 6654.2 6673.1 4037.1 4070.5 4194.2 4201.2 4263.0 1603.0 1747.2 1793.2 1804.4 1805.8 865.9 925.9 995.2 999.0 1023.2 15606.5 16889.0 16989.2 17308.4 17580.6 827.0 850.6 850.8 853.1 879.8 8353.1 8415.6 8606.8 8695.0 8798.0 443075.0 449784.0 468727.0 473706.0 475333.0 70793.6 71798.3 71814.0 72455.0 74396.5 1122.6 1130.9 1171.9 1181.8 1190.6 13811.4 13977.7 13981.7 13988.9 14168.4 31066.6 31164.0 31601.9 32151.8 32614.8 39267.8 39479.4 40296.6 40889.4 40982.4 8036.7 8403.3 8419.9 8736.0 8741.3 9923.9 9933.0 9977.4 10004.7 12242.6 13427.2 13484.7 13510.1 13519.2 13773.4 12669.9 13005.3 13119.8 13327.1 13473.2 13230.7 13759.8 13821.6 14460.9 14572.6 8269.0 8722.7 9306.2 9326.2 9376.1 9234.3 12296.8 13220.9 13570.2 13629.4 04:59:58 INFO - 2015-12-16 04:59:58,052 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,053 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5077.19 Median:6413.49 stddev:2627.07 (41.0%) stddev-sans-first:2620.46 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: Values: 1471.3 1681.8 1723.6 1733.7 1752.2 7042.3 7312.8 7463.7 7614.1 7651.4 7461.0 7496.1 7515.7 7583.4 7658.7 2083.7 2117.3 2118.6 2120.0 2123.5 2082.2 2122.8 2133.6 2134.8 2151.7 1988.2 2079.1 2087.0 2106.7 2135.2 2028.7 2092.4 2104.6 2108.3 2118.6 2073.6 2115.5 2122.0 2134.3 2145.0 7409.3 7462.3 7464.6 7465.7 7471.7 4195.3 4258.8 4261.4 4283.9 4306.0 2793.5 2822.2 2850.1 2876.8 2887.3 872.1 906.1 908.1 1726.9 1747.3 9713.3 9848.6 9873.7 9882.0 9924.3 3798.5 3817.9 3868.4 3883.5 3889.4 7928.7 7938.9 8052.8 8077.9 8080.2 4218.0 4259.2 4266.3 4267.2 4281.7 3968.3 3987.1 3990.2 3999.1 4023.0 3107.6 3120.5 3121.5 3151.0 3152.3 953.1 955.4 955.8 962.7 965.8 795.4 871.4 953.3 1014.4 1112.9 6746.8 6864.9 6867.6 6877.1 6877.3 1061.2 1068.0 1072.2 1091.7 1109.4 5231.3 5302.2 5319.1 5335.9 5348.6 8657.6 8895.4 8958.1 8996.2 9019.5 8598.2 8742.4 8781.3 8803.7 8843.2 6571.2 6655.5 6694.1 6733.7 6745.6 6690.8 6753.9 6768.6 6801.7 6826.6 7254.1 7626.8 7790.5 7794.5 7847.0 7825.8 7851.0 7879.8 7968.4 8023.8 6417.8 6422.0 6447.2 6473.4 6481.0 7009.2 7016.9 7036.4 7067.6 7100.0 6312.1 6464.6 6493.9 6620.7 6753.0 6375.1 6390.5 6401.4 6409.2 6533.5 6379.6 6402.6 6428.8 6447.9 6461.8 5716.6 5935.2 5969.0 5970.6 6037.4 6022.7 6088.7 6097.4 6151.2 6197.1 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4922.83 Median:5606.84 stddev:1448.91 (25.8%) stddev-sans-first:1410.80 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: Values: 299.0 304.7 310.5 311.5 314.4 5616.2 5649.7 5652.2 5821.3 5851.0 5597.4 5677.5 5680.0 5698.2 5707.3 4231.1 4332.0 4333.5 4339.2 4358.7 4348.2 4379.8 4380.2 4384.9 4395.3 4344.8 4346.4 4347.8 4348.8 4349.7 4321.3 4346.5 4350.8 4353.4 4377.7 3699.4 3810.1 3812.5 3828.5 3844.5 5270.6 5355.8 5409.8 5410.1 5426.5 4949.0 4978.6 4981.5 4986.3 4992.1 5945.9 5957.0 5961.4 5962.7 5992.8 3988.8 4108.0 4125.2 4142.6 4167.2 6176.9 6209.9 6225.3 6251.5 6256.3 4262.3 4293.0 4293.2 4295.7 4296.3 4338.2 4362.4 4375.6 4387.2 4407.6 4826.4 4949.9 4969.0 4972.7 5004.7 5924.8 5930.1 5940.9 5950.4 5974.9 1530.4 1542.1 1556.2 1557.0 1558.5 1046.2 1063.3 1067.4 1073.0 1087.2 5147.1 5149.1 5149.4 5157.9 5163.8 6114.4 6123.5 6162.3 6176.8 6183.8 5107.7 5120.6 5126.5 5144.3 5154.8 3233.2 3302.6 3317.6 3318.9 3332.1 5685.6 5803.5 5820.4 5843.7 5872.6 6326.2 6365.8 6397.8 6404.1 6412.8 5762.6 5802.6 5807.0 5812.7 5820.9 5981.7 6171.5 6197.5 6201.7 6207.7 6052.1 6059.1 6061.8 6076.7 6083.1 5823.9 5851.0 5857.6 5869.8 5869.8 4112.0 4149.8 4151.5 4152.3 4161.2 6028.7 6205.8 6206.0 6207.7 6227.2 5850.4 5850.6 5860.7 5916.2 5944.9 5903.4 5914.1 5920.9 5929.6 5934.1 5698.1 5751.5 5805.2 5814.1 5826.7 5984.3 5990.9 5991.4 5992.5 5994.1 5796.2 5826.4 5828.2 5832.5 5835.7 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12084.22 Median:40917.19 stddev:13276.53 (32.4%) stddev-sans-first:13285.88 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: Values: 623.2 647.7 720.6 733.0 752.7 11390.9 11539.2 11616.2 11693.2 11700.5 13515.2 14085.5 14100.8 14119.6 14177.3 810.4 812.8 825.2 827.7 831.3 814.8 821.8 826.8 827.0 827.7 856.9 857.5 858.4 861.2 861.8 847.9 849.2 856.8 856.8 859.9 630.2 630.4 639.5 639.6 642.1 12393.3 12453.3 12453.8 12553.2 12665.5 10819.9 10902.8 11129.8 11259.0 11331.4 9094.2 9141.5 9339.3 9650.1 9759.1 3084.5 3104.2 3124.3 3167.5 3220.3 40432.6 40863.8 40940.8 41093.8 41186.6 8955.2 8979.6 9090.7 9203.1 9292.5 15722.6 15729.1 15731.0 15765.1 15791.9 6131.7 6238.7 6250.6 6351.2 6555.3 3446.4 3577.6 3583.2 3587.9 3602.7 2464.9 2500.9 2513.6 2516.5 2537.4 468.1 471.9 472.9 480.9 480.9 471.9 532.9 570.6 601.6 634.5 7913.6 8175.7 8187.9 8201.1 8337.8 461.6 476.1 528.6 586.4 605.6 3845.6 3862.0 3865.9 3909.0 4009.2 47773.8 48091.0 48103.3 48363.0 48575.0 39185.0 39271.4 39586.6 40893.6 43512.0 38971.2 39095.4 39381.4 39553.2 40608.4 7861.6 8142.4 8270.2 8277.7 8299.1 30058.0 30272.0 30309.4 30669.8 30732.8 35833.1 37021.6 38789.4 39009.2 39101.6 10088.6 10217.2 10267.9 10335.6 10371.5 11217.3 11456.8 11494.2 11570.7 11616.2 10449.5 10575.8 10578.7 10634.5 10693.3 10689.5 11001.3 11010.9 11116.6 11147.1 10629.7 11249.7 11292.5 11339.1 11373.7 8449.3 8595.0 8805.4 8978.6 9118.7 8517.7 8780.7 8795.8 9036.0 9225.6 04:59:58 INFO - 2015-12-16 04:59:58,054 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:59:58 INFO - 2015-12-16 04:59:58,055 DEBUG : BROWSER_OUTPUT: 04:59:58 INFO - 2015-12-16 04:59:58,722 INFO : Browser exited with error code: 0 04:59:58 INFO - 2015-12-16 04:59:58,740 INFO : Completed test dromaeo_css (00:18:34) 04:59:58 INFO - 2015-12-16 04:59:58,741 INFO : Starting test kraken 04:59:58 INFO - 2015-12-16 04:59:58,741 DEBUG : operating with platform_type : linux_ 04:59:58 INFO - 2015-12-16 04:59:58,741 INFO : Initialising browser for kraken test... 04:59:58 INFO - 2015-12-16 04:59:58,747 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrk0bT/profile http://localhost:32982/getInfo.html 05:00:03 INFO - 2015-12-16 05:00:03,516 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:00:03 INFO - 2015-12-16 05:00:03,516 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:00:03 INFO - 2015-12-16 05:00:03,516 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:00:03 INFO - 2015-12-16 05:00:03,517 DEBUG : BROWSER_OUTPUT: __metrics 05:00:03 INFO - 2015-12-16 05:00:03,645 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] 05:00:04 INFO - 2015-12-16 05:00:04,550 INFO : Browser initialized. 05:00:04 INFO - 2015-12-16 05:00:04,550 INFO : Running cycle 1/1 for kraken test... 05:00:04 INFO - 2015-12-16 05:00:04,550 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrk0bT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:00:16 INFO - 2015-12-16 05:00:16,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 142966784 05:00:16 INFO - 2015-12-16 05:00:16,647 DEBUG : BROWSER_OUTPUT: 05:00:19 INFO - 2015-12-16 05:00:19,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32982/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:19 INFO - 2015-12-16 05:00:19,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 142876672 05:00:19 INFO - 2015-12-16 05:00:19,846 DEBUG : BROWSER_OUTPUT: 05:00:22 INFO - 2015-12-16 05:00:22,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32982/tests/kraken/driver.html?testName=audio-dft) 05:00:23 INFO - 2015-12-16 05:00:23,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 143228928 05:00:23 INFO - 2015-12-16 05:00:23,196 DEBUG : BROWSER_OUTPUT: 05:00:26 INFO - 2015-12-16 05:00:26,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32982/tests/kraken/driver.html?testName=audio-fft) 05:00:26 INFO - 2015-12-16 05:00:26,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 137805824 05:00:26 INFO - 2015-12-16 05:00:26,697 DEBUG : BROWSER_OUTPUT: 05:00:28 INFO - 2015-12-16 05:00:28,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32982/tests/kraken/driver.html?testName=audio-oscillator) 05:00:29 INFO - 2015-12-16 05:00:29,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 138076160 05:00:29 INFO - 2015-12-16 05:00:29,384 DEBUG : BROWSER_OUTPUT: 05:00:31 INFO - 2015-12-16 05:00:31,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32982/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:32 INFO - 2015-12-16 05:00:32,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 138645504 05:00:32 INFO - 2015-12-16 05:00:32,244 DEBUG : BROWSER_OUTPUT: 05:00:35 INFO - 2015-12-16 05:00:35,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32982/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:35 INFO - 2015-12-16 05:00:35,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 139431936 05:00:35 INFO - 2015-12-16 05:00:35,951 DEBUG : BROWSER_OUTPUT: 05:00:39 INFO - 2015-12-16 05:00:39,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32982/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:40 INFO - 2015-12-16 05:00:40,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 138231808 05:00:40 INFO - 2015-12-16 05:00:40,042 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-12-16 05:00:42,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32982/tests/kraken/driver.html?testName=json-parse-financial) 05:00:43 INFO - 2015-12-16 05:00:43,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 05:00:43 INFO - 2015-12-16 05:00:43,540 DEBUG : BROWSER_OUTPUT: 05:00:45 INFO - 2015-12-16 05:00:45,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32982/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:45 INFO - 2015-12-16 05:00:45,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 140849152 05:00:45 INFO - 2015-12-16 05:00:45,883 DEBUG : BROWSER_OUTPUT: 05:00:47 INFO - 2015-12-16 05:00:47,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:48 INFO - 2015-12-16 05:00:48,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 140292096 05:00:48 INFO - 2015-12-16 05:00:48,432 DEBUG : BROWSER_OUTPUT: 05:00:50 INFO - 2015-12-16 05:00:50,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:51 INFO - 2015-12-16 05:00:51,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 139939840 05:00:51 INFO - 2015-12-16 05:00:51,198 DEBUG : BROWSER_OUTPUT: 05:00:53 INFO - 2015-12-16 05:00:53,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:54 INFO - 2015-12-16 05:00:54,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 05:00:54 INFO - 2015-12-16 05:00:54,407 DEBUG : BROWSER_OUTPUT: 05:00:57 INFO - 2015-12-16 05:00:57,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:57 INFO - 2015-12-16 05:00:57,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 05:00:57 INFO - 2015-12-16 05:00:57,678 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32982/tests/kraken/driver.html?testName=ai-astar) 05:00:59 INFO - 2015-12-16 05:00:59,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 139980800 05:00:59 INFO - 2015-12-16 05:00:59,730 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,731 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:00:59 INFO - 2015-12-16 05:00:59,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:00:59 INFO - 2015-12-16 05:00:59,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:00:59 INFO - 2015-12-16 05:00:59,733 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:00:59 INFO - 2015-12-16 05:00:59,733 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;111;116;115;114;128;116;115;117;116 05:00:59 INFO - 2015-12-16 05:00:59,733 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;133;153;170;138;154;157;136;164;133 05:00:59 INFO - 2015-12-16 05:00:59,734 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;163;163;165;167;167;165;167;164 05:00:59 INFO - 2015-12-16 05:00:59,734 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;73;74;73;73;140;72;73;74 05:00:59 INFO - 2015-12-16 05:00:59,734 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;139;95;96;96;131;96;95;134 05:00:59 INFO - 2015-12-16 05:00:59,734 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;111;111;110;110;110;110;112;110 05:00:59 INFO - 2015-12-16 05:00:59,734 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;149;149;149;151;149;150;148;150 05:00:59 INFO - 2015-12-16 05:00:59,735 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;99;96;96;96;97;97;96;97;96 05:00:59 INFO - 2015-12-16 05:00:59,735 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;76;73;75;73;73;72;72;72 05:00:59 INFO - 2015-12-16 05:00:59,735 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;69;69;70;70;69;70;69 05:00:59 INFO - 2015-12-16 05:00:59,735 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;92;87;86;94;87;88;87;86;87 05:00:59 INFO - 2015-12-16 05:00:59,736 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;122;139;126;127;126;129;123;124;132 05:00:59 INFO - 2015-12-16 05:00:59,736 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;157;154;160;155;156;161;145;163;139 05:00:59 INFO - 2015-12-16 05:00:59,736 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;73;72;71;71;72;70;72;71;73 05:00:59 INFO - 2015-12-16 05:00:59,736 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:00:59 INFO - 2015-12-16 05:00:59,736 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:00:59 INFO - 2015-12-16 05:00:59,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,781 05:00:59 INFO - 2015-12-16 05:00:59,737 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:00:59 INFO - 2015-12-16 05:00:59,737 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270859731__endTimestamp 05:00:59 INFO - 2015-12-16 05:00:59,737 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:00:59 INFO - 2015-12-16 05:00:59,741 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:00:59 INFO - 2015-12-16 05:00:59,741 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,741 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.30 Median:116.00 stddev:4.42 (3.8%) stddev-sans-first:4.67 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: Values: 115.0 111.0 116.0 115.0 114.0 128.0 116.0 115.0 117.0 116.0 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.50 stddev:13.97 (9.0%) stddev-sans-first:14.02 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: Values: 163.0 133.0 153.0 170.0 138.0 154.0 157.0 136.0 164.0 133.0 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.60 (1.0%) stddev-sans-first:1.66 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 163.0 163.0 165.0 167.0 167.0 165.0 167.0 164.0 05:00:59 INFO - 2015-12-16 05:00:59,742 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:21.10 (28.9%) stddev-sans-first:22.30 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 73.0 74.0 73.0 73.0 140.0 72.0 73.0 74.0 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:96.00 stddev:18.92 (19.7%) stddev-sans-first:19.61 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 139.0 95.0 96.0 96.0 131.0 96.0 95.0 134.0 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,743 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 112.0 110.0 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 149.0 149.0 149.0 151.0 149.0 150.0 148.0 150.0 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: Values: 96.0 99.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 05:00:59 INFO - 2015-12-16 05:00:59,744 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.50 stddev:1.35 (1.8%) stddev-sans-first:1.41 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 76.0 73.0 75.0 73.0 73.0 72.0 72.0 72.0 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 69.0 70.0 70.0 69.0 70.0 69.0 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:87.50 stddev:3.41 (3.9%) stddev-sans-first:2.82 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: Values: 95.0 92.0 87.0 86.0 94.0 87.0 88.0 87.0 86.0 87.0 05:00:59 INFO - 2015-12-16 05:00:59,745 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:4.99 (3.9%) stddev-sans-first:5.27 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: Values: 129.0 122.0 139.0 126.0 127.0 126.0 129.0 123.0 124.0 132.0 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:156.50 stddev:8.18 (5.2%) stddev-sans-first:7.78 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: Values: 143.0 157.0 154.0 160.0 155.0 156.0 161.0 145.0 163.0 139.0 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.20 (1.7%) stddev-sans-first:1.00 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 71.0 71.0 72.0 70.0 72.0 71.0 73.0 05:00:59 INFO - 2015-12-16 05:00:59,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:00:59 INFO - 2015-12-16 05:00:59,747 DEBUG : BROWSER_OUTPUT: 05:01:00 INFO - 2015-12-16 05:01:00,674 INFO : Browser exited with error code: 0 05:01:00 INFO - 2015-12-16 05:01:00,729 INFO : Completed test kraken (00:01:01) 05:01:00 INFO - 2015-12-16 05:01:00,729 INFO : Starting test v8_7 05:01:00 INFO - 2015-12-16 05:01:00,729 DEBUG : operating with platform_type : linux_ 05:01:00 INFO - 2015-12-16 05:01:00,729 INFO : Initialising browser for v8_7 test... 05:01:00 INFO - 2015-12-16 05:01:00,735 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVn0me/profile http://localhost:32982/getInfo.html 05:01:05 INFO - 2015-12-16 05:01:05,524 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:01:05 INFO - 2015-12-16 05:01:05,524 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:01:05 INFO - 2015-12-16 05:01:05,524 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:01:05 INFO - 2015-12-16 05:01:05,524 DEBUG : BROWSER_OUTPUT: __metrics 05:01:05 INFO - 2015-12-16 05:01:05,633 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] 05:01:06 INFO - 2015-12-16 05:01:06,562 INFO : Browser initialized. 05:01:06 INFO - 2015-12-16 05:01:06,562 INFO : Running cycle 1/1 for v8_7 test... 05:01:06 INFO - 2015-12-16 05:01:06,562 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVn0me/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:01:18 INFO - 2015-12-16 05:01:18,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 142827520 05:01:18 INFO - 2015-12-16 05:01:18,618 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32982/tests/v8_7/run.html (next: http://localhost:32982/tests/v8_7/run.html) 05:01:40 INFO - 2015-12-16 05:01:40,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 05:01:40 INFO - 2015-12-16 05:01:40,377 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,377 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:40 INFO - 2015-12-16 05:01:40,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:40 INFO - 2015-12-16 05:01:40,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0982334489021 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.39117538005192 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.19052956010086 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1081.081081081081 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |5;Earley;726.2164124909223 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |8;Splay;597.7488151658767 05:01:40 INFO - 2015-12-16 05:01:40,378 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: __startTimestamp1450270900371__endTimestamp 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.10 Median:165.10 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,379 DEBUG : BROWSER_OUTPUT: Values: 165.1 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.39 Median:185.39 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: Values: 185.4 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: Values: 280.2 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: Values: 5207.3 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: Values: 1081.1 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,380 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:726.22 Median:726.22 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: Values: 726.2 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: Values: 12120.5 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: Values: 26256.4 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.75 Median:597.75 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: Values: 597.7 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: Values: 4850.2 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:40 INFO - 2015-12-16 05:01:40,381 DEBUG : BROWSER_OUTPUT: 05:01:41 INFO - 2015-12-16 05:01:41,302 INFO : Browser exited with error code: 0 05:01:41 INFO - 2015-12-16 05:01:41,314 INFO : Completed test v8_7 (00:00:40) 05:01:41 INFO - 2015-12-16 05:01:41,372 INFO : Completed test suite (00:20:17) 05:01:41 INFO - 2015-12-16 05:01:41,373 DEBUG : Working with test: dromaeo_css 05:01:41 INFO - 2015-12-16 05:01:41,373 DEBUG : Generating results file: dromaeo_css 05:01:41 INFO - 2015-12-16 05:01:41,374 DEBUG : Working with test: kraken 05:01:41 INFO - 2015-12-16 05:01:41,374 DEBUG : Generating results file: kraken 05:01:41 INFO - 2015-12-16 05:01:41,374 INFO : javascript benchmark 05:01:41 INFO - 2015-12-16 05:01:41,375 DEBUG : Working with test: v8_7 05:01:41 INFO - 2015-12-16 05:01:41,375 DEBUG : Generating results file: v8_7 05:01:41 INFO - 2015-12-16 05:01:41,375 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:41 INFO - 2015-12-16 05:01:41,429 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:01:41 INFO - 2015-12-16 05:01:41,429 DEBUG : process_Request line: dromaeo_css 6417.48 graph.html#tests=[[72,132,43]] 05:01:41 INFO - 2015-12-16 05:01:41,429 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:41 INFO - 2015-12-16 05:01:41,462 DEBUG : process_Request line: kraken 1559.20 graph.html#tests=[[232,132,43]] 05:01:41 INFO - 2015-12-16 05:01:41,462 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:41 INFO - 2015-12-16 05:01:41,496 DEBUG : process_Request line: v8_7 21306.36 graph.html#tests=[[230,132,43]] 05:01:41 INFO - 2015-12-16 05:01:41,497 INFO : javascript benchmark 05:01:41 INFO - 2015-12-16 05:01:41,500 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2678.7321267873217, 2713.59296105584, 2746.6841313248983, 2759.1170825335894, 2760.696323404425, 4644.721316720999, 4784.928226076611, 4807.519248075191, 4822.614190864731, 4822.951770482294, 4683.4379874415035, 4711.458182309036, 4734.526547345264, 4826.9758651206785, 4831.251156070814, 4253.106847562, 4303.870883873489, 4373.868783936471, 4389.736615803046, 4443.866683999485, 4276.700630955835, 4434.645228381722, 4452.042810795679, 4490.326451032339, 4510.458744950611, 4300.569943005706, 4362.541933097027, 4413.337999300099, 4440.600345968878, 4449.377087207794, 4387.078713470175, 4432.667549933735, 4456.844010459618, 4482.618977386926, 4492.865214043584, 4270.5515920828175, 4365.43249377582, 4409.0, 4415.271480205763, 4465.486469056068, 4554.0, 4606.309053641947, 4694.0, 4728.527147285278, 4766.73782941938, 5075.314832497603, 5152.819651312224, 5161.432242453365, 5171.844844654666, 5210.062188806013, 4916.287138364953, 5050.469700681412, 5200.193969934666, 5206.297149884755, 5211.530962213419, 4648.697834640738, 4722.929156062662, 4745.098431298043, 4760.404949381327, 4783.402074740658, 5312.946870531323, 5337.839864804062, 5341.145416733304, 5345.599080069011, 5358.11591087474, 4823.879403014953, 4926.5073492650445, 4929.383827021622, 5041.2438134280155, 5109.3613298337705, 5186.92219616706, 5208.427073021964, 5212.50481204285, 5215.061288968022, 5258.605604579672, 5055.0648130095315, 5068.670536415121, 5113.079645663742, 5137.768800403991, 5166.276721259027, 4797.9040419192115, 4957.900841983213, 4964.950350496521, 5112.744362781846, 5113.1052065888325, 4239.0, 4249.5113061997645, 4258.87223383299, 4277.443932288783, 4311.396404503372, 3745.7190710696805, 3770.8680196193, 3778.4332350147697, 3787.223619158066, 3798.5441746990537, 4253.893652658709, 4344.804483798237, 4360.106178233455, 4365.192439398721, 4369.628581570539, 5197.194434862602, 5201.401838788588, 5220.765065572058, 5240.973795131076, 5243.501867322599, 4487.6634252431195, 4495.505494395614, 4502.842400515966, 4503.954960450354, 4526.0, 4394.2969124939855, 4472.530384309665, 4499.752513611783, 4589.79345929434, 4598.908021839545, 4890.853274401774, 4917.729524876095, 4921.384826896638, 4942.530459606475, 4961.751912404293, 5122.743862806919, 5130.923036154386, 5176.327077479904, 5188.7405629717605, 5238.71187084714, 4737.526247375235, 4802.975985120052, 4850.975745121252, 4862.878428039327, 4889.022195560831, 5093.617978651542, 5125.231215317732, 5153.896922061463, 5158.432572416956, 5183.067047931258, 4994.101061808764, 5232.869178270574, 5247.16045432729, 5253.527182553588, 5258.368995720538, 4857.611391088775, 4906.337644417958, 4921.581665558468, 4937.259411088366, 5001.974990125026, 4999.8750031248055, 5023.447420783784, 5030.723310217973, 5035.370578677665, 5079.339685840817, 4746.288056791509, 4930.802767889388, 4932.506749325039, 4939.506049395031, 4947.554720075211, 4916.385451818523, 4953.529414705597, 4981.37732783402, 4998.60011199096, 5026.170681837456, 4948.727819969792, 4959.305697202467, 4974.751262436791, 4986.825461108844, 5001.349824522788], "unit": "score", "name": "dojo.html", "value": 4703.317115832756}, {"lowerIsBetter": false, "replicates": [536.1796451429313, 557.3952261795953, 565.5447364871279, 571.9456651618098, 617.287033476335, 32169.678303216962, 32727.509087363647, 32749.345013099723, 32768.180795480126, 32831.99999999997, 35858.46212306811, 35997.64002359976, 36367.636323636754, 36377.81811090947, 36573.0, 7402.518836275652, 7542.509736867086, 7575.128860181095, 7609.0, 7611.733589324374, 7540.3967682585535, 7612.657430415645, 7640.35057020154, 7640.7325743598985, 7662.348700360476, 7655.464117511777, 7741.651625676858, 7745.0, 7749.225077492262, 7758.0, 7588.772336829904, 7711.652975616111, 7759.224077592252, 7763.728269510569, 7772.494787838829, 7631.580263085528, 7759.340456061242, 7779.455438119334, 7787.610619469004, 7794.649240784178, 34196.658033419844, 34751.4787278191, 34903.650963490545, 34993.475097873554, 34998.65001349979, 2834.4472827798586, 2956.9260768480744, 3122.1414111119398, 3257.218267615779, 3631.4371272452813, 27624.447511049668, 27938.860305698545, 27983.440331193262, 28176.295592610142, 28317.85841070802, 3330.68358505944, 3341.248219150696, 3365.2764655599162, 3378.1048022274117, 3481.773684710511, 195468.0, 197056.0, 197398.0, 197824.0, 198475.0, 54802.0, 55694.44305556973, 55734.72132639311, 55751.44248557543, 55779.721101394236, 54946.450535494136, 56231.0, 65772.67113664401, 67691.26161168769, 68001.65999169972, 14737.484188053366, 14831.0, 14917.179555124572, 14920.17939013343, 15021.248937553079, 11111.666650000512, 11225.943870280596, 11237.438128093563, 11272.210945233755, 11294.378809165575, 19021.71467427962, 19073.0, 19223.807761922202, 19269.325573605136, 19332.32336868231, 7507.0, 7805.71639829931, 7851.254130857559, 7866.842663146705, 7949.562774047367, 822.5064961023338, 830.0620299062142, 831.0110967948123, 877.8332116897769, 898.573177740568, 26034.73965260323, 26521.46957060848, 26580.335491612477, 26669.466610667678, 26720.866395667897, 938.2540880000416, 979.583676937313, 982.6953644370268, 983.6114734679761, 991.9256055795844, 13524.526641567498, 13715.451381944611, 13878.097923635134, 13901.513447029305, 14989.175595342362, 296358.0, 298757.0, 299464.0, 300903.0, 301404.0, 46441.30338044932, 46466.0, 46787.0, 47117.293240601415, 47191.5280847194, 1217.6286232699113, 1223.6206775899323, 1224.7489264700714, 1239.832622595938, 1246.2709315050615, 26438.94244230286, 26539.0, 27159.86420067887, 27202.863985679945, 27307.180784576496, 38602.0, 39086.0, 39158.41262381124, 39213.41179882247, 39229.215415692095, 244530.0, 244809.0, 244943.0, 245146.0, 245619.0, 28514.714852851204, 41907.0, 42245.0, 42984.78507607442, 43279.567204327555, 43629.34555981599, 45644.54355456536, 45926.54073459223, 46333.0, 46380.0, 31569.368612628077, 36962.8151859239, 38905.6109438902, 39208.607913920496, 39435.21129577335, 31950.201244969063, 31960.0, 32123.51814722828, 32223.0, 36533.26933461369, 32622.0, 32910.0, 33025.66974330226, 33146.50280245847, 33171.33657326888, 28785.856070719514, 29543.409131816814, 29899.701002989692, 34037.65962340444, 35555.0, 23125.537489249786, 23276.0, 23300.650490242322, 23312.3006309811, 23601.40996475102], "unit": "score", "name": "ext.html", "value": 17086.367714051445}, {"lowerIsBetter": false, "replicates": [339.0540392305466, 341.7300332737138, 341.9794812311261, 342.2590092449846, 345.0098218114013, 14913.701725965475, 15254.694906101886, 16136.919315403407, 16751.162441877917, 17318.91340543297, 10072.949635251833, 10430.895691043088, 14726.852731472682, 16217.83782162178, 16330.0, 4575.1078539684695, 4720.622350211992, 4744.5492678195515, 4850.951490485103, 4935.383077115361, 4986.626003049786, 5011.298418221452, 5019.046381187581, 5029.497050294978, 5181.6113791465605, 4733.5976442002475, 4897.951020489785, 4923.089228492722, 5867.501262392701, 5907.468327850493, 5052.545270925616, 5058.24126381044, 5071.239314102877, 5074.619403544749, 5079.568236699885, 5086.491350864884, 5136.845894623168, 5142.971405718871, 5152.9484705152845, 5174.068667639824, 10569.630062947837, 10757.623483178051, 14522.782158267635, 19394.515137121543, 19544.12051457688, 1837.3569250762125, 1862.8602854785809, 1888.4712280561464, 1895.7440745499318, 1938.709193620954, 8981.640734370618, 9353.204977576914, 11002.33985960837, 12704.555340563036, 13016.763407476275, 1694.4238958754083, 1714.1086634949756, 1730.2127531972922, 1756.8418842304127, 1773.8580913526887, 53019.0, 55420.72289638526, 55856.16215756767, 55859.0, 56330.0, 9777.0, 9887.851682224773, 9910.702678919644, 9947.10476057144, 10026.949865250626, 12626.873731262753, 12647.43086561107, 12677.429515671816, 12688.238705677504, 12730.745385092247, 6877.0, 6943.722251109899, 6971.860562788817, 6976.127984002, 7053.612051337123, 6596.406323430914, 6621.370969757865, 6626.56927299724, 6654.234763002317, 6673.065770792093, 4037.0916543778003, 4070.470838790938, 4194.203101410722, 4201.180769749931, 4262.957370426318, 1602.9759553606705, 1747.1700942052678, 1793.1661777273368, 1804.404546499652, 1805.7562229098903, 865.9220670139717, 925.9398139121071, 995.1740055753708, 998.9850152247722, 1023.2070145637042, 15606.45377411808, 16889.0, 16989.23548440323, 17308.394206202724, 17580.560485987953, 826.9856373518492, 850.6002178975872, 850.8425941200898, 853.0914575976689, 879.8416285068749, 8353.122922093215, 8415.621297041647, 8606.78483037929, 8695.043545210021, 8797.956010219908, 443075.0, 449784.0, 468727.0, 473706.0, 475333.0, 70793.64603177054, 71798.2820171802, 71814.0, 72455.0, 74396.51206975938, 1122.6126986189752, 1130.886911308879, 1171.8886705762939, 1181.8345431639405, 1190.6487586162102, 13811.447542098605, 13977.650558736113, 13981.720365592835, 13988.930055349658, 14168.433262669378, 31066.582675906084, 31164.0, 31601.89393371221, 32151.839240803645, 32614.83692581522, 39267.80366098151, 39479.407808882315, 40296.597034030456, 40889.38665919954, 40982.38526422166, 8036.67853285862, 8403.285720713564, 8419.8737018946, 8735.956320218358, 8741.256993155654, 9923.900760992297, 9932.950335248277, 9977.351472154287, 10004.699859004242, 12242.632721018384, 13427.19436833793, 13484.730305393641, 13510.121842080232, 13519.188848668718, 13773.449062037405, 12669.93665031669, 13005.349732513147, 13119.803202951773, 13327.133736307496, 13473.191608503521, 13230.735385292433, 13759.79360309576, 13821.585352439442, 14460.927695361455, 14572.635684107558, 8269.0, 8722.738317850475, 9306.162445379949, 9326.160645541933, 9376.062393760569, 9234.307426942873, 12296.81554776697, 13220.867791321964, 13570.185788852701, 13629.38667759973], "unit": "score", "name": "jquery.html", "value": 8145.309011214806}, {"lowerIsBetter": false, "replicates": [1471.345251363144, 1681.840225178608, 1723.6294196747704, 1733.7486064520645, 1752.2290192315381, 7042.260562640926, 7312.780616581511, 7463.738769143081, 7614.124375696797, 7651.4261430392735, 7460.962695186517, 7496.137944136412, 7515.736949206779, 7583.393328533718, 7658.731944381948, 2083.697863809743, 2117.2589593642256, 2118.5762847430497, 2120.0, 2123.5115923337644, 2082.208760670943, 2122.7877212278804, 2133.605283022646, 2134.8078672919432, 2151.741790985076, 1988.2245924089616, 2079.1267667579577, 2086.9791302087015, 2106.73665791776, 2135.2099723102474, 2028.7362642856408, 2092.424583239606, 2104.5580428110115, 2108.325335892515, 2118.639831228687, 2073.5749171419825, 2115.471132216946, 2122.0450797141193, 2134.274346722122, 2144.9571008579896, 7409.296116868943, 7462.291082347168, 7464.626768661546, 7465.664045117983, 7471.7011319547155, 4195.307774217251, 4258.829646814123, 4261.382099595572, 4283.871483855458, 4305.9569404306185, 2793.539066054099, 2822.1815673454676, 2850.087971849009, 2876.8417737024456, 2887.2781804548863, 872.1365847810686, 906.0984320600978, 908.1009800297658, 1726.9050202238873, 1747.274880924415, 9713.271504637181, 9848.606055757833, 9873.703788886345, 9881.950590247076, 9924.255680823968, 3798.4872042273937, 3817.8663746769284, 3868.400397938324, 3883.49514563105, 3889.3582558878034, 7928.65212913806, 7938.880916786253, 8052.758417247492, 8077.919220807834, 8080.19198080199, 4218.0, 4259.212045771542, 4266.2960611499375, 4267.210566045292, 4281.715485354382, 3968.3253846846105, 3987.1228329767405, 3990.2219067281603, 3999.140184860269, 4022.9798851006144, 3107.5960125183583, 3120.547520609499, 3121.484954982448, 3151.0389331254187, 3152.2592190835135, 953.1040821627648, 955.4458414119932, 955.8183945050557, 962.6534447598859, 965.8116667249819, 795.3835777272544, 871.4379225399582, 953.3136141977765, 1014.4420568687193, 1112.866456025282, 6746.831329216809, 6864.862702745917, 6867.622280774505, 6877.105976223059, 6877.312268773083, 1061.2412125330425, 1067.9698619502076, 1072.1690689715533, 1091.7161538000018, 1109.378747901178, 5231.346081739783, 5302.178162384759, 5319.069162896478, 5335.932813437328, 5348.57211423093, 8657.610407531676, 8895.421797583136, 8958.10418958099, 8996.190342869173, 9019.503927284062, 8598.226159645537, 8742.431741936754, 8781.2535934445, 8803.69187078462, 8843.204111629984, 6571.244306904767, 6655.534112612071, 6694.129763130762, 6733.696983635748, 6745.56153850008, 6690.799276021728, 6753.898691519533, 6768.56004359715, 6801.707675541631, 6826.556273842184, 7254.129504459287, 7626.8093297668, 7790.532568045709, 7794.532328060334, 7847.0, 7825.843483130419, 7851.0, 7879.803004924923, 7968.402369822171, 8023.759287221393, 6417.7753778617525, 6422.0, 6447.2263328400895, 6473.449756770728, 6480.967595161994, 7009.1939426966555, 7016.859662806817, 7036.401905837856, 7067.646617669199, 7099.964500177466, 6312.147860038836, 6464.644444555406, 6493.8701225976165, 6620.735170593122, 6753.0, 6375.139356186855, 6390.52071094679, 6401.3598640135615, 6409.198850143732, 6533.477321814338, 6379.649119298483, 6402.6158430494315, 6428.774992875227, 6447.935520644921, 6461.806145815445, 5716.571257155813, 5935.169076329404, 5968.970155149196, 5970.5522085844605, 6037.366076561898, 6022.728977196124, 6088.695565221809, 6097.420745029215, 6151.200343955257, 6197.132401463708], "unit": "score", "name": "mootools.html", "value": 4183.103127031865}, {"lowerIsBetter": false, "replicates": [298.99850500747493, 304.7029146582083, 310.4551512096272, 311.50315247180737, 314.4293108008962, 5616.241807356011, 5649.6892670903135, 5652.180433837091, 5821.3305469870975, 5851.005329094053, 5597.4402559744, 5677.48902598766, 5679.971600142004, 5698.202251684757, 5707.286589176353, 4231.132617813356, 4332.0, 4333.544977777336, 4339.2406328892475, 4358.673099517533, 4348.21732088224, 4379.846705365313, 4380.211561918869, 4384.89037774055, 4395.318725597537, 4344.847930322439, 4346.369776382423, 4347.826086956534, 4348.760818155, 4349.673774466912, 4321.308590625516, 4346.500152482442, 4350.825966961318, 4353.368761529577, 4377.693561450668, 3699.426588878728, 3810.1427178884805, 3812.504374431334, 3828.5214348206473, 3844.480995065658, 5270.631055826094, 5355.758990845421, 5409.83770486886, 5410.1343784994215, 5426.457354264581, 4949.034938187055, 4978.626603004753, 4981.501849815026, 4986.2769898364895, 4992.101421744084, 5945.910811337833, 5957.0, 5961.374055724174, 5962.747822957184, 5992.790252341147, 3988.760674359519, 4108.0, 4125.1749650069805, 4142.565030671796, 4167.2082304362075, 6176.938230617681, 6209.9379006210265, 6225.346338634424, 6251.468625166866, 6256.343083976162, 4262.339337402707, 4292.978535107304, 4293.184294983943, 4295.72077814941, 4296.334068219431, 4338.175746608134, 4362.367456718758, 4375.606195442426, 4387.2103021455805, 4407.581279778416, 4826.372571565674, 4949.876253093701, 4969.0, 4972.701637901665, 5004.699718016858, 5924.822255332347, 5930.05119180929, 5940.910886336708, 5950.375210602911, 5974.850628734316, 1530.3878448620642, 1542.0978727444347, 1556.167450414023, 1557.0346385241223, 1558.462330495977, 1046.1839764983324, 1063.2557209952909, 1067.4449286371043, 1072.962446314391, 1087.1628845788857, 5147.0992576298995, 5149.124648809711, 5149.356330458692, 5157.922631160535, 5163.845084647392, 6114.388561143939, 6123.4795042421, 6162.322144564095, 6176.845578860564, 6183.752649894044, 5107.668001579886, 5120.61595380348, 5126.512981266774, 5144.254083157921, 5154.793808247703, 3233.1593785615437, 3302.620198677135, 3317.568716066896, 3318.93362132756, 3332.0670212340583, 5685.630434021776, 5803.477687008105, 5820.351739958309, 5843.737031833578, 5872.559558033079, 6326.177596912464, 6365.777197798147, 6397.808065758035, 6404.103425520431, 6412.807615771534, 5762.596618236683, 5802.593818432753, 5806.970965145232, 5812.68030258323, 5820.854478638068, 5981.700914954148, 6171.47542458896, 6197.504199664107, 6201.6899155041165, 6207.689615519115, 6052.092186172109, 6059.121427393092, 6061.848453788691, 6076.665783381956, 6083.117947897442, 5823.94176058234, 5850.970745146247, 5857.619254748428, 5869.765209391577, 5869.7945571904775, 4111.97944010278, 4149.792510374529, 4151.501819781645, 4152.2525945330135, 4161.167766446662, 6028.698565071817, 6205.81382558524, 6206.0, 6207.689615519296, 6227.19046523949, 5850.356460789225, 5850.619709719025, 5860.736266867916, 5916.201312822714, 5944.940550594439, 5903.439173278532, 5914.053751399755, 5920.911186332122, 5929.644221346733, 5934.080217566284, 5698.14197521645, 5751.539876809761, 5805.216295800182, 5814.069748840166, 5826.679532625746, 5984.341722410619, 5990.880182396415, 5991.430814072656, 5992.460678538952, 5994.130851026664, 5796.159556864315, 5826.41735826414, 5828.184054232495, 5832.475077243069, 5835.708214589338], "unit": "score", "name": "prototype.html", "value": 4455.571954918156}, {"lowerIsBetter": false, "replicates": [623.2489849731074, 647.7085311609777, 720.6324774365072, 732.9628575565575, 752.6876346316279, 11390.943045284772, 11539.249948753346, 11616.24494407863, 11693.181477296592, 11700.473478693459, 13515.189088654688, 14085.507007254748, 14100.78848817266, 14119.647008824759, 14177.291135443238, 810.3881569415083, 812.8333691593209, 825.1707034430389, 827.6772058897035, 831.3390854270839, 814.8451794159091, 821.8438496685641, 826.8470332988386, 827.0241115483727, 827.730987429085, 856.9100244474334, 857.4598003257938, 858.3776761847641, 861.2162931732125, 861.8448679237734, 847.9406441549094, 849.235687880906, 856.7729551668782, 856.7858035491128, 859.896812382515, 630.2185290240116, 630.4357599948021, 639.4788247578256, 639.6034458635629, 642.139533025743, 12393.318367489876, 12453.315067671274, 12453.813192802025, 12553.246805191719, 12665.493380264777, 10819.945900270526, 10902.781944361148, 11129.833052504138, 11259.042981346596, 11331.43342832855, 9094.226990705798, 9141.54292285383, 9339.3462457628, 9650.08324209199, 9759.072888075621, 3084.4910589752662, 3104.161876293411, 3124.2814152744995, 3167.4773662345915, 3220.3237320162793, 40432.59567404318, 40863.7956810214, 40940.79529602333, 41093.79453102745, 41186.588134118574, 8955.238804701543, 8979.551022448852, 9090.727278181665, 9203.113361760823, 9292.488913109844, 15722.606934826721, 15729.056256624639, 15731.0, 15765.054096754231, 15791.921040394724, 6131.693415329216, 6238.65687387189, 6250.562460627712, 6351.237851457762, 6555.311692272243, 3446.362422951712, 3577.5885773136424, 3583.1937813991644, 3587.8698210063744, 3602.657747513982, 2464.9137280195464, 2500.912468063609, 2513.5852584323748, 2516.5218608464334, 2537.4163942293376, 468.08255818595933, 471.9315699223662, 472.9408823897013, 480.9374781278481, 480.9495003024632, 471.9362886010413, 532.8747744280091, 570.5806232419169, 601.6119602856133, 634.511426201822, 7913.564753938474, 8175.67297308101, 8187.918120818835, 8201.13888041759, 8337.82462023672, 461.5937974582346, 476.12630822441207, 528.6193940362932, 586.4370204603543, 605.5942518512519, 3845.5962123977138, 3861.9806900965314, 3865.8646947356706, 3908.964124507008, 4009.2382447334912, 47773.76113119482, 48091.0, 48103.278450823265, 48363.0, 48575.0, 39185.0, 39271.41092883609, 39586.60413395887, 40893.591064089575, 43512.0, 38971.22057558889, 39095.41356879649, 39381.40927886084, 39553.2089358217, 40608.39087413691, 7861.567613781297, 8142.389320801082, 8270.214329638675, 8277.710280140167, 8299.128591498047, 30058.0, 30272.0, 30309.39381212319, 30669.8466507666, 30732.84633576818, 35833.1041723959, 37021.62978370182, 38789.41815872708, 39009.2198156041, 39101.6089839098, 10088.64689735885, 10217.1826253901, 10267.94866025665, 10335.586576537155, 10371.481425928825, 11217.326960382403, 11456.828147577626, 11494.195406321478, 11570.710732231762, 11616.244944078608, 10449.529771160469, 10575.841362379724, 10578.682639520826, 10634.468276586294, 10693.304935179189, 10689.465526723789, 11001.339919604849, 11010.944945275221, 11116.610918618133, 11147.108231341635, 10629.734256643645, 11249.66251012471, 11292.49183786748, 11339.092872570009, 11373.658790236306, 8449.28181104613, 8594.957025214833, 8805.42764720291, 8978.55107244622, 9118.726438206864, 8517.701880434155, 8780.692675756318, 8795.824083518422, 9035.954820225857, 9225.630974761203], "unit": "score", "name": "yui.html", "value": 5725.059100416931}], "name": "dromaeo_css", "value": 6417.476577936388}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 116.0, 115.0, 114.0, 128.0, 116.0, 115.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [163.0, 133.0, 153.0, 170.0, 138.0, 154.0, 157.0, 136.0, 164.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 163.0, 165.0, 167.0, 167.0, 165.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 74.0, 73.0, 73.0, 140.0, 72.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 96.0, 131.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 112.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 149.0, 149.0, 149.0, 151.0, 149.0, 150.0, 148.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 149.1}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 73.0, 75.0, 73.0, 73.0, 72.0, 72.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 87.0, 86.0, 94.0, 87.0, 88.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 139.0, 126.0, 127.0, 126.0, 129.0, 123.0, 124.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [143.0, 157.0, 154.0, 160.0, 155.0, 156.0, 161.0, 145.0, 163.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 71.0, 71.0, 72.0, 70.0, 72.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1559.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0982334489021], "unit": "score", "name": "Richards", "value": 213.824214}, {"lowerIsBetter": false, "replicates": [185.39117538005192], "unit": "score", "name": "DeltaBlue", "value": 356.6404920000001}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [726.2164124909223], "unit": "score", "name": "Earley", "value": 917.719551}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [597.7488151658767], "unit": "score", "name": "Splay", "value": 136.32983944499506}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21306.362558729834}]} 05:01:41 INFO - RETURN: dromaeo_css: 6417.48 05:01:41 INFO - RETURN: kraken: 1559.20 05:01:41 INFO - RETURN: v8_7: 21306.36 05:01:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21306.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1559.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6417.48"}}} 05:01:41 INFO - Return code: 0 05:01:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:01:41 INFO - # TBPL SUCCESS # 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - Running post-run listener: _resource_record_post_run 05:01:42 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 522506240; Read time: 0; Write time: 552580 05:01:42 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244883456; Read time: 0; Write time: 378968 05:01:42 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 273616896; Read time: 0; Write time: 172880 05:01:42 INFO - Running post-run listener: _upload_blobber_files 05:01:42 INFO - Blob upload gear active. 05:01:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:01:42 INFO - Copying logs to upload dir... 05:01:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.753634 ========= master_lag: 14.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 05:01:56.348184) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.352837) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009913 build_url: 'https://queue.taskcluster.net/v1/task/VsKvFysITrqCqdBOMenaSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.47 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:01:56.834509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:01:56.834878) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450269624.581215-1976455859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 1.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 05:01:58.649713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:01:58.650071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:01:58.815696) ========= ========= Total master_lag: 16.56 =========