builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1449260233.27 results: success (0) buildid: 20151204113611 builduid: ce3f0cc682994afab06fa7ec9be424c4 revision: 3d8926eef121ba1b6b003011e2cac09c00782657 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.271580) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.272228) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.272705) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006222 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.298079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.298560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.312781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.313174) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.362996) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.363294) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.363637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.363908) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 12:17:13-- 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% 47.3M=0s 2015-12-04 12:17:13 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.526236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.526556) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021198 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.576137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:13.576491) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d8926eef121ba1b6b003011e2cac09c00782657 --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 3d8926eef121ba1b6b003011e2cac09c00782657 --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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 12:17:13,841 truncating revision to first 12 chars 2015-12-04 12:17:13,841 Setting DEBUG logging. 2015-12-04 12:17:13,841 attempt 1/10 2015-12-04 12:17:13,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d8926eef121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 12:17:14,483 unpacking tar archive at: fx-team-3d8926eef121/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:14.527438) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:14.527788) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:14.535352) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:14.535725) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 12:17:14.536233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-04 12:17:14.536592) ========= /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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:14 INFO - MultiFileLogger online at 20151204 12:17:14 in /builds/slave/test 12:17:14 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 12:17:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:14 INFO - {'append_to_log': False, 12:17:14 INFO - 'base_work_dir': '/builds/slave/test', 12:17:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:17:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:14 INFO - 'branch': 'Fx-Team-Non-PGO', 12:17:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:14 INFO - 'config_files': ('talos/linux_config.py',), 12:17:14 INFO - 'default_actions': ('clobber', 12:17:14 INFO - 'read-buildbot-config', 12:17:14 INFO - 'download-and-extract', 12:17:14 INFO - 'populate-webroot', 12:17:14 INFO - 'create-virtualenv', 12:17:14 INFO - 'install', 12:17:14 INFO - 'run-tests'), 12:17:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:14 INFO - 'download_minidump_stackwalk': True, 12:17:14 INFO - 'download_symbols': 'ondemand', 12:17:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:14 INFO - 'installer_path': 'installer.exe', 12:17:14 INFO - 'log_level': 'info', 12:17:14 INFO - 'log_name': 'talos', 12:17:14 INFO - 'log_to_console': True, 12:17:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:14 INFO - 'opt_config_files': (), 12:17:14 INFO - 'pip_index': False, 12:17:14 INFO - 'sps_profile': False, 12:17:14 INFO - 'sps_profile_interval': 0, 12:17:14 INFO - 'suite': 'dromaeojs-e10s', 12:17:14 INFO - 'system_bits': '64', 12:17:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:14 INFO - 'title': 'talos-linux64-ix-027', 12:17:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:14 INFO - 'use_talos_json': True, 12:17:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:14 INFO - 'work_dir': 'build'} 12:17:14 INFO - ##### 12:17:14 INFO - ##### Running clobber step. 12:17:14 INFO - ##### 12:17:14 INFO - Running pre-action listener: _resource_record_pre_action 12:17:14 INFO - Running main action method: clobber 12:17:14 INFO - rmtree: /builds/slave/test/build 12:17:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:15 INFO - Running post-action listener: _resource_record_post_action 12:17:15 INFO - ##### 12:17:15 INFO - ##### Running read-buildbot-config step. 12:17:15 INFO - ##### 12:17:15 INFO - Running pre-action listener: _resource_record_pre_action 12:17:15 INFO - Running main action method: read_buildbot_config 12:17:15 INFO - Using buildbot properties: 12:17:15 INFO - { 12:17:15 INFO - "properties": { 12:17:15 INFO - "buildnumber": 804, 12:17:15 INFO - "product": "firefox", 12:17:15 INFO - "script_repo_revision": "production", 12:17:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:17:15 INFO - "repository": "", 12:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:17:15 INFO - "buildid": "20151204113611", 12:17:15 INFO - "slavename": "talos-linux64-ix-027", 12:17:15 INFO - "pgo_build": "False", 12:17:15 INFO - "basedir": "/builds/slave/test", 12:17:15 INFO - "project": "", 12:17:15 INFO - "platform": "ubuntu64_hw", 12:17:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:17:15 INFO - "slavebuilddir": "test", 12:17:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:17:15 INFO - "branch": "fx-team", 12:17:15 INFO - "repo_path": "integration/fx-team", 12:17:15 INFO - "stage_platform": "linux64", 12:17:15 INFO - "builduid": "ce3f0cc682994afab06fa7ec9be424c4", 12:17:15 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:17:15 INFO - }, 12:17:15 INFO - "sourcestamp": { 12:17:15 INFO - "repository": "", 12:17:15 INFO - "hasPatch": false, 12:17:15 INFO - "project": "", 12:17:15 INFO - "branch": "fx-team-linux64-talos", 12:17:15 INFO - "changes": [ 12:17:15 INFO - { 12:17:15 INFO - "category": null, 12:17:15 INFO - "files": [ 12:17:15 INFO - { 12:17:15 INFO - "url": null, 12:17:15 INFO - "name": "https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:17:15 INFO - } 12:17:15 INFO - ], 12:17:15 INFO - "repository": "", 12:17:15 INFO - "rev": "3d8926eef121ba1b6b003011e2cac09c00782657", 12:17:15 INFO - "who": "mconley@mozilla.com", 12:17:15 INFO - "when": 1449259442, 12:17:15 INFO - "number": 6745749, 12:17:15 INFO - "comments": "Bug 1225921 - Have SessionStore keep a list of window data that might be saved during a flush. r=billm\n\nThis helps us keep track of what windows we've chosen to forget, and helps\nus avoid the problem of accidentally saving a window we've chosen to forget.", 12:17:15 INFO - "project": "", 12:17:15 INFO - "at": "Fri 04 Dec 2015 12:04:02", 12:17:15 INFO - "branch": "fx-team-linux64-talos", 12:17:15 INFO - "revlink": "", 12:17:15 INFO - "properties": [ 12:17:15 INFO - [ 12:17:15 INFO - "buildid", 12:17:15 INFO - "20151204113611", 12:17:15 INFO - "Change" 12:17:15 INFO - ], 12:17:15 INFO - [ 12:17:15 INFO - "builduid", 12:17:15 INFO - "ce3f0cc682994afab06fa7ec9be424c4", 12:17:15 INFO - "Change" 12:17:15 INFO - ], 12:17:15 INFO - [ 12:17:15 INFO - "pgo_build", 12:17:15 INFO - "False", 12:17:15 INFO - "Change" 12:17:15 INFO - ] 12:17:15 INFO - ], 12:17:15 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:17:15 INFO - } 12:17:15 INFO - ], 12:17:15 INFO - "revision": "3d8926eef121ba1b6b003011e2cac09c00782657" 12:17:15 INFO - } 12:17:15 INFO - } 12:17:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:17:15 INFO - Running post-action listener: _resource_record_post_action 12:17:15 INFO - ##### 12:17:15 INFO - ##### Running download-and-extract step. 12:17:15 INFO - ##### 12:17:15 INFO - Running pre-action listener: _resource_record_pre_action 12:17:15 INFO - Running main action method: download_and_extract 12:17:15 INFO - mkdir: /builds/slave/test/build/tests 12:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:15 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json 12:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json 12:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:17:15 INFO - Downloaded 1302 bytes. 12:17:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:17:15 INFO - Using the following test package requirements: 12:17:15 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'jsshell-linux-x86_64.zip'], 12:17:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:17:15 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:17:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:15 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:15 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:17 INFO - Downloaded 21849117 bytes. 12:17:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:17:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:17:18 INFO - Return code: 0 12:17:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:17:18 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')]} 12:17:18 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:19 INFO - Downloaded 21849117 bytes. 12:17:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:17:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:17:20 INFO - Return code: 0 12:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:20 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:17:21 INFO - Downloaded 11132001 bytes. 12:17:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:17:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:17:21 INFO - Return code: 0 12:17:21 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')]} 12:17:21 INFO - https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:17:24 INFO - Downloaded 57704536 bytes. 12:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:17:24 INFO - mkdir: /builds/slave/test/properties 12:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:24 INFO - Contents: 12:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:17:24 INFO - Running post-action listener: _resource_record_post_action 12:17:25 INFO - Running post-action listener: set_extra_try_arguments 12:17:25 INFO - ##### 12:17:25 INFO - ##### Running populate-webroot step. 12:17:25 INFO - ##### 12:17:25 INFO - Running pre-action listener: _resource_record_pre_action 12:17:25 INFO - Running main action method: populate_webroot 12:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:17:25 INFO - '../fennec_ids.txt'], 12:17:25 INFO - 'tests': ['tcheck2']}, 12:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:25 INFO - '--tppagecycles', 12:17:25 INFO - '7'], 12:17:25 INFO - 'tests': ['tsvgm']}}, 12:17:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'tests': ['damp', 'tps']}, 12:17:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['damp', 'tps']}, 12:17:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:25 INFO - 'other': {'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'other_l64': {'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:25 INFO - 'ts_paint', 12:17:25 INFO - 'tpaint', 12:17:25 INFO - 'sessionrestore', 12:17:25 INFO - 'sessionrestore_no_auto_restore']}, 12:17:25 INFO - 'svgr': {'tests': ['tsvgx', 12:17:25 INFO - 'tsvgr_opacity', 12:17:25 INFO - 'tart', 12:17:25 INFO - 'tscrollx', 12:17:25 INFO - 'cart']}, 12:17:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['tsvgx', 12:17:25 INFO - 'tsvgr_opacity', 12:17:25 INFO - 'tart', 12:17:25 INFO - 'tscrollx', 12:17:25 INFO - 'cart']}, 12:17:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'tests': ['tp5o']}, 12:17:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'talos_options': ['--e10s'], 12:17:25 INFO - 'tests': ['tp5o']}, 12:17:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'talos_options': ['--xperf_path', 12:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:25 INFO - 'tests': ['tp5n']}, 12:17:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:25 INFO - 'talos_options': ['--e10s', 12:17:25 INFO - '--xperf_path', 12:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:25 INFO - 'tests': ['tp5n']}}, 12:17:25 INFO - 'talos.zip': {'path': '', 12:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:25 INFO - Running post-action listener: _resource_record_post_action 12:17:25 INFO - ##### 12:17:25 INFO - ##### Running create-virtualenv step. 12:17:25 INFO - ##### 12:17:25 INFO - Running pre-action listener: _resource_record_pre_action 12:17:25 INFO - Running main action method: create_virtualenv 12:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:25 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 12:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:25 INFO - Using real prefix '/usr' 12:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:27 INFO - Installing pip.................done. 12:17:27 INFO - Return code: 0 12:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:27 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')]} 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:27 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')]} 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:27 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:27 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 12:17:27 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 12:17:27 INFO - Using env: {'DISPLAY': ':0', 12:17:27 INFO - 'HOME': '/home/cltbld', 12:17:27 INFO - 'LANG': 'en_US.UTF-8', 12:17:27 INFO - 'LANGUAGE': 'en_US:en', 12:17:27 INFO - 'LOGNAME': 'cltbld', 12:17:27 INFO - 'MAIL': '/var/mail/cltbld', 12:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:27 INFO - 'MOZ_NO_REMOTE': '1', 12:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:27 INFO - 'NO_EM_RESTART': '1', 12:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:27 INFO - 'PWD': '/builds/slave/test', 12:17:27 INFO - 'SHELL': '/bin/bash', 12:17:27 INFO - 'SHLVL': '1', 12:17:27 INFO - 'TERM': 'linux', 12:17:27 INFO - 'TMOUT': '86400', 12:17:27 INFO - 'USER': 'cltbld', 12:17:27 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:27 INFO - '_': '/tools/buildbot/bin/python'} 12:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:27 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 12:17:27 INFO - Cleaning up... 12:17:27 INFO - Return code: 0 12:17:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17:27 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')]} 12:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:27 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')]} 12:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:27 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:27 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 12:17:27 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 12:17:27 INFO - Using env: {'DISPLAY': ':0', 12:17:27 INFO - 'HOME': '/home/cltbld', 12:17:27 INFO - 'LANG': 'en_US.UTF-8', 12:17:27 INFO - 'LANGUAGE': 'en_US:en', 12:17:27 INFO - 'LOGNAME': 'cltbld', 12:17:27 INFO - 'MAIL': '/var/mail/cltbld', 12:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:27 INFO - 'MOZ_NO_REMOTE': '1', 12:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:27 INFO - 'NO_EM_RESTART': '1', 12:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:27 INFO - 'PWD': '/builds/slave/test', 12:17:27 INFO - 'SHELL': '/bin/bash', 12:17:27 INFO - 'SHLVL': '1', 12:17:27 INFO - 'TERM': 'linux', 12:17:27 INFO - 'TMOUT': '86400', 12:17:27 INFO - 'USER': 'cltbld', 12:17:27 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:27 INFO - '_': '/tools/buildbot/bin/python'} 12:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:28 INFO - Downloading/unpacking psutil>=0.7.1 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:17:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:29 INFO - Installing collected packages: psutil 12:17:29 INFO - Running setup.py install for psutil 12:17:29 INFO - building 'psutil._psutil_linux' extension 12:17:29 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 12:17:30 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 12:17:30 INFO - building 'psutil._psutil_posix' extension 12:17:30 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 12:17:30 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 12:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:30 INFO - Successfully installed psutil 12:17:30 INFO - Cleaning up... 12:17:30 INFO - Return code: 0 12:17:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:30 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')]} 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:30 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')]} 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:30 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:30 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 12:17:30 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 12:17:30 INFO - Using env: {'DISPLAY': ':0', 12:17:30 INFO - 'HOME': '/home/cltbld', 12:17:30 INFO - 'LANG': 'en_US.UTF-8', 12:17:30 INFO - 'LANGUAGE': 'en_US:en', 12:17:30 INFO - 'LOGNAME': 'cltbld', 12:17:30 INFO - 'MAIL': '/var/mail/cltbld', 12:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:30 INFO - 'MOZ_NO_REMOTE': '1', 12:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:30 INFO - 'NO_EM_RESTART': '1', 12:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:30 INFO - 'PWD': '/builds/slave/test', 12:17:30 INFO - 'SHELL': '/bin/bash', 12:17:30 INFO - 'SHLVL': '1', 12:17:30 INFO - 'TERM': 'linux', 12:17:30 INFO - 'TMOUT': '86400', 12:17:30 INFO - 'USER': 'cltbld', 12:17:30 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:30 INFO - '_': '/tools/buildbot/bin/python'} 12:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17:30 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 12:17:30 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 12:17:30 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 12:17:30 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 12:17:30 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 12:17:30 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 12:17:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:17:32 INFO - Installing collected packages: mozsystemmonitor 12:17:32 INFO - Running setup.py install for mozsystemmonitor 12:17:32 INFO - Successfully installed mozsystemmonitor 12:17:32 INFO - Cleaning up... 12:17:32 INFO - Return code: 0 12:17:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:32 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')]} 12:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:32 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')]} 12:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:32 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:32 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 12:17:32 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 12:17:32 INFO - Using env: {'DISPLAY': ':0', 12:17:32 INFO - 'HOME': '/home/cltbld', 12:17:32 INFO - 'LANG': 'en_US.UTF-8', 12:17:32 INFO - 'LANGUAGE': 'en_US:en', 12:17:32 INFO - 'LOGNAME': 'cltbld', 12:17:32 INFO - 'MAIL': '/var/mail/cltbld', 12:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:32 INFO - 'MOZ_NO_REMOTE': '1', 12:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:32 INFO - 'NO_EM_RESTART': '1', 12:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:32 INFO - 'PWD': '/builds/slave/test', 12:17:32 INFO - 'SHELL': '/bin/bash', 12:17:32 INFO - 'SHLVL': '1', 12:17:32 INFO - 'TERM': 'linux', 12:17:32 INFO - 'TMOUT': '86400', 12:17:32 INFO - 'USER': 'cltbld', 12:17:32 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:32 INFO - '_': '/tools/buildbot/bin/python'} 12:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:32 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:32 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 12:17:32 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 12:17:32 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 12:17:32 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 12:17:32 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 12:17:32 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 12:17:34 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 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 12:17:34 INFO - Downloading docopt-0.6.1.tar.gz 12:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:34 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:34 INFO - Running setup.py install for blobuploader 12:17:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:35 INFO - Running setup.py install for requests 12:17:35 INFO - Running setup.py install for docopt 12:17:35 INFO - Successfully installed blobuploader requests docopt 12:17:35 INFO - Cleaning up... 12:17:35 INFO - Return code: 0 12:17:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:35 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')]} 12:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:35 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')]} 12:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:35 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:35 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 12:17:35 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 12:17:35 INFO - Using env: {'DISPLAY': ':0', 12:17:35 INFO - 'HOME': '/home/cltbld', 12:17:35 INFO - 'LANG': 'en_US.UTF-8', 12:17:35 INFO - 'LANGUAGE': 'en_US:en', 12:17:35 INFO - 'LOGNAME': 'cltbld', 12:17:35 INFO - 'MAIL': '/var/mail/cltbld', 12:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:35 INFO - 'MOZ_NO_REMOTE': '1', 12:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:35 INFO - 'NO_EM_RESTART': '1', 12:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:35 INFO - 'PWD': '/builds/slave/test', 12:17:35 INFO - 'SHELL': '/bin/bash', 12:17:35 INFO - 'SHLVL': '1', 12:17:35 INFO - 'TERM': 'linux', 12:17:35 INFO - 'TMOUT': '86400', 12:17:35 INFO - 'USER': 'cltbld', 12:17:35 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:35 INFO - '_': '/tools/buildbot/bin/python'} 12:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:35 INFO - Running setup.py (path:/tmp/pip-pMIG8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:35 INFO - Running setup.py (path:/tmp/pip-wuv7gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:35 INFO - Running setup.py (path:/tmp/pip-_L8M2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:36 INFO - Running setup.py (path:/tmp/pip-ayJV4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:36 INFO - Running setup.py (path:/tmp/pip-7DvJVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:36 INFO - Running setup.py (path:/tmp/pip-zQQCLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:36 INFO - Running setup.py (path:/tmp/pip-YXMO5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:36 INFO - Running setup.py (path:/tmp/pip-Jk8mia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:36 INFO - Running setup.py (path:/tmp/pip-akYQjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:36 INFO - Running setup.py (path:/tmp/pip-sKW98q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:36 INFO - Running setup.py (path:/tmp/pip-QILtmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:36 INFO - Running setup.py (path:/tmp/pip-9vPSzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:36 INFO - Running setup.py (path:/tmp/pip-LURRrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:36 INFO - Running setup.py (path:/tmp/pip-MwPN3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:36 INFO - Running setup.py (path:/tmp/pip-m0joc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:36 INFO - Running setup.py (path:/tmp/pip-2o8PX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:36 INFO - Running setup.py (path:/tmp/pip-hKdUIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:37 INFO - Running setup.py install for manifestparser 12:17:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Running setup.py install for mozcrash 12:17:37 INFO - Running setup.py install for mozdebug 12:17:37 INFO - Running setup.py install for mozdevice 12:17:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Running setup.py install for mozfile 12:17:37 INFO - Running setup.py install for mozhttpd 12:17:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Running setup.py install for mozinfo 12:17:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Running setup.py install for mozInstall 12:17:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:37 INFO - Running setup.py install for mozleak 12:17:37 INFO - Running setup.py install for mozlog 12:17:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Running setup.py install for moznetwork 12:17:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Running setup.py install for mozprocess 12:17:38 INFO - Running setup.py install for mozprofile 12:17:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Running setup.py install for mozrunner 12:17:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Running setup.py install for mozscreenshot 12:17:38 INFO - Running setup.py install for moztest 12:17:38 INFO - Running setup.py install for mozversion 12:17:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:38 INFO - Cleaning up... 12:17:38 INFO - Return code: 0 12:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:38 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:38 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 12:17:38 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 12:17:38 INFO - Using env: {'DISPLAY': ':0', 12:17:38 INFO - 'HOME': '/home/cltbld', 12:17:38 INFO - 'LANG': 'en_US.UTF-8', 12:17:38 INFO - 'LANGUAGE': 'en_US:en', 12:17:38 INFO - 'LOGNAME': 'cltbld', 12:17:38 INFO - 'MAIL': '/var/mail/cltbld', 12:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:38 INFO - 'MOZ_NO_REMOTE': '1', 12:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:38 INFO - 'NO_EM_RESTART': '1', 12:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:38 INFO - 'PWD': '/builds/slave/test', 12:17:38 INFO - 'SHELL': '/bin/bash', 12:17:38 INFO - 'SHLVL': '1', 12:17:38 INFO - 'TERM': 'linux', 12:17:38 INFO - 'TMOUT': '86400', 12:17:38 INFO - 'USER': 'cltbld', 12:17:38 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:38 INFO - '_': '/tools/buildbot/bin/python'} 12:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:39 INFO - Running setup.py (path:/tmp/pip-0CekNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:39 INFO - Running setup.py (path:/tmp/pip-hMXWBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:39 INFO - Running setup.py (path:/tmp/pip-GjeJ3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:39 INFO - Running setup.py (path:/tmp/pip-Mocz3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:39 INFO - Running setup.py (path:/tmp/pip-8QeVaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:39 INFO - Running setup.py (path:/tmp/pip-2jW_ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:39 INFO - Running setup.py (path:/tmp/pip-B7RGYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:39 INFO - Running setup.py (path:/tmp/pip-R2pnrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:39 INFO - Running setup.py (path:/tmp/pip-dpBF_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:39 INFO - Running setup.py (path:/tmp/pip-BH2SXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:39 INFO - Running setup.py (path:/tmp/pip-_8Dia3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:39 INFO - Running setup.py (path:/tmp/pip-0wppHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:39 INFO - Running setup.py (path:/tmp/pip-OsYkLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:39 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)) 12:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:39 INFO - Running setup.py (path:/tmp/pip-o3eJSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:40 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)) 12:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:40 INFO - Running setup.py (path:/tmp/pip-YQi_2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:40 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)) 12:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:40 INFO - Running setup.py (path:/tmp/pip-tMa6e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:40 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)) 12:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:40 INFO - Running setup.py (path:/tmp/pip-D6Ot7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:40 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)) 12:17:40 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)) 12:17:40 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)) 12:17:40 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)) 12:17:40 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)) 12:17:40 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)) 12:17:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:40 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 12:17:40 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 12:17:40 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 12:17:40 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 12:17:40 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 12:17:40 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 12:17:41 INFO - Downloading blessings-1.5.1.tar.gz 12:17:41 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 12:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:41 INFO - Installing collected packages: blessings 12:17:41 INFO - Running setup.py install for blessings 12:17:42 INFO - Successfully installed blessings 12:17:42 INFO - Cleaning up... 12:17:42 INFO - Return code: 0 12:17:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:42 INFO - Reading from file tmpfile_stdout 12:17:42 INFO - Current package versions: 12:17:42 INFO - argparse == 1.2.1 12:17:42 INFO - blessings == 1.5.1 12:17:42 INFO - blobuploader == 1.2.4 12:17:42 INFO - docopt == 0.6.1 12:17:42 INFO - manifestparser == 1.1 12:17:42 INFO - mozInstall == 1.12 12:17:42 INFO - mozcrash == 0.16 12:17:42 INFO - mozdebug == 0.1 12:17:42 INFO - mozdevice == 0.47 12:17:42 INFO - mozfile == 1.2 12:17:42 INFO - mozhttpd == 0.7 12:17:42 INFO - mozinfo == 0.9 12:17:42 INFO - mozleak == 0.1 12:17:42 INFO - mozlog == 3.1 12:17:42 INFO - moznetwork == 0.27 12:17:42 INFO - mozprocess == 0.22 12:17:42 INFO - mozprofile == 0.27 12:17:42 INFO - mozrunner == 6.11 12:17:42 INFO - mozscreenshot == 0.1 12:17:42 INFO - mozsystemmonitor == 0.0 12:17:42 INFO - moztest == 0.7 12:17:42 INFO - mozversion == 1.4 12:17:42 INFO - psutil == 3.1.1 12:17:42 INFO - requests == 1.2.3 12:17:42 INFO - wsgiref == 0.1.2 12:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:42 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:42 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 12:17:42 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 12:17:42 INFO - Using env: {'DISPLAY': ':0', 12:17:42 INFO - 'HOME': '/home/cltbld', 12:17:42 INFO - 'LANG': 'en_US.UTF-8', 12:17:42 INFO - 'LANGUAGE': 'en_US:en', 12:17:42 INFO - 'LOGNAME': 'cltbld', 12:17:42 INFO - 'MAIL': '/var/mail/cltbld', 12:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:42 INFO - 'MOZ_NO_REMOTE': '1', 12:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:42 INFO - 'NO_EM_RESTART': '1', 12:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:42 INFO - 'PWD': '/builds/slave/test', 12:17:42 INFO - 'SHELL': '/bin/bash', 12:17:42 INFO - 'SHLVL': '1', 12:17:42 INFO - 'TERM': 'linux', 12:17:42 INFO - 'TMOUT': '86400', 12:17:42 INFO - 'USER': 'cltbld', 12:17:42 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:42 INFO - '_': '/tools/buildbot/bin/python'} 12:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 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)) 12:17:42 INFO - Cleaning up... 12:17:42 INFO - Return code: 0 12:17:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:42 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:42 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 12:17:42 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 12:17:42 INFO - Using env: {'DISPLAY': ':0', 12:17:42 INFO - 'HOME': '/home/cltbld', 12:17:42 INFO - 'LANG': 'en_US.UTF-8', 12:17:42 INFO - 'LANGUAGE': 'en_US:en', 12:17:42 INFO - 'LOGNAME': 'cltbld', 12:17:42 INFO - 'MAIL': '/var/mail/cltbld', 12:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:42 INFO - 'MOZ_NO_REMOTE': '1', 12:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:42 INFO - 'NO_EM_RESTART': '1', 12:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:42 INFO - 'PWD': '/builds/slave/test', 12:17:42 INFO - 'SHELL': '/bin/bash', 12:17:42 INFO - 'SHLVL': '1', 12:17:42 INFO - 'TERM': 'linux', 12:17:42 INFO - 'TMOUT': '86400', 12:17:42 INFO - 'USER': 'cltbld', 12:17:42 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:42 INFO - '_': '/tools/buildbot/bin/python'} 12:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:42 INFO - Downloading/unpacking jsonschema 12:17:42 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 12:17:42 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 12:17:42 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 12:17:42 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 12:17:42 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 12:17:42 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 12:17:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:44 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 12:17:44 INFO - Downloading/unpacking functools32 (from jsonschema) 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:44 INFO - warning: no files found matching '*.txt' 12:17:44 INFO - no previously-included directories found matching 'build' 12:17:44 INFO - no previously-included directories found matching 'dist' 12:17:44 INFO - no previously-included directories found matching '.git*' 12:17:44 INFO - Installing collected packages: jsonschema, functools32 12:17:44 INFO - Running setup.py install for functools32 12:17:44 INFO - warning: no files found matching '*.txt' 12:17:44 INFO - no previously-included directories found matching 'build' 12:17:44 INFO - no previously-included directories found matching 'dist' 12:17:44 INFO - no previously-included directories found matching '.git*' 12:17:44 INFO - Successfully installed jsonschema functools32 12:17:44 INFO - Cleaning up... 12:17:44 INFO - Return code: 0 12:17:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 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 0x7fe0b730bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, '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': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', '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 12:17:44 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 12:17:44 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 12:17:44 INFO - Using env: {'DISPLAY': ':0', 12:17:44 INFO - 'HOME': '/home/cltbld', 12:17:44 INFO - 'LANG': 'en_US.UTF-8', 12:17:44 INFO - 'LANGUAGE': 'en_US:en', 12:17:44 INFO - 'LOGNAME': 'cltbld', 12:17:44 INFO - 'MAIL': '/var/mail/cltbld', 12:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:44 INFO - 'MOZ_NO_REMOTE': '1', 12:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:44 INFO - 'NO_EM_RESTART': '1', 12:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:44 INFO - 'PWD': '/builds/slave/test', 12:17:44 INFO - 'SHELL': '/bin/bash', 12:17:44 INFO - 'SHLVL': '1', 12:17:44 INFO - 'TERM': 'linux', 12:17:44 INFO - 'TMOUT': '86400', 12:17:44 INFO - 'USER': 'cltbld', 12:17:44 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:44 INFO - '_': '/tools/buildbot/bin/python'} 12:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:45 INFO - Downloading/unpacking flake8 12:17:45 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 12:17:45 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 12:17:45 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 12:17:45 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 12:17:45 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 12:17:45 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 12:17:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:17:46 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 12:17:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:17:46 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 12:17:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:47 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 12:17:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:47 INFO - no previously-included directories found matching 'docs/_build' 12:17:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:17:47 INFO - Running setup.py install for pep8 12:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:47 INFO - no previously-included directories found matching 'docs/_build' 12:17:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:17:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:17:47 INFO - Cleaning up... 12:17:47 INFO - Return code: 0 12:17:47 INFO - Running post-action listener: _resource_record_post_action 12:17:47 INFO - Running post-action listener: _start_resource_monitoring 12:17:47 INFO - Starting resource monitoring. 12:17:47 INFO - ##### 12:17:47 INFO - ##### Running install step. 12:17:47 INFO - ##### 12:17:47 INFO - Running pre-action listener: _resource_record_pre_action 12:17:47 INFO - Running main action method: install 12:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:47 INFO - Reading from file tmpfile_stdout 12:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:48 INFO - Reading from file tmpfile_stdout 12:17:48 INFO - Output received: 12:17:48 INFO - Usage: mozinstall [options] installer 12:17:48 INFO - Options: 12:17:48 INFO - -h, --help show this help message and exit 12:17:48 INFO - -d DEST, --destination=DEST 12:17:48 INFO - Directory to install application into. [default: 12:17:48 INFO - "/builds/slave/test"] 12:17:48 INFO - --app=APP Application being installed. [default: firefox] 12:17:48 INFO - mkdir: /builds/slave/test/build/application 12:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:18:02 INFO - Reading from file tmpfile_stdout 12:18:02 INFO - Output received: 12:18:02 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:02 INFO - Running post-action listener: _resource_record_post_action 12:18:02 INFO - ##### 12:18:02 INFO - ##### Running run-tests step. 12:18:02 INFO - ##### 12:18:02 INFO - Running pre-action listener: _resource_record_pre_action 12:18:02 INFO - Running main action method: run_tests 12:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:02 INFO - Python 2.7.3 12:18:02 INFO - Return code: 0 12:18:02 INFO - grabbing minidump binary from tooltool 12:18: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')]} 12:18:02 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 0x2abb0b0>, '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 0x2abbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abc440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:02 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 12:18:02 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 12:18:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:02 INFO - Return code: 0 12:18:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:18:03 INFO - Return code: 0 12:18:03 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 12:18:03 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 12:18:03 INFO - Using env: {'DISPLAY': ':0', 12:18:03 INFO - 'HOME': '/home/cltbld', 12:18:03 INFO - 'LANG': 'en_US.UTF-8', 12:18:03 INFO - 'LANGUAGE': 'en_US:en', 12:18:03 INFO - 'LOGNAME': 'cltbld', 12:18:03 INFO - 'MAIL': '/var/mail/cltbld', 12:18:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:03 INFO - 'MOZ_NO_REMOTE': '1', 12:18:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:03 INFO - 'NO_EM_RESTART': '1', 12:18:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:03 INFO - 'PWD': '/builds/slave/test', 12:18:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:03 INFO - 'SHELL': '/bin/bash', 12:18:03 INFO - 'SHLVL': '1', 12:18:03 INFO - 'TERM': 'linux', 12:18:03 INFO - 'TMOUT': '86400', 12:18:03 INFO - 'USER': 'cltbld', 12:18:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800', 12:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:03 INFO - '_': '/tools/buildbot/bin/python'} 12:18:03 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/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 12:18:03 INFO - mozversion INFO | application_buildid: 20151204113611 12:18:03 INFO - mozversion INFO | application_changeset: 3d8926eef121ba1b6b003011e2cac09c00782657 12:18:03 INFO - mozversion INFO | application_display_name: Nightly 12:18:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:03 INFO - mozversion INFO | application_name: Firefox 12:18:03 INFO - mozversion INFO | application_remotingname: firefox 12:18:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:18:03 INFO - mozversion INFO | application_vendor: Mozilla 12:18:03 INFO - mozversion INFO | application_version: 45.0a1 12:18:03 INFO - mozversion INFO | platform_buildid: 20151204113611 12:18:03 INFO - mozversion INFO | platform_changeset: 3d8926eef121ba1b6b003011e2cac09c00782657 12:18:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:18:03 INFO - mozversion INFO | platform_version: 45.0a1 12:18:03 INFO - 2015-12-04 12:18:03,776 DEBUG : using testdate: 1449260283 12:18:03 INFO - 2015-12-04 12:18:03,776 DEBUG : actual date: 1449260283 12:18:03 INFO - 2015-12-04 12:18:03,785 INFO : starting webserver on 'localhost:35012' 12:18:03 INFO - 2015-12-04 12:18:03,786 INFO : Starting test suite talos-linux64-ix-027.e 12:18:03 INFO - 2015-12-04 12:18:03,786 INFO : Starting test dromaeo_css 12:18:03 INFO - 2015-12-04 12:18:03,786 DEBUG : operating with platform_type : linux_ 12:18:03 INFO - 2015-12-04 12:18:03,787 INFO : Initialising browser for dromaeo_css test... 12:18:03 INFO - 2015-12-04 12:18:03,801 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjeWpHV/profile http://localhost:35012/getInfo.html 12:18:08 INFO - 2015-12-04 12:18:08,907 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:18:08 INFO - 2015-12-04 12:18:08,907 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:18:08 INFO - 2015-12-04 12:18:08,907 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:18:08 INFO - 2015-12-04 12:18:08,907 DEBUG : BROWSER_OUTPUT: __metrics 12:18:09 INFO - 2015-12-04 12:18:09,049 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] 12:18:09 INFO - 2015-12-04 12:18:09,967 INFO : Browser initialized. 12:18:09 INFO - 2015-12-04 12:18:09,968 INFO : Running cycle 1/1 for dromaeo_css test... 12:18:09 INFO - 2015-12-04 12:18:09,968 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjeWpHV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:18:21 INFO - 2015-12-04 12:18:21,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 143409152 12:18:21 INFO - 2015-12-04 12:18:21,987 DEBUG : BROWSER_OUTPUT: 12:19:11 INFO - 2015-12-04 12:19:11,627 DEBUG : BROWSER_OUTPUT: 1449260351626 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] 12:21:24 INFO - 2015-12-04 12:21:24,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35012/tests/dromaeo/cssquery-ext.html) 12:21:25 INFO - 2015-12-04 12:21:25,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 147439616 12:21:25 INFO - 2015-12-04 12:21:25,284 DEBUG : BROWSER_OUTPUT: 12:24:27 INFO - 2015-12-04 12:24:27,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-ext.html (next: http://localhost:35012/tests/dromaeo/cssquery-jquery.html) 12:24:27 INFO - 2015-12-04 12:24:27,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 144932864 12:24:27 INFO - 2015-12-04 12:24:27,811 DEBUG : BROWSER_OUTPUT: 12:27:29 INFO - 2015-12-04 12:27:29,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35012/tests/dromaeo/cssquery-mootools.html) 12:27:30 INFO - 2015-12-04 12:27:30,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 145453056 12:27:30 INFO - 2015-12-04 12:27:30,203 DEBUG : BROWSER_OUTPUT: 12:30:31 INFO - 2015-12-04 12:30:31,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35012/tests/dromaeo/cssquery-prototype.html) 12:30:32 INFO - 2015-12-04 12:30:32,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 144715776 12:30:32 INFO - 2015-12-04 12:30:32,570 DEBUG : BROWSER_OUTPUT: 12:33:35 INFO - 2015-12-04 12:33:35,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35012/tests/dromaeo/cssquery-yui.html) 12:33:35 INFO - 2015-12-04 12:33:35,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 144957440 12:33:35 INFO - 2015-12-04 12:33:35,836 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/dromaeo/cssquery-yui.html (next: http://localhost:35012/tests/dromaeo/cssquery-dojo.html) 12:36:38 INFO - 2015-12-04 12:36:38,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 147017728 12:36:38 INFO - 2015-12-04 12:36:38,556 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:38 INFO - 2015-12-04 12:36:38,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:38 INFO - 2015-12-04 12:36:38,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:38 INFO - 2015-12-04 12:36:38,556 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:38 INFO - 2015-12-04 12:36:38,559 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.171316891763;2715.158300926714;2747.3131717070733;2763.2124844419336;2777.041920537415;4671.906561868761;4815.686980346275;4839.612830973522;4852.053849499344;4901.362822833035;4790.425148982127;4806.279058141281;4806.663533552653;4818.445878723948;4946.084974279761;4341.327094300388;4416.646668266539;4458.843940462085;4459.331100334959;4498.032922921571;4157.147784704143;4415.116976604676;4486.730796152225;4523.3441151033085;4544.113897789915;4394.670399720034;4454.866354009385;4474.932876006863;4487.461504619467;4514.0294836609955;4414.139242847646;4482.282834746425;4506.932396014063;4509.301058335963;4550.68145229834;4184.66522678185;4281.593248641374;4291.098869237464;4469.888252793674;4491.640668746492;4775;4786.1863483207935;4791.0178413425165;4809.567138957511;4864.513548645143;5191.32512773337;5219.321488206547;5229.450907654679;5233.764480598345;5250.7374631268285;4982.352294201767;5034.521720436553;5085.923711144335;5110.923336149961;5182.507661772125;4758.048390321949;4769.117713223065;4787.066522028241;4795;4834.154023045953;5269.420363759983;5278.261043453919;5299.258103865462;5301.54936830366;5304.92042619361;4920.089783390084;4941.332920055818;5020.7740651670765;5047.848564543069;5050.545450909436;5143.434222235551;5170;5174.586033117342;5182.093133701587;5211.348581427322;4935.284383764334;5099.515546023122;5101.617378696538;5107.310513080686;5109.591232701449;4963.57809586182;4986.601071914238;5011.348524691767;5034;5078.619103567247;4241.893952651209;4268.573142685768;4276.72201306914;4298.097399546068;4337.50118736343;3627.093226693327;3709.5548534176073;3783.5459744830796;3796.5823759386444;3839.2705385976574;4260.275753121977;4378.978105109454;4421.712588681726;4520.864374068783;4523.163214805271;5195.584353251731;5221.556167725786;5225.1117310056625;5229.137192363218;5268.841934741888;4476.283794592915;4477.6417886569;4482.21561226784;4489.663275254369;4492.932606010912;4378.124375124988;4460.442444694413;4463.330500424962;4474.709143905636;4569.977150114228;4919.877003074952;4945.579625731853;4968.701877887338;4973.776180071833;4985.326980857682;5225.81709640176;5235.842924712265;5236.869078273074;5242.266082748494;5243.265942767939;4680.157571637002;4791.808327666994;4835.419749630067;4885.413750349981;4925.729084900365;5001.174806156943;5007.69953802773;5027.899442011066;5034.345535080416;5044;5015.523525265094;5109.335786347751;5110;5115.5396014358885;5116.616253781056;4930.13722598551;4946.678465899849;4962.925556116734;5022.045811295842;5048.621353398583;4936;4960.627952903619;4965.4786247444945;4968.130577148912;5025.69845809238;4711.175544279668;4819.759012049313;4878.731669758197;4889.7799599018845;4921.729304888266;4912.852614421573;4919.680220785637;4963.677360971526;4989.850304490871;5016.272640467038;4868.756562171948;4948.208286674115;4961.627877909099;4983.9501604984935;4998.725070121178 12:36:38 INFO - 2015-12-04 12:36:38,559 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.9829605111845;585.2625691628548;591.101525680965;592.1266132454629;635.5646382228172;37161.62838371615;37756.62243377566;37809.81095094524;38098.42852357213;38132.61867381325;39176.60823391765;39476.60523394765;39518.20963580734;39604;39646.60353396472;7796.922030779705;7932.841343173133;7970.043594768636;7974.441789074767;7984.680612775482;7769.922300776976;7859.331956783652;7897.723579674713;7913.248241417056;7913.366930645535;7544.170141284454;7606.277403646644;7643.847123057535;7664.616769161547;7681.57751323677;7800.141984381714;7906.446548741562;7906.6837326506875;7930.206979302053;7950.204979502061;7712.228777122299;7884.684612615489;7894.131645518988;7911.446198766089;7912.604369781546;36061.45907811385;36313.27373452516;36617.267654646756;36696.81651591752;36703.63296367029;2593.74062593741;2626.1071235779737;2657.162993656992;3021.8640161192798;3245.496947973068;27427.725722742915;27929;27938.860305698545;27940.742666580052;28163.155105346872;3400.4219282721997;3426.468897320919;3465.289615628815;3491.5810102787573;3567.108222944264;216463;217192;217423;217661;218321;47278.527214727415;54799;54890.451095489334;54944.45055549393;55017.44982550203;43434.87368699969;65112.674436627516;65784.67107664431;65871.34128658652;66435.66782166058;14268.500602478864;14584.197869117088;14603.050801697857;14604.05073670208;14649;10916.290441121302;11093.057090147428;11118.277311974858;11129.387883666313;11140.554377824958;19060.428187154408;19126.521836954187;19232.807671923103;19286.80713192878;19365.225390984484;7302.707891684379;7630.961845190738;7642.388608911274;7689.846203075907;7732.536047837148;903.2322525852973;905.2594087617155;950.6482601437374;1012.9161796877418;1033.6278939581744;26415.094339622625;26752.464950700876;26817.329566760985;27071.458570828472;27169.320766980985;948.3456415073578;968.3705591365668;990.2375171118342;1074.7474343529263;1079.5519859258477;13629.25039122838;13768;13801.378937947817;13908.304584770924;14042.789358159636;260518;264423;265834;266086;267786;45789.77105114453;46051.53948460473;46258.537414626095;46598.76700616543;46639;1186.590626233948;1215.1736818963013;1216.3674889057818;1216.9026477881926;1223.174357308813;25111.49777004486;26320.078797242004;26509.469810604067;26672.59991100096;26677.06630267931;40282.1943561133;40439.19121617492;40792.38811417772;40944.385834213106;41043;245105;247357;247431;247998;248261;24757.62863557084;25299;28964.13107606775;29032.56451153192;29562.260943476584;38806.4179037309;39056.609433905294;39192;40140.98590140962;40480;30170.24574385658;30306.770449704272;30306.84846575753;30851.38297233998;30951.69048309488;29511.704882950897;29534.556981644862;29600.703992960654;29609.5558566626;30010;30705.539416908316;30915.536266956464;31281.530777037908;31320;32627.836860816493;28013.859930700215;29970.70029299679;30490.69509304967;30492.542611861285;30775.692243077283;23699.526009480058;23713.28860134199;23790.405239869142;23851.761482384954;24213.515729684954 12:36:38 INFO - 2015-12-04 12:36:38,561 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.07134487761834;331.93449028618136;333.01095745635456;333.4131927807059;333.68633484524554;10115.039071288234;10298.176145908319;10465.843012354802;14940.25298735063;15466.458673946414;12590.370481475935;12665.366731663426;13130.27783471911;15439.536813895573;15867.285972131252;5608.887822243552;5666.461686139821;5703.372629010805;5727.885442291152;5847.502962248214;5595.132754423071;5652.830415087534;5695.77216911323;5696.2594862668;5699.68651724155;5544.306961629796;5679;6120.908186377208;6286.748530058792;6312.715927783261;6288.748450061992;6299.874002519947;6345.302016778151;6811.829704257384;6815.897761533581;6524.641144737037;6534.869302613969;6556.082148499214;6559.8032059038305;6572.474202063823;19101.140448679842;19757.901210493997;20423.591528169352;21220;21457;1866.1135960418828;1898.439960211727;1899.0220036681121;1917.1564511614845;2004.2083377066124;12984.480620775157;13019.804702929463;13027.544035958696;13094.345282735825;13155.736885262337;1727.3695101288065;1732.774739283885;1749.1516614441985;1756.771619689445;1764.700000999833;58857;59892.401075989554;60549.09176362358;64388.678056610355;65450.67274663596;15278.618034549003;15376.38494460209;15463.304151313218;15515;15594.766078508832;23364.415889602897;23380.18169364098;23542.882285588807;23657.870791628837;23823.761762382153;8512.489250644981;8819.867701984474;8911;8990.056044115274;9022.729318120468;7481.70073197066;7531.585762783099;7550;7589.241075892367;7620.390368770485;7480.17718051014;7576.696932122653;7594.772156835304;7719.266669666373;7773.494722842997;1727.5681079730068;1787.428023032643;3147.5436061770915;3189.3940151371166;3197.4724170512072;846.7925358287259;850.2815121222557;895.3866601378077;908.2688435809105;912.9452232866049;15285.770713439308;15607.375704971673;15690.215489225493;16239;16271.430499932681;822.5681517203516;844.6494704697482;846.1580727176375;859.5659192107945;867.696306292805;8639.95680021596;8759.211670949646;8976.05751396107;9086.001079762442;9163.86562978578;491334;495786;498098;501434;504399;71353.64323178351;72564.27435725575;72652;73129.78396836222;73628;1075.0808059109506;1077.7305673581604;1087.575845420271;1088.820344643125;1105.7898999189968;14550.955302716182;14613.561593152222;14620.926895365881;14811.25943702832;14863.702725945204;31709.682903170673;32420.35159296848;32458.83770581132;32731.181720457178;33059.834700826344;42422.787886060374;43880.122397552506;43979.12041759211;44034.77982610066;47350;8640.481571105502;8648.956755216184;8649.481031138152;8767.386282960131;9019.909800901907;10523.421211833424;10554.630587929385;10565.841512377167;10654.786904262026;13230.603081907559;12957.352132393155;13104.279264640536;13158.01314901367;13161.802572961606;13201.537946171838;12528.99768018538;12886.548970785978;12936.676583085498;12957.028222883133;13002.804957925828;12781.297028663514;12931.353432328158;13292.933535332262;13383.933080334536;13630;9107.316951228817;9117.133872282122;9186.494742789211;9217.907820921973;9239;13178.670533236746;13287.40206690682;13476.393562289917;13834.446622135405;13940.093893896865 12:36:38 INFO - 2015-12-04 12:36:38,562 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1395.5603984744798;1409.739198248324;1467.3763650448557;1643.137352889733;1698.991505042475;6012.398760123996;6115;6824.385805277524;7366.926330736697;7383.22476140005;6808.659567021654;6889.7588584399555;6999.230084690693;7009.614471204081;7009.684564194611;1984.7022946557988;2019.0712272354735;2022.0799536211061;2028.7869773673774;2029.52306208041;2041.8570700051002;2066.638338290793;2073.8548301618894;2082.9791702082935;2105.3683894831565;2001.6597178479622;2002.8097330753556;2016.3043749906258;2021.6563184258637;2026.1591439552567;2048.2114385961363;2062.0411508648476;2069.048237810594;2069.3895300886275;2071.461420030788;2034.033833928872;2046.3349411441193;2068.782777808339;2071.9171233150655;2074.502119491311;7178.641067946634;7210.423166146696;7228.819279518054;7246.746363877239;7253.093363329584;4117.670586353114;4143.6892233082335;4148.730332528376;4162;4168.7707176105305;2590.3653604866927;2604.6613940187653;2636.2882021853993;2648.9337766555795;2651.992242947687;827.9296259817922;828.5070383122032;853.6884037326394;857.7984173719234;858.6050416808275;9463.858042129374;9472.857907131398;9491.003444638283;9526;9585.329026968115;3839.0978120141745;3851.9037024074623;3883.456316115746;3883.9029024274055;3922.980385098056;8129.837403251902;8271.2142346477;8288.875666865002;8304.418690691715;8343.332533397313;4050.797460126982;4061.329880569732;4080.9795951020646;4125.608067233608;4135.77253251074;3203.6956489133495;3295.6210035846184;3679.5400574928135;3694.4273637586216;3708.981455092707;3400.472926696366;3433.1760377509218;3441.4321636929626;3445.0870519312402;3488.965110348915;1102.1293178389144;1113.1484414422973;1122.3266040375709;1127.5320741892024;1130.2709752209778;1186.9821952670716;1193.075366590899;1193.2601786892183;1207.6980754811298;1214.089432925306;6644.169478815148;6724.125863637696;6785.084013658093;6788.1175447191545;6813.897791533131;420.68238479948053;421.90749727642;422.5520947795347;428.2526990401769;437.52309982119004;5312.442193569696;5329.786808527616;5373.623846330719;5391.299131113009;5399.190121481809;8355.248027677417;8355.415120941598;8551.187637174458;8561.743147705578;8685.739427817176;8403.41176117666;8418.368622353348;8485.151484851465;8501.107383724744;8526.31789456842;6629.469642428594;6655.933440665725;6740.9325906740305;6742.865142697118;6806.55757375769;6389.361063893573;6413.583117097561;6460.192475940507;6474.870502589828;6476.125723027331;7448.068991376078;7553.546787192786;7675.961620191863;7715.382769378324;7745.264199901;7721.090632624663;7818.530888146729;7843.4509584330835;7907.56508392021;7921.207879212033;5190.195519694454;5332.253484512249;5864.44287792659;6202.255729312331;6263.843403914756;6542.574732642363;6568.1789776277965;6569.178852643419;6693.2972037935315;6727.831804204934;6139.079138129317;6188.566800323934;6229.657368844757;6322.525810564318;6382.808515744535;6321.96839015802;6378.585391949508;6379.649119298483;6445.548811583144;6524.4454221389815;6056.454919057306;6085;6088.939110608837;6096.298925623432;6101.7559297627595;5487.286652735119;5507.504324610804;5530.6128570999645;5535.474129957647;5547.11246200606;5560.4161563035295;5627.493525582717;5673;5695.515881149983;5708.743106560298 12:36:38 INFO - 2015-12-04 12:36:38,563 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.53151237433485;288.7358067368358;291.16145500957225;291.65875925167546;291.96204493415854;5403.78384864605;5618.213450116982;5682.51698605618;5689.345725241598;5788.594798364116;5649.943500564993;5653.830385088444;5654.74553645086;5655.1517272409155;5673.120666296721;4240.279152544075;4243.193793179286;4252.4046633471335;4268.082362292106;4268.871933841974;4255.234057869582;4259.382389553512;4260.8721738347895;4262.232798096342;4267.637250833683;3987.003249187703;4149.087200815816;4202.516710578277;4209.989602495394;4222.113356195187;4153.8961525961795;4155.044339801862;4155.31437312843;4158.729682570638;4163.854265100737;3594.676479116892;3602.873899413508;3606.819659017065;3608.458731190316;3614.8915532534065;5348.277982472356;5350.839474815762;5359;5363.436839131874;5371.194320851903;4629.65277604181;4784.64115191362;4807.711537307773;4814.446338671028;4818.325434439182;5671.120976248688;5775.48020678141;5778.393268706767;5789.189513468118;5817.767289308423;3877.8448862045484;3880.767153970771;3882.010087427716;3885.417187421881;3887.047673320055;6102.8779424411705;6130.386961303879;6149.477294429978;6160.5687601867885;6175.135481032659;3869.7678139311734;3996;4011.8194681239415;4019.2363450944226;4020.537638171589;4075.7350772200307;4079.204555111725;4079.6124368184974;4083.673306135502;4084.7549147051272;4768.904621907612;4770.189067858472;4770.952290477051;4771.785269662873;4776.522347765195;5876.676782776988;5882.941170588325;5884.499817515473;5887.793927212527;5903.291605007426;1393.7700279453777;1420.389232629979;1445.8265008199082;1451.5935538049364;1452.244832687018;932.6036434515439;945.7068308824149;946.8390373636498;951.286535098676;957.2963871554402;5027.044861476308;5072.847814565569;5074.746262686925;5089.8727531812;5090.134677104901;6022.427869352405;6033.78881739137;6034.366391528826;6046.123312119806;6068.33248342682;5042.4705405931845;5047.141985862412;5062.594992400599;5071.771770270347;5075.3402057732255;3217.0670505553594;3234.1429521176906;3261.4292498812615;3267.803931764102;3313.8508767105536;5780.682062486603;5836.299644042657;5836.941630583725;5841.182234487175;5845;6281.183446151971;6322.652254126067;6331.620102793847;6333.20834895638;6348.460380867586;5689.402612725604;5757.827265182052;5817.854553636108;5818.21454103699;5827.388124246893;6051.394860513913;6090.573659843769;6115.510759139169;6173.228346456693;6180.7527698891545;6028.306744724413;6033.517318614413;6034.064719968412;6047.425494578008;6057.394260573908;5783.479486846204;5793;5806.9419305806405;5810.82567522975;5827.562932779973;3949.763014219156;4031.67746580267;4034.293998550301;4042.8989275268355;4046.736962097454;5874.17761513397;6103.816885493442;6106.755729770759;6118.755249790137;6124.14262003311;5762.769489220552;5795.217645617788;5882.764689412375;5931.228940237742;5949.405059494016;5871.647701137946;5914.58050067972;5929.822105336847;5939.346671866005;5948;5665.065264231355;5755.050416681201;5787.131930210502;5801.970990145022;5808;5964.284285885721;5976.940230597638;5984.401559844155;5987.790427335022;6008.279006519071;5783.248177736868;5784.161296612052;5784.50831679312;5788.942110579009;5795.565332599987 12:36:38 INFO - 2015-12-04 12:36:38,563 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.7979925721168;722.3715367630161;752.3642522068853;755.9659815308312;788.1724189600917;11152;11418.600348987788;11457.828132578017;11462.942685286584;11485.483153258114;11033.944830275837;11130.49912753926;11224.887751122485;11227;11265.887341126587;626.8589567347356;638.4605008767608;791.1574173505198;802.5987006496752;813.4427916876929;815.3110621524802;816.5508970066469;824.0605709491185;824.9505029698207;825.3892119831312;854.2354592639584;856.3235044315015;857.4855086947844;859.7034023261965;862.8835107260502;840.2731637133896;848.4103548034119;851.0553285852699;852.2074470742207;852.9658813647478;631.6810010944489;633.1009965848506;633.7116611941556;634.3751404866204;635.5297080160694;11469.655910322703;11586.47860846264;11633.94183029088;11670.241434306743;11699.23954942926;10591.152707783358;10909.945450272777;11256.54973801047;11869.46587403569;12154.696132596668;9569.33014688972;9591.232701383942;9619.807603847954;9722.513874306327;9828.852567211497;3225.12921511193;3267.3628642414737;3270.591176102987;3284.8193349365774;3300.2574420755136;41550.37674434886;41599.37600935988;41789.79105104455;42275.7886210567;42312.365314520306;8964.551772411354;9071.909280907106;9135.862962055575;9149.725508234764;9270.90729092714;16098.275577599035;16168.838311616968;16264.593385165228;16312.592185195464;16526.752098718287;6148.44663980244;6238.937610623836;6254.718537665816;6268.373162683695;6472.611643301417;3524.524189234472;3574.5353104096303;3611.6749492545273;3683.060819491066;3683.6684698377276;2719.5920611908373;2721.6461859958476;2737.3156710822295;2753.559430491112;2760.7239276072232;455.1261577770622;470.4260801821772;475.39624676660446;475.5125995854277;491.0890298496238;446.15676371657594;452.34184261899514;481.059528621544;494.87133345329755;545.1277955271613;7181.6409179540815;7355.742549010759;7477.7008919643695;7513.661885215179;7549.547027178387;424.7493978552607;511.48595661360093;595.0301009354724;619.127030886457;627.8932581461163;3591.174029973121;3684.115812205105;3795.1460921292487;3905.5899130591447;3907.5897030811357;48634;48888.755556222706;49023.264651030266;49325.26012109821;49343.25985110226;44578.55421445809;45131.32303015458;45188.77405613017;45227.32159017617;45340.77329613397;40147;40295.19409611791;40326.59673403287;44090.33864492035;44982.32526512105;7736.7678969631;7758.586460194605;8108.432409731262;8236.670533178605;8438.367122465963;31936.52095218527;32412.83793581017;32590.83704581462;32716.83641581872;32906.50640240446;37063.6293637071;37427.81286093552;38942.4158637615;40676;41062.1787564253;10383.273170877967;10464.215183861088;10501.842472362769;10543.57825686964;10604.734881628021;11429.59996400122;11511.76976460483;11653.825192621947;11913.90054370757;12028.15802893789;10388.896111038794;10428.165746740395;10789.676309710721;10900.454977250947;10956.671299861016;10555.472226388803;10799.56801727922;10904;11046.558137674403;11369.54521819151;10497.002784735438;10500.159987201157;10768.40773757451;10776.245662803529;10798.406087665255;9224.907750922404;9636.807263854824;9815.901840981784;9890;10073.496325183858;9013.549322533716;9147.496887671243;9222.815543688954;9316.534173291444;9341.626334946526 12:36:38 INFO - 2015-12-04 12:36:38,563 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:38 INFO - 2015-12-04 12:36:38,563 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:38 INFO - 2015-12-04 12:36:38,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261398555__endTimestamp 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4741.73 Median:4901.36 stddev:497.48 (10.1%) stddev-sans-first:471.79 12:36:38 INFO - 2015-12-04 12:36:38,564 DEBUG : BROWSER_OUTPUT: Values: 2673.2 2715.2 2747.3 2763.2 2777.0 4671.9 4815.7 4839.6 4852.1 4901.4 4790.4 4806.3 4806.7 4818.4 4946.1 4341.3 4416.6 4458.8 4459.3 4498.0 4157.1 4415.1 4486.7 4523.3 4544.1 4394.7 4454.9 4474.9 4487.5 4514.0 4414.1 4482.3 4506.9 4509.3 4550.7 4184.7 4281.6 4291.1 4469.9 4491.6 4775.0 4786.2 4791.0 4809.6 4864.5 5191.3 5219.3 5229.5 5233.8 5250.7 4982.4 5034.5 5085.9 5110.9 5182.5 4758.0 4769.1 4787.1 4795.0 4834.2 5269.4 5278.3 5299.3 5301.5 5304.9 4920.1 4941.3 5020.8 5047.8 5050.5 5143.4 5170.0 5174.6 5182.1 5211.3 4935.3 5099.5 5101.6 5107.3 5109.6 4963.6 4986.6 5011.3 5034.0 5078.6 4241.9 4268.6 4276.7 4298.1 4337.5 3627.1 3709.6 3783.5 3796.6 3839.3 4260.3 4379.0 4421.7 4520.9 4523.2 5195.6 5221.6 5225.1 5229.1 5268.8 4476.3 4477.6 4482.2 4489.7 4492.9 4378.1 4460.4 4463.3 4474.7 4570.0 4919.9 4945.6 4968.7 4973.8 4985.3 5225.8 5235.8 5236.9 5242.3 5243.3 4680.2 4791.8 4835.4 4885.4 4925.7 5001.2 5007.7 5027.9 5034.3 5044.0 5015.5 5109.3 5110.0 5115.5 5116.6 4930.1 4946.7 4962.9 5022.0 5048.6 4936.0 4960.6 4965.5 4968.1 5025.7 4711.2 4819.8 4878.7 4889.8 4921.7 4912.9 4919.7 4963.7 4989.9 5016.3 4868.8 4948.2 4961.6 4984.0 4998.7 12:36:38 INFO - 2015-12-04 12:36:38,565 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,565 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40386.91 Median:31300.77 stddev:63585.08 (203.1%) stddev-sans-first:63693.17 12:36:38 INFO - 2015-12-04 12:36:38,566 DEBUG : BROWSER_OUTPUT: Values: 568.0 585.3 591.1 592.1 635.6 37161.6 37756.6 37809.8 38098.4 38132.6 39176.6 39476.6 39518.2 39604.0 39646.6 7796.9 7932.8 7970.0 7974.4 7984.7 7769.9 7859.3 7897.7 7913.2 7913.4 7544.2 7606.3 7643.8 7664.6 7681.6 7800.1 7906.4 7906.7 7930.2 7950.2 7712.2 7884.7 7894.1 7911.4 7912.6 36061.5 36313.3 36617.3 36696.8 36703.6 2593.7 2626.1 2657.2 3021.9 3245.5 27427.7 27929.0 27938.9 27940.7 28163.2 3400.4 3426.5 3465.3 3491.6 3567.1 216463.0 217192.0 217423.0 217661.0 218321.0 47278.5 54799.0 54890.5 54944.5 55017.4 43434.9 65112.7 65784.7 65871.3 66435.7 14268.5 14584.2 14603.1 14604.1 14649.0 10916.3 11093.1 11118.3 11129.4 11140.6 19060.4 19126.5 19232.8 19286.8 19365.2 7302.7 7631.0 7642.4 7689.8 7732.5 903.2 905.3 950.6 1012.9 1033.6 26415.1 26752.5 26817.3 27071.5 27169.3 948.3 968.4 990.2 1074.7 1079.6 13629.3 13768.0 13801.4 13908.3 14042.8 260518.0 264423.0 265834.0 266086.0 267786.0 45789.8 46051.5 46258.5 46598.8 46639.0 1186.6 1215.2 1216.4 1216.9 1223.2 25111.5 26320.1 26509.5 26672.6 26677.1 40282.2 40439.2 40792.4 40944.4 41043.0 245105.0 247357.0 247431.0 247998.0 248261.0 24757.6 25299.0 28964.1 29032.6 29562.3 38806.4 39056.6 39192.0 40141.0 40480.0 30170.2 30306.8 30306.8 30851.4 30951.7 29511.7 29534.6 29600.7 29609.6 30010.0 30705.5 30915.5 31281.5 31320.0 32627.8 28013.9 29970.7 30490.7 30492.5 30775.7 23699.5 23713.3 23790.4 23851.8 24213.5 12:36:38 INFO - 2015-12-04 12:36:38,566 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,566 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27589.74 Median:331.50 stddev:81298.81 (24524.3%) stddev-sans-first:81501.11 12:36:38 INFO - 2015-12-04 12:36:38,566 DEBUG : BROWSER_OUTPUT: Values: 331.1 331.9 333.0 333.4 333.7 10115.0 10298.2 10465.8 14940.3 15466.5 12590.4 12665.4 13130.3 15439.5 15867.3 5608.9 5666.5 5703.4 5727.9 5847.5 5595.1 5652.8 5695.8 5696.3 5699.7 5544.3 5679.0 6120.9 6286.7 6312.7 6288.7 6299.9 6345.3 6811.8 6815.9 6524.6 6534.9 6556.1 6559.8 6572.5 19101.1 19757.9 20423.6 21220.0 21457.0 1866.1 1898.4 1899.0 1917.2 2004.2 12984.5 13019.8 13027.5 13094.3 13155.7 1727.4 1732.8 1749.2 1756.8 1764.7 58857.0 59892.4 60549.1 64388.7 65450.7 15278.6 15376.4 15463.3 15515.0 15594.8 23364.4 23380.2 23542.9 23657.9 23823.8 8512.5 8819.9 8911.0 8990.1 9022.7 7481.7 7531.6 7550.0 7589.2 7620.4 7480.2 7576.7 7594.8 7719.3 7773.5 1727.6 1787.4 3147.5 3189.4 3197.5 846.8 850.3 895.4 908.3 912.9 15285.8 15607.4 15690.2 16239.0 16271.4 822.6 844.6 846.2 859.6 867.7 8640.0 8759.2 8976.1 9086.0 9163.9 491334.0 495786.0 498098.0 501434.0 504399.0 71353.6 72564.3 72652.0 73129.8 73628.0 1075.1 1077.7 1087.6 1088.8 1105.8 14551.0 14613.6 14620.9 14811.3 14863.7 31709.7 32420.4 32458.8 32731.2 33059.8 42422.8 43880.1 43979.1 44034.8 47350.0 8640.5 8649.0 8649.5 8767.4 9019.9 10523.4 10554.6 10565.8 10654.8 13230.6 12957.4 13104.3 13158.0 13161.8 13201.5 12529.0 12886.5 12936.7 12957.0 13002.8 12781.3 12931.4 13292.9 13383.9 13630.0 9107.3 9117.1 9186.5 9217.9 9239.0 13178.7 13287.4 13476.4 13834.4 13940.1 12:36:38 INFO - 2015-12-04 12:36:38,566 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,567 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4881.83 Median:5702.13 stddev:2565.24 (45.0%) stddev-sans-first:2559.05 12:36:38 INFO - 2015-12-04 12:36:38,568 DEBUG : BROWSER_OUTPUT: Values: 1395.6 1409.7 1467.4 1643.1 1699.0 6012.4 6115.0 6824.4 7366.9 7383.2 6808.7 6889.8 6999.2 7009.6 7009.7 1984.7 2019.1 2022.1 2028.8 2029.5 2041.9 2066.6 2073.9 2083.0 2105.4 2001.7 2002.8 2016.3 2021.7 2026.2 2048.2 2062.0 2069.0 2069.4 2071.5 2034.0 2046.3 2068.8 2071.9 2074.5 7178.6 7210.4 7228.8 7246.7 7253.1 4117.7 4143.7 4148.7 4162.0 4168.8 2590.4 2604.7 2636.3 2648.9 2652.0 827.9 828.5 853.7 857.8 858.6 9463.9 9472.9 9491.0 9526.0 9585.3 3839.1 3851.9 3883.5 3883.9 3923.0 8129.8 8271.2 8288.9 8304.4 8343.3 4050.8 4061.3 4081.0 4125.6 4135.8 3203.7 3295.6 3679.5 3694.4 3709.0 3400.5 3433.2 3441.4 3445.1 3489.0 1102.1 1113.1 1122.3 1127.5 1130.3 1187.0 1193.1 1193.3 1207.7 1214.1 6644.2 6724.1 6785.1 6788.1 6813.9 420.7 421.9 422.6 428.3 437.5 5312.4 5329.8 5373.6 5391.3 5399.2 8355.2 8355.4 8551.2 8561.7 8685.7 8403.4 8418.4 8485.2 8501.1 8526.3 6629.5 6655.9 6740.9 6742.9 6806.6 6389.4 6413.6 6460.2 6474.9 6476.1 7448.1 7553.5 7676.0 7715.4 7745.3 7721.1 7818.5 7843.5 7907.6 7921.2 5190.2 5332.3 5864.4 6202.3 6263.8 6542.6 6568.2 6569.2 6693.3 6727.8 6139.1 6188.6 6229.7 6322.5 6382.8 6322.0 6378.6 6379.6 6445.5 6524.4 6056.5 6085.0 6088.9 6096.3 6101.8 5487.3 5507.5 5530.6 5535.5 5547.1 5560.4 5627.5 5673.0 5695.5 5708.7 12:36:38 INFO - 2015-12-04 12:36:38,568 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,568 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4827.15 Median:5660.11 stddev:1473.33 (26.0%) stddev-sans-first:1437.40 12:36:38 INFO - 2015-12-04 12:36:38,569 DEBUG : BROWSER_OUTPUT: Values: 280.5 288.7 291.2 291.7 292.0 5403.8 5618.2 5682.5 5689.3 5788.6 5649.9 5653.8 5654.7 5655.2 5673.1 4240.3 4243.2 4252.4 4268.1 4268.9 4255.2 4259.4 4260.9 4262.2 4267.6 3987.0 4149.1 4202.5 4210.0 4222.1 4153.9 4155.0 4155.3 4158.7 4163.9 3594.7 3602.9 3606.8 3608.5 3614.9 5348.3 5350.8 5359.0 5363.4 5371.2 4629.7 4784.6 4807.7 4814.4 4818.3 5671.1 5775.5 5778.4 5789.2 5817.8 3877.8 3880.8 3882.0 3885.4 3887.0 6102.9 6130.4 6149.5 6160.6 6175.1 3869.8 3996.0 4011.8 4019.2 4020.5 4075.7 4079.2 4079.6 4083.7 4084.8 4768.9 4770.2 4771.0 4771.8 4776.5 5876.7 5882.9 5884.5 5887.8 5903.3 1393.8 1420.4 1445.8 1451.6 1452.2 932.6 945.7 946.8 951.3 957.3 5027.0 5072.8 5074.7 5089.9 5090.1 6022.4 6033.8 6034.4 6046.1 6068.3 5042.5 5047.1 5062.6 5071.8 5075.3 3217.1 3234.1 3261.4 3267.8 3313.9 5780.7 5836.3 5836.9 5841.2 5845.0 6281.2 6322.7 6331.6 6333.2 6348.5 5689.4 5757.8 5817.9 5818.2 5827.4 6051.4 6090.6 6115.5 6173.2 6180.8 6028.3 6033.5 6034.1 6047.4 6057.4 5783.5 5793.0 5806.9 5810.8 5827.6 3949.8 4031.7 4034.3 4042.9 4046.7 5874.2 6103.8 6106.8 6118.8 6124.1 5762.8 5795.2 5882.8 5931.2 5949.4 5871.6 5914.6 5929.8 5939.3 5948.0 5665.1 5755.1 5787.1 5802.0 5808.0 5964.3 5976.9 5984.4 5987.8 6008.3 5783.2 5784.2 5784.5 5788.9 5795.6 12:36:38 INFO - 2015-12-04 12:36:38,569 DEBUG : BROWSER_OUTPUT: 12:36:38 INFO - 2015-12-04 12:36:38,569 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12358.32 Median:44334.45 stddev:13973.83 (31.5%) stddev-sans-first:13985.65 12:36:38 INFO - 2015-12-04 12:36:38,570 DEBUG : BROWSER_OUTPUT: Values: 708.8 722.4 752.4 756.0 788.2 11152.0 11418.6 11457.8 11462.9 11485.5 11033.9 11130.5 11224.9 11227.0 11265.9 626.9 638.5 791.2 802.6 813.4 815.3 816.6 824.1 825.0 825.4 854.2 856.3 857.5 859.7 862.9 840.3 848.4 851.1 852.2 853.0 631.7 633.1 633.7 634.4 635.5 11469.7 11586.5 11633.9 11670.2 11699.2 10591.2 10909.9 11256.5 11869.5 12154.7 9569.3 9591.2 9619.8 9722.5 9828.9 3225.1 3267.4 3270.6 3284.8 3300.3 41550.4 41599.4 41789.8 42275.8 42312.4 8964.6 9071.9 9135.9 9149.7 9270.9 16098.3 16168.8 16264.6 16312.6 16526.8 6148.4 6238.9 6254.7 6268.4 6472.6 3524.5 3574.5 3611.7 3683.1 3683.7 2719.6 2721.6 2737.3 2753.6 2760.7 455.1 470.4 475.4 475.5 491.1 446.2 452.3 481.1 494.9 545.1 7181.6 7355.7 7477.7 7513.7 7549.5 424.7 511.5 595.0 619.1 627.9 3591.2 3684.1 3795.1 3905.6 3907.6 48634.0 48888.8 49023.3 49325.3 49343.3 44578.6 45131.3 45188.8 45227.3 45340.8 40147.0 40295.2 40326.6 44090.3 44982.3 7736.8 7758.6 8108.4 8236.7 8438.4 31936.5 32412.8 32590.8 32716.8 32906.5 37063.6 37427.8 38942.4 40676.0 41062.2 10383.3 10464.2 10501.8 10543.6 10604.7 11429.6 11511.8 11653.8 11913.9 12028.2 10388.9 10428.2 10789.7 10900.5 10956.7 10555.5 10799.6 10904.0 11046.6 11369.5 10497.0 10500.2 10768.4 10776.2 10798.4 9224.9 9636.8 9815.9 9890.0 10073.5 9013.5 9147.5 9222.8 9316.5 9341.6 12:36:38 INFO - 2015-12-04 12:36:38,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:38 INFO - 2015-12-04 12:36:38,570 DEBUG : BROWSER_OUTPUT: 12:36:39 INFO - 2015-12-04 12:36:39,283 INFO : Browser exited with error code: 0 12:36:39 INFO - 2015-12-04 12:36:39,300 INFO : Completed test dromaeo_css (00:18:35) 12:36:39 INFO - 2015-12-04 12:36:39,300 INFO : Starting test kraken 12:36:39 INFO - 2015-12-04 12:36:39,300 DEBUG : operating with platform_type : linux_ 12:36:39 INFO - 2015-12-04 12:36:39,300 INFO : Initialising browser for kraken test... 12:36:39 INFO - 2015-12-04 12:36:39,306 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThCcJQ/profile http://localhost:35012/getInfo.html 12:36:44 INFO - 2015-12-04 12:36:44,261 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:44 INFO - 2015-12-04 12:36:44,261 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:44 INFO - 2015-12-04 12:36:44,261 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:44 INFO - 2015-12-04 12:36:44,261 DEBUG : BROWSER_OUTPUT: __metrics 12:36:44 INFO - 2015-12-04 12:36:44,430 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] 12:36:45 INFO - 2015-12-04 12:36:45,379 INFO : Browser initialized. 12:36:45 INFO - 2015-12-04 12:36:45,380 INFO : Running cycle 1/1 for kraken test... 12:36:45 INFO - 2015-12-04 12:36:45,380 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpThCcJQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:57 INFO - 2015-12-04 12:36:57,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 143183872 12:36:57 INFO - 2015-12-04 12:36:57,450 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-12-04 12:37:00,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35012/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:00 INFO - 2015-12-04 12:37:00,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 142852096 12:37:00 INFO - 2015-12-04 12:37:00,652 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-12-04 12:37:03,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35012/tests/kraken/driver.html?testName=audio-dft) 12:37:03 INFO - 2015-12-04 12:37:03,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 141398016 12:37:03 INFO - 2015-12-04 12:37:03,987 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-12-04 12:37:06,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35012/tests/kraken/driver.html?testName=audio-fft) 12:37:07 INFO - 2015-12-04 12:37:07,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 137965568 12:37:07 INFO - 2015-12-04 12:37:07,505 DEBUG : BROWSER_OUTPUT: 12:37:09 INFO - 2015-12-04 12:37:09,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35012/tests/kraken/driver.html?testName=audio-oscillator) 12:37:10 INFO - 2015-12-04 12:37:10,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 139042816 12:37:10 INFO - 2015-12-04 12:37:10,230 DEBUG : BROWSER_OUTPUT: 12:37:12 INFO - 2015-12-04 12:37:12,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:13 INFO - 2015-12-04 12:37:13,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 12:37:13 INFO - 2015-12-04 12:37:13,078 DEBUG : BROWSER_OUTPUT: 12:37:16 INFO - 2015-12-04 12:37:16,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35012/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:16 INFO - 2015-12-04 12:37:16,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 12:37:16 INFO - 2015-12-04 12:37:16,743 DEBUG : BROWSER_OUTPUT: 12:37:20 INFO - 2015-12-04 12:37:20,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35012/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:20 INFO - 2015-12-04 12:37:20,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 137568256 12:37:20 INFO - 2015-12-04 12:37:20,821 DEBUG : BROWSER_OUTPUT: 12:37:23 INFO - 2015-12-04 12:37:23,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35012/tests/kraken/driver.html?testName=json-parse-financial) 12:37:24 INFO - 2015-12-04 12:37:24,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 137687040 12:37:24 INFO - 2015-12-04 12:37:24,309 DEBUG : BROWSER_OUTPUT: 12:37:26 INFO - 2015-12-04 12:37:26,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:26 INFO - 2015-12-04 12:37:26,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 140058624 12:37:26 INFO - 2015-12-04 12:37:26,671 DEBUG : BROWSER_OUTPUT: 12:37:28 INFO - 2015-12-04 12:37:28,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:29 INFO - 2015-12-04 12:37:29,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 140394496 12:37:29 INFO - 2015-12-04 12:37:29,211 DEBUG : BROWSER_OUTPUT: 12:37:31 INFO - 2015-12-04 12:37:31,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:32 INFO - 2015-12-04 12:37:32,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 140738560 12:37:32 INFO - 2015-12-04 12:37:32,014 DEBUG : BROWSER_OUTPUT: 12:37:34 INFO - 2015-12-04 12:37:34,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:35 INFO - 2015-12-04 12:37:35,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 12:37:35 INFO - 2015-12-04 12:37:35,258 DEBUG : BROWSER_OUTPUT: 12:37:37 INFO - 2015-12-04 12:37:37,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:38 INFO - 2015-12-04 12:37:38,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 140705792 12:37:38 INFO - 2015-12-04 12:37:38,418 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35012/tests/kraken/driver.html?testName=ai-astar) 12:37:40 INFO - 2015-12-04 12:37:40,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 12:37:40 INFO - 2015-12-04 12:37:40,411 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,411 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;115;111;113;124;110;110;110;111 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;132;157;169;131;156;155;135;177;131 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;162;161;165;167;167;162;163;163 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;73;73;74;164;73;71;75;74;157 12:37:40 INFO - 2015-12-04 12:37:40,412 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;135;96;95;96;131;94;94;134 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;110;110;110;110 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;157;148;149;148;148;147 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;96;97;96;96 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;72;72;73;72;71;74;71 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;75;69;69;69;68;69;69;68;69;69 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;93;88;86;84;86;85;84;97;98 12:37:40 INFO - 2015-12-04 12:37:40,413 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;135;122;143;137;131;123;149;125;141 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;145;144;145;137;149;133;141;142;147 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;67;68;70;69;70;70;68;70 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,797 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261460407__endTimestamp 12:37:40 INFO - 2015-12-04 12:37:40,414 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,418 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:40 INFO - 2015-12-04 12:37:40,418 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:37:40 INFO - 2015-12-04 12:37:40,418 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,418 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:111.00 stddev:4.64 (4.2%) stddev-sans-first:4.90 12:37:40 INFO - 2015-12-04 12:37:40,419 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 115.0 111.0 113.0 124.0 110.0 110.0 110.0 111.0 12:37:40 INFO - 2015-12-04 12:37:40,419 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,420 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.30 Median:156.50 stddev:16.90 (10.8%) stddev-sans-first:17.56 12:37:40 INFO - 2015-12-04 12:37:40,420 DEBUG : BROWSER_OUTPUT: Values: 160.0 132.0 157.0 169.0 131.0 156.0 155.0 135.0 177.0 131.0 12:37:40 INFO - 2015-12-04 12:37:40,420 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,420 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.06 (1.3%) stddev-sans-first:2.17 12:37:40 INFO - 2015-12-04 12:37:40,420 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 162.0 161.0 165.0 167.0 167.0 162.0 163.0 163.0 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.10 Median:73.50 stddev:36.65 (49.9%) stddev-sans-first:38.51 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: Values: 77.0 73.0 73.0 74.0 164.0 73.0 71.0 75.0 74.0 157.0 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.50 stddev:18.63 (19.7%) stddev-sans-first:19.29 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 135.0 96.0 95.0 96.0 131.0 94.0 94.0 134.0 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:2.98 (2.0%) stddev-sans-first:3.15 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 157.0 148.0 149.0 148.0 148.0 147.0 12:37:40 INFO - 2015-12-04 12:37:40,421 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:73.00 stddev:1.08 (1.5%) stddev-sans-first:1.00 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 72.0 72.0 73.0 72.0 71.0 74.0 71.0 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:2.01 (2.9%) stddev-sans-first:0.44 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: Values: 75.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 69.0 69.0 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:87.00 stddev:5.56 (6.4%) stddev-sans-first:5.55 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: Values: 83.0 93.0 88.0 86.0 84.0 86.0 85.0 84.0 97.0 98.0 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:136.00 stddev:9.84 (7.2%) stddev-sans-first:9.49 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: Values: 121.0 135.0 122.0 143.0 137.0 131.0 123.0 149.0 125.0 141.0 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,422 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.50 stddev:5.29 (3.7%) stddev-sans-first:5.00 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: Values: 135.0 145.0 144.0 145.0 137.0 149.0 133.0 141.0 142.0 147.0 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:70.00 stddev:1.15 (1.6%) stddev-sans-first:1.17 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 67.0 68.0 70.0 69.0 70.0 70.0 68.0 70.0 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:40 INFO - 2015-12-04 12:37:40,423 DEBUG : BROWSER_OUTPUT: 12:37:41 INFO - 2015-12-04 12:37:41,355 INFO : Browser exited with error code: 0 12:37:41 INFO - 2015-12-04 12:37:41,406 INFO : Completed test kraken (00:01:02) 12:37:41 INFO - 2015-12-04 12:37:41,406 INFO : Starting test v8_7 12:37:41 INFO - 2015-12-04 12:37:41,406 DEBUG : operating with platform_type : linux_ 12:37:41 INFO - 2015-12-04 12:37:41,406 INFO : Initialising browser for v8_7 test... 12:37:41 INFO - 2015-12-04 12:37:41,413 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPkrDT/profile http://localhost:35012/getInfo.html 12:37:46 INFO - 2015-12-04 12:37:46,421 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:46 INFO - 2015-12-04 12:37:46,422 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:46 INFO - 2015-12-04 12:37:46,422 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:37:46 INFO - 2015-12-04 12:37:46,422 DEBUG : BROWSER_OUTPUT: __metrics 12:37:46 INFO - 2015-12-04 12:37:46,559 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] 12:37:47 INFO - 2015-12-04 12:37:47,543 INFO : Browser initialized. 12:37:47 INFO - 2015-12-04 12:37:47,544 INFO : Running cycle 1/1 for v8_7 test... 12:37:47 INFO - 2015-12-04 12:37:47,544 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPkrDT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:59 INFO - 2015-12-04 12:37:59,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 143212544 12:37:59 INFO - 2015-12-04 12:37:59,610 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35012/tests/v8_7/run.html (next: http://localhost:35012/tests/v8_7/run.html) 12:38:21 INFO - 2015-12-04 12:38:21,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 12:38:21 INFO - 2015-12-04 12:38:21,379 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,379 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:38:21 INFO - 2015-12-04 12:38:21,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:38:21 INFO - 2015-12-04 12:38:21,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:38:21 INFO - 2015-12-04 12:38:21,380 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:38:21 INFO - 2015-12-04 12:38:21,380 DEBUG : BROWSER_OUTPUT: |0;Richards;167.19612104999163 12:38:21 INFO - 2015-12-04 12:38:21,381 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.85732671446956 12:38:21 INFO - 2015-12-04 12:38:21,381 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 12:38:21 INFO - 2015-12-04 12:38:21,381 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5223.958333333333 12:38:21 INFO - 2015-12-04 12:38:21,381 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1072.961373390558 12:38:21 INFO - 2015-12-04 12:38:21,382 DEBUG : BROWSER_OUTPUT: |5;Earley;705.7163020465773 12:38:21 INFO - 2015-12-04 12:38:21,382 DEBUG : BROWSER_OUTPUT: |6;Boyer;12506.172839506173 12:38:21 INFO - 2015-12-04 12:38:21,382 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 12:38:21 INFO - 2015-12-04 12:38:21,383 DEBUG : BROWSER_OUTPUT: |8;Splay;607.90273556231 12:38:21 INFO - 2015-12-04 12:38:21,383 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515 12:38:21 INFO - 2015-12-04 12:38:21,383 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:38:21 INFO - 2015-12-04 12:38:21,383 DEBUG : BROWSER_OUTPUT: __startTimestamp1449261501376__endTimestamp 12:38:21 INFO - 2015-12-04 12:38:21,384 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:38:21 INFO - 2015-12-04 12:38:21,384 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:38:21 INFO - 2015-12-04 12:38:21,384 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,385 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,385 DEBUG : BROWSER_OUTPUT: Values: 167.2 12:38:21 INFO - 2015-12-04 12:38:21,385 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,386 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.86 Median:183.86 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,386 DEBUG : BROWSER_OUTPUT: Values: 183.9 12:38:21 INFO - 2015-12-04 12:38:21,386 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,386 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: Values: 277.5 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: Values: 5224.0 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,387 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: Values: 1073.0 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.72 Median:705.72 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: Values: 705.7 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,388 DEBUG : BROWSER_OUTPUT: Values: 12506.2 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: Values: 26000.0 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: Values: 607.9 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: 12:38:21 INFO - 2015-12-04 12:38:21,389 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 12:38:21 INFO - 2015-12-04 12:38:21,390 DEBUG : BROWSER_OUTPUT: Values: 4868.9 12:38:21 INFO - 2015-12-04 12:38:21,390 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:38:21 INFO - 2015-12-04 12:38:21,390 DEBUG : BROWSER_OUTPUT: 12:38:22 INFO - 2015-12-04 12:38:22,303 INFO : Browser exited with error code: 0 12:38:22 INFO - 2015-12-04 12:38:22,322 INFO : Completed test v8_7 (00:00:40) 12:38:22 INFO - 2015-12-04 12:38:22,358 INFO : Completed test suite (00:20:18) 12:38:22 INFO - 2015-12-04 12:38:22,359 DEBUG : Working with test: dromaeo_css 12:38:22 INFO - 2015-12-04 12:38:22,359 DEBUG : Generating results file: dromaeo_css 12:38:22 INFO - 2015-12-04 12:38:22,360 DEBUG : Working with test: kraken 12:38:22 INFO - 2015-12-04 12:38:22,360 DEBUG : Generating results file: kraken 12:38:22 INFO - 2015-12-04 12:38:22,360 INFO : javascript benchmark 12:38:22 INFO - 2015-12-04 12:38:22,360 DEBUG : Working with test: v8_7 12:38:22 INFO - 2015-12-04 12:38:22,361 DEBUG : Generating results file: v8_7 12:38:22 INFO - 2015-12-04 12:38:22,361 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:22 INFO - 2015-12-04 12:38:22,416 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 12:38:22 INFO - 2015-12-04 12:38:22,416 DEBUG : process_Request line: dromaeo_css 6428.77 graph.html#tests=[[72,132,43]] 12:38:22 INFO - 2015-12-04 12:38:22,416 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:22 INFO - 2015-12-04 12:38:22,449 DEBUG : process_Request line: kraken 1552.50 graph.html#tests=[[232,132,43]] 12:38:22 INFO - 2015-12-04 12:38:22,449 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:22 INFO - 2015-12-04 12:38:22,481 DEBUG : process_Request line: v8_7 21299.27 graph.html#tests=[[230,132,43]] 12:38:22 INFO - 2015-12-04 12:38:22,483 INFO : javascript benchmark 12:38:22 INFO - 2015-12-04 12:38:22,486 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.171316891763, 2715.158300926714, 2747.3131717070733, 2763.2124844419336, 2777.041920537415, 4671.906561868761, 4815.686980346275, 4839.612830973522, 4852.053849499344, 4901.362822833035, 4790.425148982127, 4806.279058141281, 4806.663533552653, 4818.445878723948, 4946.084974279761, 4341.327094300388, 4416.646668266539, 4458.843940462085, 4459.331100334959, 4498.032922921571, 4157.147784704143, 4415.116976604676, 4486.730796152225, 4523.3441151033085, 4544.113897789915, 4394.670399720034, 4454.866354009385, 4474.932876006863, 4487.461504619467, 4514.0294836609955, 4414.139242847646, 4482.282834746425, 4506.932396014063, 4509.301058335963, 4550.68145229834, 4184.66522678185, 4281.593248641374, 4291.098869237464, 4469.888252793674, 4491.640668746492, 4775.0, 4786.1863483207935, 4791.0178413425165, 4809.567138957511, 4864.513548645143, 5191.32512773337, 5219.321488206547, 5229.450907654679, 5233.764480598345, 5250.7374631268285, 4982.352294201767, 5034.521720436553, 5085.923711144335, 5110.923336149961, 5182.507661772125, 4758.048390321949, 4769.117713223065, 4787.066522028241, 4795.0, 4834.154023045953, 5269.420363759983, 5278.261043453919, 5299.258103865462, 5301.54936830366, 5304.92042619361, 4920.089783390084, 4941.332920055818, 5020.7740651670765, 5047.848564543069, 5050.545450909436, 5143.434222235551, 5170.0, 5174.586033117342, 5182.093133701587, 5211.348581427322, 4935.284383764334, 5099.515546023122, 5101.617378696538, 5107.310513080686, 5109.591232701449, 4963.57809586182, 4986.601071914238, 5011.348524691767, 5034.0, 5078.619103567247, 4241.893952651209, 4268.573142685768, 4276.72201306914, 4298.097399546068, 4337.50118736343, 3627.093226693327, 3709.5548534176073, 3783.5459744830796, 3796.5823759386444, 3839.2705385976574, 4260.275753121977, 4378.978105109454, 4421.712588681726, 4520.864374068783, 4523.163214805271, 5195.584353251731, 5221.556167725786, 5225.1117310056625, 5229.137192363218, 5268.841934741888, 4476.283794592915, 4477.6417886569, 4482.21561226784, 4489.663275254369, 4492.932606010912, 4378.124375124988, 4460.442444694413, 4463.330500424962, 4474.709143905636, 4569.977150114228, 4919.877003074952, 4945.579625731853, 4968.701877887338, 4973.776180071833, 4985.326980857682, 5225.81709640176, 5235.842924712265, 5236.869078273074, 5242.266082748494, 5243.265942767939, 4680.157571637002, 4791.808327666994, 4835.419749630067, 4885.413750349981, 4925.729084900365, 5001.174806156943, 5007.69953802773, 5027.899442011066, 5034.345535080416, 5044.0, 5015.523525265094, 5109.335786347751, 5110.0, 5115.5396014358885, 5116.616253781056, 4930.13722598551, 4946.678465899849, 4962.925556116734, 5022.045811295842, 5048.621353398583, 4936.0, 4960.627952903619, 4965.4786247444945, 4968.130577148912, 5025.69845809238, 4711.175544279668, 4819.759012049313, 4878.731669758197, 4889.7799599018845, 4921.729304888266, 4912.852614421573, 4919.680220785637, 4963.677360971526, 4989.850304490871, 5016.272640467038, 4868.756562171948, 4948.208286674115, 4961.627877909099, 4983.9501604984935, 4998.725070121178], "unit": "ms", "name": "dojo.html", "value": 4710.539026599211}, {"lowerIsBetter": false, "replicates": [567.9829605111845, 585.2625691628548, 591.101525680965, 592.1266132454629, 635.5646382228172, 37161.62838371615, 37756.62243377566, 37809.81095094524, 38098.42852357213, 38132.61867381325, 39176.60823391765, 39476.60523394765, 39518.20963580734, 39604.0, 39646.60353396472, 7796.922030779705, 7932.841343173133, 7970.043594768636, 7974.441789074767, 7984.680612775482, 7769.922300776976, 7859.331956783652, 7897.723579674713, 7913.248241417056, 7913.366930645535, 7544.170141284454, 7606.277403646644, 7643.847123057535, 7664.616769161547, 7681.57751323677, 7800.141984381714, 7906.446548741562, 7906.6837326506875, 7930.206979302053, 7950.204979502061, 7712.228777122299, 7884.684612615489, 7894.131645518988, 7911.446198766089, 7912.604369781546, 36061.45907811385, 36313.27373452516, 36617.267654646756, 36696.81651591752, 36703.63296367029, 2593.74062593741, 2626.1071235779737, 2657.162993656992, 3021.8640161192798, 3245.496947973068, 27427.725722742915, 27929.0, 27938.860305698545, 27940.742666580052, 28163.155105346872, 3400.4219282721997, 3426.468897320919, 3465.289615628815, 3491.5810102787573, 3567.108222944264, 216463.0, 217192.0, 217423.0, 217661.0, 218321.0, 47278.527214727415, 54799.0, 54890.451095489334, 54944.45055549393, 55017.44982550203, 43434.87368699969, 65112.674436627516, 65784.67107664431, 65871.34128658652, 66435.66782166058, 14268.500602478864, 14584.197869117088, 14603.050801697857, 14604.05073670208, 14649.0, 10916.290441121302, 11093.057090147428, 11118.277311974858, 11129.387883666313, 11140.554377824958, 19060.428187154408, 19126.521836954187, 19232.807671923103, 19286.80713192878, 19365.225390984484, 7302.707891684379, 7630.961845190738, 7642.388608911274, 7689.846203075907, 7732.536047837148, 903.2322525852973, 905.2594087617155, 950.6482601437374, 1012.9161796877418, 1033.6278939581744, 26415.094339622625, 26752.464950700876, 26817.329566760985, 27071.458570828472, 27169.320766980985, 948.3456415073578, 968.3705591365668, 990.2375171118342, 1074.7474343529263, 1079.5519859258477, 13629.25039122838, 13768.0, 13801.378937947817, 13908.304584770924, 14042.789358159636, 260518.0, 264423.0, 265834.0, 266086.0, 267786.0, 45789.77105114453, 46051.53948460473, 46258.537414626095, 46598.76700616543, 46639.0, 1186.590626233948, 1215.1736818963013, 1216.3674889057818, 1216.9026477881926, 1223.174357308813, 25111.49777004486, 26320.078797242004, 26509.469810604067, 26672.59991100096, 26677.06630267931, 40282.1943561133, 40439.19121617492, 40792.38811417772, 40944.385834213106, 41043.0, 245105.0, 247357.0, 247431.0, 247998.0, 248261.0, 24757.62863557084, 25299.0, 28964.13107606775, 29032.56451153192, 29562.260943476584, 38806.4179037309, 39056.609433905294, 39192.0, 40140.98590140962, 40480.0, 30170.24574385658, 30306.770449704272, 30306.84846575753, 30851.38297233998, 30951.69048309488, 29511.704882950897, 29534.556981644862, 29600.703992960654, 29609.5558566626, 30010.0, 30705.539416908316, 30915.536266956464, 31281.530777037908, 31320.0, 32627.836860816493, 28013.859930700215, 29970.70029299679, 30490.69509304967, 30492.542611861285, 30775.692243077283, 23699.526009480058, 23713.28860134199, 23790.405239869142, 23851.761482384954, 24213.515729684954], "unit": "ms", "name": "ext.html", "value": 16830.327556032484}, {"lowerIsBetter": false, "replicates": [331.07134487761834, 331.93449028618136, 333.01095745635456, 333.4131927807059, 333.68633484524554, 10115.039071288234, 10298.176145908319, 10465.843012354802, 14940.25298735063, 15466.458673946414, 12590.370481475935, 12665.366731663426, 13130.27783471911, 15439.536813895573, 15867.285972131252, 5608.887822243552, 5666.461686139821, 5703.372629010805, 5727.885442291152, 5847.502962248214, 5595.132754423071, 5652.830415087534, 5695.77216911323, 5696.2594862668, 5699.68651724155, 5544.306961629796, 5679.0, 6120.908186377208, 6286.748530058792, 6312.715927783261, 6288.748450061992, 6299.874002519947, 6345.302016778151, 6811.829704257384, 6815.897761533581, 6524.641144737037, 6534.869302613969, 6556.082148499214, 6559.8032059038305, 6572.474202063823, 19101.140448679842, 19757.901210493997, 20423.591528169352, 21220.0, 21457.0, 1866.1135960418828, 1898.439960211727, 1899.0220036681121, 1917.1564511614845, 2004.2083377066124, 12984.480620775157, 13019.804702929463, 13027.544035958696, 13094.345282735825, 13155.736885262337, 1727.3695101288065, 1732.774739283885, 1749.1516614441985, 1756.771619689445, 1764.700000999833, 58857.0, 59892.401075989554, 60549.09176362358, 64388.678056610355, 65450.67274663596, 15278.618034549003, 15376.38494460209, 15463.304151313218, 15515.0, 15594.766078508832, 23364.415889602897, 23380.18169364098, 23542.882285588807, 23657.870791628837, 23823.761762382153, 8512.489250644981, 8819.867701984474, 8911.0, 8990.056044115274, 9022.729318120468, 7481.70073197066, 7531.585762783099, 7550.0, 7589.241075892367, 7620.390368770485, 7480.17718051014, 7576.696932122653, 7594.772156835304, 7719.266669666373, 7773.494722842997, 1727.5681079730068, 1787.428023032643, 3147.5436061770915, 3189.3940151371166, 3197.4724170512072, 846.7925358287259, 850.2815121222557, 895.3866601378077, 908.2688435809105, 912.9452232866049, 15285.770713439308, 15607.375704971673, 15690.215489225493, 16239.0, 16271.430499932681, 822.5681517203516, 844.6494704697482, 846.1580727176375, 859.5659192107945, 867.696306292805, 8639.95680021596, 8759.211670949646, 8976.05751396107, 9086.001079762442, 9163.86562978578, 491334.0, 495786.0, 498098.0, 501434.0, 504399.0, 71353.64323178351, 72564.27435725575, 72652.0, 73129.78396836222, 73628.0, 1075.0808059109506, 1077.7305673581604, 1087.575845420271, 1088.820344643125, 1105.7898999189968, 14550.955302716182, 14613.561593152222, 14620.926895365881, 14811.25943702832, 14863.702725945204, 31709.682903170673, 32420.35159296848, 32458.83770581132, 32731.181720457178, 33059.834700826344, 42422.787886060374, 43880.122397552506, 43979.12041759211, 44034.77982610066, 47350.0, 8640.481571105502, 8648.956755216184, 8649.481031138152, 8767.386282960131, 9019.909800901907, 10523.421211833424, 10554.630587929385, 10565.841512377167, 10654.786904262026, 13230.603081907559, 12957.352132393155, 13104.279264640536, 13158.01314901367, 13161.802572961606, 13201.537946171838, 12528.99768018538, 12886.548970785978, 12936.676583085498, 12957.028222883133, 13002.804957925828, 12781.297028663514, 12931.353432328158, 13292.933535332262, 13383.933080334536, 13630.0, 9107.316951228817, 9117.133872282122, 9186.494742789211, 9217.907820921973, 9239.0, 13178.670533236746, 13287.40206690682, 13476.393562289917, 13834.446622135405, 13940.093893896865], "unit": "ms", "name": "jquery.html", "value": 9070.58819917162}, {"lowerIsBetter": false, "replicates": [1395.5603984744798, 1409.739198248324, 1467.3763650448557, 1643.137352889733, 1698.991505042475, 6012.398760123996, 6115.0, 6824.385805277524, 7366.926330736697, 7383.22476140005, 6808.659567021654, 6889.7588584399555, 6999.230084690693, 7009.614471204081, 7009.684564194611, 1984.7022946557988, 2019.0712272354735, 2022.0799536211061, 2028.7869773673774, 2029.52306208041, 2041.8570700051002, 2066.638338290793, 2073.8548301618894, 2082.9791702082935, 2105.3683894831565, 2001.6597178479622, 2002.8097330753556, 2016.3043749906258, 2021.6563184258637, 2026.1591439552567, 2048.2114385961363, 2062.0411508648476, 2069.048237810594, 2069.3895300886275, 2071.461420030788, 2034.033833928872, 2046.3349411441193, 2068.782777808339, 2071.9171233150655, 2074.502119491311, 7178.641067946634, 7210.423166146696, 7228.819279518054, 7246.746363877239, 7253.093363329584, 4117.670586353114, 4143.6892233082335, 4148.730332528376, 4162.0, 4168.7707176105305, 2590.3653604866927, 2604.6613940187653, 2636.2882021853993, 2648.9337766555795, 2651.992242947687, 827.9296259817922, 828.5070383122032, 853.6884037326394, 857.7984173719234, 858.6050416808275, 9463.858042129374, 9472.857907131398, 9491.003444638283, 9526.0, 9585.329026968115, 3839.0978120141745, 3851.9037024074623, 3883.456316115746, 3883.9029024274055, 3922.980385098056, 8129.837403251902, 8271.2142346477, 8288.875666865002, 8304.418690691715, 8343.332533397313, 4050.797460126982, 4061.329880569732, 4080.9795951020646, 4125.608067233608, 4135.77253251074, 3203.6956489133495, 3295.6210035846184, 3679.5400574928135, 3694.4273637586216, 3708.981455092707, 3400.472926696366, 3433.1760377509218, 3441.4321636929626, 3445.0870519312402, 3488.965110348915, 1102.1293178389144, 1113.1484414422973, 1122.3266040375709, 1127.5320741892024, 1130.2709752209778, 1186.9821952670716, 1193.075366590899, 1193.2601786892183, 1207.6980754811298, 1214.089432925306, 6644.169478815148, 6724.125863637696, 6785.084013658093, 6788.1175447191545, 6813.897791533131, 420.68238479948053, 421.90749727642, 422.5520947795347, 428.2526990401769, 437.52309982119004, 5312.442193569696, 5329.786808527616, 5373.623846330719, 5391.299131113009, 5399.190121481809, 8355.248027677417, 8355.415120941598, 8551.187637174458, 8561.743147705578, 8685.739427817176, 8403.41176117666, 8418.368622353348, 8485.151484851465, 8501.107383724744, 8526.31789456842, 6629.469642428594, 6655.933440665725, 6740.9325906740305, 6742.865142697118, 6806.55757375769, 6389.361063893573, 6413.583117097561, 6460.192475940507, 6474.870502589828, 6476.125723027331, 7448.068991376078, 7553.546787192786, 7675.961620191863, 7715.382769378324, 7745.264199901, 7721.090632624663, 7818.530888146729, 7843.4509584330835, 7907.56508392021, 7921.207879212033, 5190.195519694454, 5332.253484512249, 5864.44287792659, 6202.255729312331, 6263.843403914756, 6542.574732642363, 6568.1789776277965, 6569.178852643419, 6693.2972037935315, 6727.831804204934, 6139.079138129317, 6188.566800323934, 6229.657368844757, 6322.525810564318, 6382.808515744535, 6321.96839015802, 6378.585391949508, 6379.649119298483, 6445.548811583144, 6524.4454221389815, 6056.454919057306, 6085.0, 6088.939110608837, 6096.298925623432, 6101.7559297627595, 5487.286652735119, 5507.504324610804, 5530.6128570999645, 5535.474129957647, 5547.11246200606, 5560.4161563035295, 5627.493525582717, 5673.0, 5695.515881149983, 5708.743106560298], "unit": "ms", "name": "mootools.html", "value": 3945.55834733019}, {"lowerIsBetter": false, "replicates": [280.53151237433485, 288.7358067368358, 291.16145500957225, 291.65875925167546, 291.96204493415854, 5403.78384864605, 5618.213450116982, 5682.51698605618, 5689.345725241598, 5788.594798364116, 5649.943500564993, 5653.830385088444, 5654.74553645086, 5655.1517272409155, 5673.120666296721, 4240.279152544075, 4243.193793179286, 4252.4046633471335, 4268.082362292106, 4268.871933841974, 4255.234057869582, 4259.382389553512, 4260.8721738347895, 4262.232798096342, 4267.637250833683, 3987.003249187703, 4149.087200815816, 4202.516710578277, 4209.989602495394, 4222.113356195187, 4153.8961525961795, 4155.044339801862, 4155.31437312843, 4158.729682570638, 4163.854265100737, 3594.676479116892, 3602.873899413508, 3606.819659017065, 3608.458731190316, 3614.8915532534065, 5348.277982472356, 5350.839474815762, 5359.0, 5363.436839131874, 5371.194320851903, 4629.65277604181, 4784.64115191362, 4807.711537307773, 4814.446338671028, 4818.325434439182, 5671.120976248688, 5775.48020678141, 5778.393268706767, 5789.189513468118, 5817.767289308423, 3877.8448862045484, 3880.767153970771, 3882.010087427716, 3885.417187421881, 3887.047673320055, 6102.8779424411705, 6130.386961303879, 6149.477294429978, 6160.5687601867885, 6175.135481032659, 3869.7678139311734, 3996.0, 4011.8194681239415, 4019.2363450944226, 4020.537638171589, 4075.7350772200307, 4079.204555111725, 4079.6124368184974, 4083.673306135502, 4084.7549147051272, 4768.904621907612, 4770.189067858472, 4770.952290477051, 4771.785269662873, 4776.522347765195, 5876.676782776988, 5882.941170588325, 5884.499817515473, 5887.793927212527, 5903.291605007426, 1393.7700279453777, 1420.389232629979, 1445.8265008199082, 1451.5935538049364, 1452.244832687018, 932.6036434515439, 945.7068308824149, 946.8390373636498, 951.286535098676, 957.2963871554402, 5027.044861476308, 5072.847814565569, 5074.746262686925, 5089.8727531812, 5090.134677104901, 6022.427869352405, 6033.78881739137, 6034.366391528826, 6046.123312119806, 6068.33248342682, 5042.4705405931845, 5047.141985862412, 5062.594992400599, 5071.771770270347, 5075.3402057732255, 3217.0670505553594, 3234.1429521176906, 3261.4292498812615, 3267.803931764102, 3313.8508767105536, 5780.682062486603, 5836.299644042657, 5836.941630583725, 5841.182234487175, 5845.0, 6281.183446151971, 6322.652254126067, 6331.620102793847, 6333.20834895638, 6348.460380867586, 5689.402612725604, 5757.827265182052, 5817.854553636108, 5818.21454103699, 5827.388124246893, 6051.394860513913, 6090.573659843769, 6115.510759139169, 6173.228346456693, 6180.7527698891545, 6028.306744724413, 6033.517318614413, 6034.064719968412, 6047.425494578008, 6057.394260573908, 5783.479486846204, 5793.0, 5806.9419305806405, 5810.82567522975, 5827.562932779973, 3949.763014219156, 4031.67746580267, 4034.293998550301, 4042.8989275268355, 4046.736962097454, 5874.17761513397, 6103.816885493442, 6106.755729770759, 6118.755249790137, 6124.14262003311, 5762.769489220552, 5795.217645617788, 5882.764689412375, 5931.228940237742, 5949.405059494016, 5871.647701137946, 5914.58050067972, 5929.822105336847, 5939.346671866005, 5948.0, 5665.065264231355, 5755.050416681201, 5787.131930210502, 5801.970990145022, 5808.0, 5964.284285885721, 5976.940230597638, 5984.401559844155, 5987.790427335022, 6008.279006519071, 5783.248177736868, 5784.161296612052, 5784.50831679312, 5788.942110579009, 5795.565332599987], "unit": "ms", "name": "prototype.html", "value": 4339.580842549056}, {"lowerIsBetter": false, "replicates": [708.7979925721168, 722.3715367630161, 752.3642522068853, 755.9659815308312, 788.1724189600917, 11152.0, 11418.600348987788, 11457.828132578017, 11462.942685286584, 11485.483153258114, 11033.944830275837, 11130.49912753926, 11224.887751122485, 11227.0, 11265.887341126587, 626.8589567347356, 638.4605008767608, 791.1574173505198, 802.5987006496752, 813.4427916876929, 815.3110621524802, 816.5508970066469, 824.0605709491185, 824.9505029698207, 825.3892119831312, 854.2354592639584, 856.3235044315015, 857.4855086947844, 859.7034023261965, 862.8835107260502, 840.2731637133896, 848.4103548034119, 851.0553285852699, 852.2074470742207, 852.9658813647478, 631.6810010944489, 633.1009965848506, 633.7116611941556, 634.3751404866204, 635.5297080160694, 11469.655910322703, 11586.47860846264, 11633.94183029088, 11670.241434306743, 11699.23954942926, 10591.152707783358, 10909.945450272777, 11256.54973801047, 11869.46587403569, 12154.696132596668, 9569.33014688972, 9591.232701383942, 9619.807603847954, 9722.513874306327, 9828.852567211497, 3225.12921511193, 3267.3628642414737, 3270.591176102987, 3284.8193349365774, 3300.2574420755136, 41550.37674434886, 41599.37600935988, 41789.79105104455, 42275.7886210567, 42312.365314520306, 8964.551772411354, 9071.909280907106, 9135.862962055575, 9149.725508234764, 9270.90729092714, 16098.275577599035, 16168.838311616968, 16264.593385165228, 16312.592185195464, 16526.752098718287, 6148.44663980244, 6238.937610623836, 6254.718537665816, 6268.373162683695, 6472.611643301417, 3524.524189234472, 3574.5353104096303, 3611.6749492545273, 3683.060819491066, 3683.6684698377276, 2719.5920611908373, 2721.6461859958476, 2737.3156710822295, 2753.559430491112, 2760.7239276072232, 455.1261577770622, 470.4260801821772, 475.39624676660446, 475.5125995854277, 491.0890298496238, 446.15676371657594, 452.34184261899514, 481.059528621544, 494.87133345329755, 545.1277955271613, 7181.6409179540815, 7355.742549010759, 7477.7008919643695, 7513.661885215179, 7549.547027178387, 424.7493978552607, 511.48595661360093, 595.0301009354724, 619.127030886457, 627.8932581461163, 3591.174029973121, 3684.115812205105, 3795.1460921292487, 3905.5899130591447, 3907.5897030811357, 48634.0, 48888.755556222706, 49023.264651030266, 49325.26012109821, 49343.25985110226, 44578.55421445809, 45131.32303015458, 45188.77405613017, 45227.32159017617, 45340.77329613397, 40147.0, 40295.19409611791, 40326.59673403287, 44090.33864492035, 44982.32526512105, 7736.7678969631, 7758.586460194605, 8108.432409731262, 8236.670533178605, 8438.367122465963, 31936.52095218527, 32412.83793581017, 32590.83704581462, 32716.83641581872, 32906.50640240446, 37063.6293637071, 37427.81286093552, 38942.4158637615, 40676.0, 41062.1787564253, 10383.273170877967, 10464.215183861088, 10501.842472362769, 10543.57825686964, 10604.734881628021, 11429.59996400122, 11511.76976460483, 11653.825192621947, 11913.90054370757, 12028.15802893789, 10388.896111038794, 10428.165746740395, 10789.676309710721, 10900.454977250947, 10956.671299861016, 10555.472226388803, 10799.56801727922, 10904.0, 11046.558137674403, 11369.54521819151, 10497.002784735438, 10500.159987201157, 10768.40773757451, 10776.245662803529, 10798.406087665255, 9224.907750922404, 9636.807263854824, 9815.901840981784, 9890.0, 10073.496325183858, 9013.549322533716, 9147.496887671243, 9222.815543688954, 9316.534173291444, 9341.626334946526], "unit": "ms", "name": "yui.html", "value": 5732.778015505573}], "name": "dromaeo_css", "value": 6428.767819826559}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 115.0, 111.0, 113.0, 124.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [160.0, 132.0, 157.0, 169.0, 131.0, 156.0, 155.0, 135.0, 177.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 161.0, 165.0, 167.0, 167.0, 162.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 73.0, 74.0, 164.0, 73.0, 71.0, 75.0, 74.0, 157.0], "unit": "ms", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 135.0, 96.0, 95.0, 96.0, 131.0, 94.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 157.0, 148.0, 149.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 72.0, 72.0, 73.0, 72.0, 71.0, 74.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [75.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 93.0, 88.0, 86.0, 84.0, 86.0, 85.0, 84.0, 97.0, 98.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [121.0, 135.0, 122.0, 143.0, 137.0, 131.0, 123.0, 149.0, 125.0, 141.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 132.7}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 144.0, 145.0, 137.0, 149.0, 133.0, 141.0, 142.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 67.0, 68.0, 70.0, 69.0, 70.0, 70.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1552.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [183.85732671446956], "unit": "score", "name": "DeltaBlue", "value": 359.615802}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [705.7163020465773], "unit": "score", "name": "Earley", "value": 944.3780709999997}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 21299.26798392863}]} 12:38:22 INFO - RETURN: dromaeo_css: 6428.77 12:38:22 INFO - RETURN: kraken: 1552.50 12:38:22 INFO - RETURN: v8_7: 21299.27 12:38:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21299.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1552.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6428.77"}}} 12:38:22 INFO - Return code: 0 12:38:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:38:22 INFO - # TBPL SUCCESS # 12:38:22 INFO - Running post-action listener: _resource_record_post_action 12:38:22 INFO - Running post-run listener: _resource_record_post_run 12:38:23 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 504479744; Read time: 0; Write time: 467076 12:38:23 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231165952; Read time: 0; Write time: 308884 12:38:23 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 272433152; Read time: 0; Write time: 158132 12:38:23 INFO - Running post-run listener: _upload_blobber_files 12:38:23 INFO - Blob upload gear active. 12:38:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:38:23 INFO - Copying logs to upload dir... 12:38:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.978852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-04 12:38:23.537465) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:38:23.541447) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010048 build_url: 'https://queue.taskcluster.net/v1/task/miMweytXSuKcNjQBCbRHTg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 12:38:23.593315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:38:23.593664) ========= 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=447a3abc0420b6a47dd38cba000001bf-1449260232.804226-484751800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004694 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 12:38:23.642794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 12:38:23.643131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 12:38:23.643422) ========= ========= Total master_lag: 0.23 =========