builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1449267641.02 results: success (0) buildid: 20151204094024 builduid: 8792ef2e4a8d4ef4a751305258b2a82e revision: 18a0014d720691eb17a609352d29426ab2821f4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.016648) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.017126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.017443) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004347 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.034961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.035297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.047753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.048138) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.097298) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.097603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.098002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.098292) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 14:20:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-04 14:20:41 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.280754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.281066) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014012 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.331571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:41.332240) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 18a0014d720691eb17a609352d29426ab2821f4f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 18a0014d720691eb17a609352d29426ab2821f4f --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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 14:20:41,408 truncating revision to first 12 chars 2015-12-04 14:20:41,408 Setting DEBUG logging. 2015-12-04 14:20:41,408 attempt 1/10 2015-12-04 14:20:41,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/18a0014d7206?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 14:20:41,722 unpacking tar archive at: cedar-18a0014d7206/testing/mozharness/ program finished with exit code 0 elapsedTime=0.770929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:42.116951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:42.117264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:42.127909) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:42.128510) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/default ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 14:20:42.129171) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-04 14:20:42.129660) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:20:42 INFO - MultiFileLogger online at 20151204 14:20:42 in /builds/slave/test 14:20:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 14:20:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:20:42 INFO - {'append_to_log': False, 14:20:42 INFO - 'base_work_dir': '/builds/slave/test', 14:20:42 INFO - 'blob_upload_branch': 'Cedar', 14:20:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:20:42 INFO - 'branch': 'Cedar', 14:20:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:20:42 INFO - 'config_files': ('talos/linux_config.py',), 14:20:42 INFO - 'default_actions': ('clobber', 14:20:42 INFO - 'read-buildbot-config', 14:20:42 INFO - 'download-and-extract', 14:20:42 INFO - 'populate-webroot', 14:20:42 INFO - 'create-virtualenv', 14:20:42 INFO - 'install', 14:20:42 INFO - 'run-tests'), 14:20:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:20:42 INFO - 'download_minidump_stackwalk': True, 14:20:42 INFO - 'download_symbols': 'ondemand', 14:20:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:20:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:20:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:20:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:20:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:20:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:20:42 INFO - 'installer_path': 'installer.exe', 14:20:42 INFO - 'log_level': 'info', 14:20:42 INFO - 'log_name': 'talos', 14:20:42 INFO - 'log_to_console': True, 14:20:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:20:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:20:42 INFO - 'opt_config_files': (), 14:20:42 INFO - 'pip_index': False, 14:20:42 INFO - 'sps_profile': False, 14:20:42 INFO - 'sps_profile_interval': 0, 14:20:42 INFO - 'suite': 'dromaeojs', 14:20:42 INFO - 'system_bits': '64', 14:20:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:20:42 INFO - 'title': 'talos-linux64-ix-053', 14:20:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:20:42 INFO - 'use_talos_json': True, 14:20:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:20:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:20:42 INFO - 'work_dir': 'build'} 14:20:42 INFO - ##### 14:20:42 INFO - ##### Running clobber step. 14:20:42 INFO - ##### 14:20:42 INFO - Running pre-action listener: _resource_record_pre_action 14:20:42 INFO - Running main action method: clobber 14:20:42 INFO - rmtree: /builds/slave/test/build 14:20:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:20:42 INFO - Running post-action listener: _resource_record_post_action 14:20:42 INFO - ##### 14:20:42 INFO - ##### Running read-buildbot-config step. 14:20:42 INFO - ##### 14:20:42 INFO - Running pre-action listener: _resource_record_pre_action 14:20:42 INFO - Running main action method: read_buildbot_config 14:20:42 INFO - Using buildbot properties: 14:20:42 INFO - { 14:20:42 INFO - "properties": { 14:20:42 INFO - "buildnumber": 1, 14:20:42 INFO - "product": "firefox", 14:20:42 INFO - "script_repo_revision": "default", 14:20:42 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 14:20:42 INFO - "repository": "", 14:20:42 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 14:20:42 INFO - "buildid": "20151204094024", 14:20:42 INFO - "slavename": "talos-linux64-ix-053", 14:20:42 INFO - "pgo_build": "False", 14:20:42 INFO - "basedir": "/builds/slave/test", 14:20:42 INFO - "project": "", 14:20:42 INFO - "platform": "ubuntu64_hw", 14:20:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:20:42 INFO - "slavebuilddir": "test", 14:20:42 INFO - "scheduler": "tests-cedar-linux64-talos", 14:20:42 INFO - "branch": "cedar", 14:20:42 INFO - "repo_path": "projects/cedar", 14:20:42 INFO - "stage_platform": "linux64", 14:20:42 INFO - "builduid": "8792ef2e4a8d4ef4a751305258b2a82e", 14:20:42 INFO - "revision": "18a0014d720691eb17a609352d29426ab2821f4f" 14:20:42 INFO - }, 14:20:42 INFO - "sourcestamp": { 14:20:42 INFO - "repository": "", 14:20:42 INFO - "hasPatch": false, 14:20:42 INFO - "project": "", 14:20:42 INFO - "branch": "cedar-linux64-talos", 14:20:42 INFO - "changes": [ 14:20:42 INFO - { 14:20:42 INFO - "category": null, 14:20:42 INFO - "files": [ 14:20:42 INFO - { 14:20:42 INFO - "url": null, 14:20:42 INFO - "name": "https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:20:42 INFO - } 14:20:42 INFO - ], 14:20:42 INFO - "repository": "", 14:20:42 INFO - "rev": "18a0014d720691eb17a609352d29426ab2821f4f", 14:20:42 INFO - "who": "bind-autoland@mozilla.com", 14:20:42 INFO - "when": 1449254880, 14:20:42 INFO - "number": 6745469, 14:20:42 INFO - "comments": "Bug 1154057 - Disable all TaskCluster tests on cedar. r=etocm\n\nTaskCluster tests are mostly failing; disabling to get rid of a bunch\nof oranges.", 14:20:42 INFO - "project": "", 14:20:42 INFO - "at": "Fri 04 Dec 2015 10:48:00", 14:20:42 INFO - "branch": "cedar-linux64-talos", 14:20:42 INFO - "revlink": "", 14:20:42 INFO - "properties": [ 14:20:42 INFO - [ 14:20:42 INFO - "buildid", 14:20:42 INFO - "20151204094024", 14:20:42 INFO - "Change" 14:20:42 INFO - ], 14:20:42 INFO - [ 14:20:42 INFO - "builduid", 14:20:42 INFO - "8792ef2e4a8d4ef4a751305258b2a82e", 14:20:42 INFO - "Change" 14:20:42 INFO - ], 14:20:42 INFO - [ 14:20:42 INFO - "pgo_build", 14:20:42 INFO - "False", 14:20:42 INFO - "Change" 14:20:42 INFO - ] 14:20:42 INFO - ], 14:20:42 INFO - "revision": "18a0014d720691eb17a609352d29426ab2821f4f" 14:20:42 INFO - } 14:20:42 INFO - ], 14:20:42 INFO - "revision": "18a0014d720691eb17a609352d29426ab2821f4f" 14:20:42 INFO - } 14:20:42 INFO - } 14:20:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:20:42 INFO - Running post-action listener: _resource_record_post_action 14:20:42 INFO - ##### 14:20:42 INFO - ##### Running download-and-extract step. 14:20:42 INFO - ##### 14:20:42 INFO - Running pre-action listener: _resource_record_pre_action 14:20:42 INFO - Running main action method: download_and_extract 14:20:42 INFO - mkdir: /builds/slave/test/build/tests 14:20: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')]} 14:20:42 INFO - https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:20:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/test_packages.json 14:20:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/test_packages.json 14:20:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:20:43 INFO - Downloaded 1302 bytes. 14:20:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:20:43 INFO - Using the following test package requirements: 14:20:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:20:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:20:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'jsshell-linux-x86_64.zip'], 14:20:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:20:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:20:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:20:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:20:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:20:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:20:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:20:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:20:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:43 INFO - https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:45 INFO - Downloaded 21849281 bytes. 14:20:45 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 14:20:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:45 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 14:20:46 INFO - Return code: 0 14:20:46 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 14:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:46 INFO - https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:20:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:48 INFO - Downloaded 21849281 bytes. 14:20:48 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 14:20:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:20:48 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 14:20:49 INFO - Return code: 0 14:20:49 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')]} 14:20:49 INFO - https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:51 INFO - Downloaded 11132001 bytes. 14:20:51 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 14:20:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:20:51 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 14:20:51 INFO - Return code: 0 14:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:51 INFO - https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:20:53 INFO - Downloaded 57699497 bytes. 14:20:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:20:53 INFO - mkdir: /builds/slave/test/properties 14:20:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:20:53 INFO - Writing to file /builds/slave/test/properties/build_url 14:20:53 INFO - Contents: 14:20:53 INFO - build_url:https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:20:53 INFO - Running post-action listener: _resource_record_post_action 14:20:53 INFO - Running post-action listener: set_extra_try_arguments 14:20:53 INFO - ##### 14:20:53 INFO - ##### Running populate-webroot step. 14:20:53 INFO - ##### 14:20:53 INFO - Running pre-action listener: _resource_record_pre_action 14:20:53 INFO - Running main action method: populate_webroot 14:20:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:20:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:20:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:20:53 INFO - '../fennec_ids.txt'], 14:20:53 INFO - 'tests': ['tcheck2']}, 14:20:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:20:53 INFO - '--tppagecycles', 14:20:53 INFO - '7'], 14:20:53 INFO - 'tests': ['tsvgm']}}, 14:20:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:20:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:20:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:20:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:20:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:20:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'tests': ['damp', 'tps']}, 14:20:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['damp', 'tps']}, 14:20:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:20:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:20:53 INFO - 'other': {'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'other_l64': {'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'other_nol64': {'tests': ['a11yr', 14:20:53 INFO - 'ts_paint', 14:20:53 INFO - 'tpaint', 14:20:53 INFO - 'sessionrestore', 14:20:53 INFO - 'sessionrestore_no_auto_restore']}, 14:20:53 INFO - 'svgr': {'tests': ['tsvgx', 14:20:53 INFO - 'tsvgr_opacity', 14:20:53 INFO - 'tart', 14:20:53 INFO - 'tscrollx', 14:20:53 INFO - 'cart']}, 14:20:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['tsvgx', 14:20:53 INFO - 'tsvgr_opacity', 14:20:53 INFO - 'tart', 14:20:53 INFO - 'tscrollx', 14:20:53 INFO - 'cart']}, 14:20:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'tests': ['tp5o']}, 14:20:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'talos_options': ['--e10s'], 14:20:53 INFO - 'tests': ['tp5o']}, 14:20:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'talos_options': ['--xperf_path', 14:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:53 INFO - 'tests': ['tp5n']}, 14:20:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:20:53 INFO - 'talos_options': ['--e10s', 14:20:53 INFO - '--xperf_path', 14:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:20:53 INFO - 'tests': ['tp5n']}}, 14:20:53 INFO - 'talos.zip': {'path': '', 14:20:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:20:53 INFO - Running post-action listener: _resource_record_post_action 14:20:53 INFO - ##### 14:20:53 INFO - ##### Running create-virtualenv step. 14:20:53 INFO - ##### 14:20:53 INFO - Running pre-action listener: _resource_record_pre_action 14:20:53 INFO - Running main action method: create_virtualenv 14:20:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:20:53 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 14:20:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:20:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:20:54 INFO - Using real prefix '/usr' 14:20:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:20:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:20:56 INFO - Installing pip.................done. 14:20:56 INFO - Return code: 0 14:20:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:20:56 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')]} 14:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:56 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')]} 14:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:56 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:20:56 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 14:20:56 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 14:20:56 INFO - Using env: {'DISPLAY': ':0', 14:20:56 INFO - 'HOME': '/home/cltbld', 14:20:56 INFO - 'LANG': 'en_US.UTF-8', 14:20:56 INFO - 'LANGUAGE': 'en_US:en', 14:20:56 INFO - 'LOGNAME': 'cltbld', 14:20:56 INFO - 'MAIL': '/var/mail/cltbld', 14:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:56 INFO - 'MOZ_NO_REMOTE': '1', 14:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:56 INFO - 'NO_EM_RESTART': '1', 14:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:56 INFO - 'PWD': '/builds/slave/test', 14:20:56 INFO - 'SHELL': '/bin/bash', 14:20:56 INFO - 'SHLVL': '1', 14:20:56 INFO - 'TERM': 'linux', 14:20:56 INFO - 'TMOUT': '86400', 14:20:56 INFO - 'USER': 'cltbld', 14:20:56 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:56 INFO - '_': '/tools/buildbot/bin/python'} 14:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:56 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 14:20:56 INFO - Cleaning up... 14:20:56 INFO - Return code: 0 14:20:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:20:56 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')]} 14:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:56 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')]} 14:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:56 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:20:56 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 14:20:56 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 14:20:56 INFO - Using env: {'DISPLAY': ':0', 14:20:56 INFO - 'HOME': '/home/cltbld', 14:20:56 INFO - 'LANG': 'en_US.UTF-8', 14:20:56 INFO - 'LANGUAGE': 'en_US:en', 14:20:56 INFO - 'LOGNAME': 'cltbld', 14:20:56 INFO - 'MAIL': '/var/mail/cltbld', 14:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:56 INFO - 'MOZ_NO_REMOTE': '1', 14:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:56 INFO - 'NO_EM_RESTART': '1', 14:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:56 INFO - 'PWD': '/builds/slave/test', 14:20:56 INFO - 'SHELL': '/bin/bash', 14:20:56 INFO - 'SHLVL': '1', 14:20:56 INFO - 'TERM': 'linux', 14:20:56 INFO - 'TMOUT': '86400', 14:20:56 INFO - 'USER': 'cltbld', 14:20:56 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:56 INFO - '_': '/tools/buildbot/bin/python'} 14:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:57 INFO - Downloading/unpacking psutil>=0.7.1 14:20:57 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 14:20:57 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 14:20:57 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 14:20:57 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 14:20:57 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 14:20:57 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 14:20:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:20:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:20:58 INFO - Installing collected packages: psutil 14:20:58 INFO - Running setup.py install for psutil 14:20:58 INFO - building 'psutil._psutil_linux' extension 14:20:58 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 14:20:59 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 14:20:59 INFO - building 'psutil._psutil_posix' extension 14:20:59 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 14:20:59 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 14:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:00 INFO - Successfully installed psutil 14:21:00 INFO - Cleaning up... 14:21:00 INFO - Return code: 0 14:21:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:21:00 INFO - Using env: {'DISPLAY': ':0', 14:21:00 INFO - 'HOME': '/home/cltbld', 14:21:00 INFO - 'LANG': 'en_US.UTF-8', 14:21:00 INFO - 'LANGUAGE': 'en_US:en', 14:21:00 INFO - 'LOGNAME': 'cltbld', 14:21:00 INFO - 'MAIL': '/var/mail/cltbld', 14:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:00 INFO - 'MOZ_NO_REMOTE': '1', 14:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:00 INFO - 'NO_EM_RESTART': '1', 14:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:00 INFO - 'PWD': '/builds/slave/test', 14:21:00 INFO - 'SHELL': '/bin/bash', 14:21:00 INFO - 'SHLVL': '1', 14:21:00 INFO - 'TERM': 'linux', 14:21:00 INFO - 'TMOUT': '86400', 14:21:00 INFO - 'USER': 'cltbld', 14:21:00 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:00 INFO - '_': '/tools/buildbot/bin/python'} 14:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:21:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:21:02 INFO - Installing collected packages: mozsystemmonitor 14:21:02 INFO - Running setup.py install for mozsystemmonitor 14:21:02 INFO - Successfully installed mozsystemmonitor 14:21:02 INFO - Cleaning up... 14:21:02 INFO - Return code: 0 14:21:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:21:02 INFO - Using env: {'DISPLAY': ':0', 14:21:02 INFO - 'HOME': '/home/cltbld', 14:21:02 INFO - 'LANG': 'en_US.UTF-8', 14:21:02 INFO - 'LANGUAGE': 'en_US:en', 14:21:02 INFO - 'LOGNAME': 'cltbld', 14:21:02 INFO - 'MAIL': '/var/mail/cltbld', 14:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:02 INFO - 'MOZ_NO_REMOTE': '1', 14:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:02 INFO - 'NO_EM_RESTART': '1', 14:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:02 INFO - 'PWD': '/builds/slave/test', 14:21:02 INFO - 'SHELL': '/bin/bash', 14:21:02 INFO - 'SHLVL': '1', 14:21:02 INFO - 'TERM': 'linux', 14:21:02 INFO - 'TMOUT': '86400', 14:21:02 INFO - 'USER': 'cltbld', 14:21:02 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:02 INFO - '_': '/tools/buildbot/bin/python'} 14:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:05 INFO - Downloading docopt-0.6.1.tar.gz 14:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:05 INFO - Running setup.py install for blobuploader 14:21:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:05 INFO - Running setup.py install for requests 14:21:05 INFO - Running setup.py install for docopt 14:21:05 INFO - Successfully installed blobuploader requests docopt 14:21:05 INFO - Cleaning up... 14:21:05 INFO - Return code: 0 14:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:05 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:05 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 14:21:05 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 14:21:05 INFO - Using env: {'DISPLAY': ':0', 14:21:05 INFO - 'HOME': '/home/cltbld', 14:21:05 INFO - 'LANG': 'en_US.UTF-8', 14:21:05 INFO - 'LANGUAGE': 'en_US:en', 14:21:05 INFO - 'LOGNAME': 'cltbld', 14:21:05 INFO - 'MAIL': '/var/mail/cltbld', 14:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:05 INFO - 'MOZ_NO_REMOTE': '1', 14:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:05 INFO - 'NO_EM_RESTART': '1', 14:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:05 INFO - 'PWD': '/builds/slave/test', 14:21:05 INFO - 'SHELL': '/bin/bash', 14:21:05 INFO - 'SHLVL': '1', 14:21:05 INFO - 'TERM': 'linux', 14:21:05 INFO - 'TMOUT': '86400', 14:21:05 INFO - 'USER': 'cltbld', 14:21:05 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:05 INFO - '_': '/tools/buildbot/bin/python'} 14:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:06 INFO - Running setup.py (path:/tmp/pip-rh7nR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:06 INFO - Running setup.py (path:/tmp/pip-HGodIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:06 INFO - Running setup.py (path:/tmp/pip-uT1k6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:06 INFO - Running setup.py (path:/tmp/pip-hGiPSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:06 INFO - Running setup.py (path:/tmp/pip-4rt3fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:06 INFO - Running setup.py (path:/tmp/pip-0BTE29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:06 INFO - Running setup.py (path:/tmp/pip-CaNKNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:06 INFO - Running setup.py (path:/tmp/pip-3hIOeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:06 INFO - Running setup.py (path:/tmp/pip-hzSdsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:06 INFO - Running setup.py (path:/tmp/pip-NsEeMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:06 INFO - Running setup.py (path:/tmp/pip-E_izJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:06 INFO - Running setup.py (path:/tmp/pip-4RmAOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:06 INFO - Running setup.py (path:/tmp/pip-MxQ5HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:06 INFO - Running setup.py (path:/tmp/pip-rFq3kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:06 INFO - Running setup.py (path:/tmp/pip-pvyLjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:07 INFO - Running setup.py (path:/tmp/pip-qk0l3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:07 INFO - Running setup.py (path:/tmp/pip-zsgfcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:07 INFO - Running setup.py install for manifestparser 14:21:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Running setup.py install for mozcrash 14:21:07 INFO - Running setup.py install for mozdebug 14:21:07 INFO - Running setup.py install for mozdevice 14:21:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Running setup.py install for mozfile 14:21:07 INFO - Running setup.py install for mozhttpd 14:21:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Running setup.py install for mozinfo 14:21:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Running setup.py install for mozInstall 14:21:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:07 INFO - Running setup.py install for mozleak 14:21:08 INFO - Running setup.py install for mozlog 14:21:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Running setup.py install for moznetwork 14:21:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Running setup.py install for mozprocess 14:21:08 INFO - Running setup.py install for mozprofile 14:21:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Running setup.py install for mozrunner 14:21:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Running setup.py install for mozscreenshot 14:21:08 INFO - Running setup.py install for moztest 14:21:08 INFO - Running setup.py install for mozversion 14:21:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:08 INFO - Cleaning up... 14:21:08 INFO - Return code: 0 14:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:08 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')]} 14:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:08 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')]} 14:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:08 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:08 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 14:21:08 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 14:21:08 INFO - Using env: {'DISPLAY': ':0', 14:21:08 INFO - 'HOME': '/home/cltbld', 14:21:08 INFO - 'LANG': 'en_US.UTF-8', 14:21:08 INFO - 'LANGUAGE': 'en_US:en', 14:21:08 INFO - 'LOGNAME': 'cltbld', 14:21:08 INFO - 'MAIL': '/var/mail/cltbld', 14:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:08 INFO - 'MOZ_NO_REMOTE': '1', 14:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:08 INFO - 'NO_EM_RESTART': '1', 14:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:08 INFO - 'PWD': '/builds/slave/test', 14:21:08 INFO - 'SHELL': '/bin/bash', 14:21:08 INFO - 'SHLVL': '1', 14:21:08 INFO - 'TERM': 'linux', 14:21:08 INFO - 'TMOUT': '86400', 14:21:08 INFO - 'USER': 'cltbld', 14:21:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:08 INFO - '_': '/tools/buildbot/bin/python'} 14:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:09 INFO - Running setup.py (path:/tmp/pip-Ixk30g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:09 INFO - Running setup.py (path:/tmp/pip-jEi03i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:09 INFO - Running setup.py (path:/tmp/pip-hitHXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:09 INFO - Running setup.py (path:/tmp/pip-X_syOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:09 INFO - Running setup.py (path:/tmp/pip-8POgcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:09 INFO - Running setup.py (path:/tmp/pip-u5Fv9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:09 INFO - Running setup.py (path:/tmp/pip-UFrp8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:09 INFO - Running setup.py (path:/tmp/pip-QHQgRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:09 INFO - Running setup.py (path:/tmp/pip-T8FXSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:09 INFO - Running setup.py (path:/tmp/pip-1EWDMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:09 INFO - Running setup.py (path:/tmp/pip-wKyqh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:09 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)) 14:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:09 INFO - Running setup.py (path:/tmp/pip-gHy9FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:10 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)) 14:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:10 INFO - Running setup.py (path:/tmp/pip-bG_Mce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:10 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)) 14:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:10 INFO - Running setup.py (path:/tmp/pip-I6HlY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:10 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)) 14:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:10 INFO - Running setup.py (path:/tmp/pip-PbuSzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:10 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)) 14:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:10 INFO - Running setup.py (path:/tmp/pip-P6p4li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:10 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)) 14:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:10 INFO - Running setup.py (path:/tmp/pip-8ZnMVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:10 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)) 14:21:10 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)) 14:21:10 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)) 14:21:10 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)) 14:21:10 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)) 14:21:10 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)) 14:21:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:10 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 14:21:10 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 14:21:10 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 14:21:10 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 14:21:10 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 14:21:10 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 14:21:12 INFO - Downloading blessings-1.5.1.tar.gz 14:21:12 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 14:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:21:12 INFO - Installing collected packages: blessings 14:21:12 INFO - Running setup.py install for blessings 14:21:12 INFO - Successfully installed blessings 14:21:12 INFO - Cleaning up... 14:21:12 INFO - Return code: 0 14:21:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:12 INFO - Reading from file tmpfile_stdout 14:21:12 INFO - Current package versions: 14:21:12 INFO - argparse == 1.2.1 14:21:12 INFO - blessings == 1.5.1 14:21:12 INFO - blobuploader == 1.2.4 14:21:12 INFO - docopt == 0.6.1 14:21:12 INFO - manifestparser == 1.1 14:21:12 INFO - mozInstall == 1.12 14:21:12 INFO - mozcrash == 0.16 14:21:12 INFO - mozdebug == 0.1 14:21:12 INFO - mozdevice == 0.47 14:21:12 INFO - mozfile == 1.2 14:21:12 INFO - mozhttpd == 0.7 14:21:12 INFO - mozinfo == 0.9 14:21:12 INFO - mozleak == 0.1 14:21:12 INFO - mozlog == 3.1 14:21:12 INFO - moznetwork == 0.27 14:21:12 INFO - mozprocess == 0.22 14:21:12 INFO - mozprofile == 0.27 14:21:12 INFO - mozrunner == 6.11 14:21:12 INFO - mozscreenshot == 0.1 14:21:12 INFO - mozsystemmonitor == 0.0 14:21:12 INFO - moztest == 0.7 14:21:12 INFO - mozversion == 1.4 14:21:12 INFO - psutil == 3.1.1 14:21:12 INFO - requests == 1.2.3 14:21:12 INFO - wsgiref == 0.1.2 14:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:12 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')]} 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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')]} 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:12 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 14:21:12 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 14:21:12 INFO - Using env: {'DISPLAY': ':0', 14:21:12 INFO - 'HOME': '/home/cltbld', 14:21:12 INFO - 'LANG': 'en_US.UTF-8', 14:21:12 INFO - 'LANGUAGE': 'en_US:en', 14:21:12 INFO - 'LOGNAME': 'cltbld', 14:21:12 INFO - 'MAIL': '/var/mail/cltbld', 14:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:12 INFO - 'MOZ_NO_REMOTE': '1', 14:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:12 INFO - 'NO_EM_RESTART': '1', 14:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:12 INFO - 'PWD': '/builds/slave/test', 14:21:12 INFO - 'SHELL': '/bin/bash', 14:21:12 INFO - 'SHLVL': '1', 14:21:12 INFO - 'TERM': 'linux', 14:21:12 INFO - 'TMOUT': '86400', 14:21:12 INFO - 'USER': 'cltbld', 14:21:12 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:12 INFO - '_': '/tools/buildbot/bin/python'} 14:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 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)) 14:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:12 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)) 14:21:12 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)) 14:21:12 INFO - Cleaning up... 14:21:12 INFO - Return code: 0 14:21:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21:12 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')]} 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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')]} 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:12 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:12 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 14:21:12 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 14:21:12 INFO - Using env: {'DISPLAY': ':0', 14:21:12 INFO - 'HOME': '/home/cltbld', 14:21:12 INFO - 'LANG': 'en_US.UTF-8', 14:21:12 INFO - 'LANGUAGE': 'en_US:en', 14:21:12 INFO - 'LOGNAME': 'cltbld', 14:21:12 INFO - 'MAIL': '/var/mail/cltbld', 14:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:12 INFO - 'MOZ_NO_REMOTE': '1', 14:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:12 INFO - 'NO_EM_RESTART': '1', 14:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:12 INFO - 'PWD': '/builds/slave/test', 14:21:12 INFO - 'SHELL': '/bin/bash', 14:21:12 INFO - 'SHLVL': '1', 14:21:12 INFO - 'TERM': 'linux', 14:21:12 INFO - 'TMOUT': '86400', 14:21:12 INFO - 'USER': 'cltbld', 14:21:12 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:12 INFO - '_': '/tools/buildbot/bin/python'} 14:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:12 INFO - Downloading/unpacking jsonschema 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:14 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 14:21:14 INFO - Downloading/unpacking functools32 (from jsonschema) 14:21:14 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 14:21:14 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 14:21:14 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 14:21:14 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 14:21:14 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 14:21:14 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 14:21:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:14 INFO - warning: no files found matching '*.txt' 14:21:14 INFO - no previously-included directories found matching 'build' 14:21:14 INFO - no previously-included directories found matching 'dist' 14:21:14 INFO - no previously-included directories found matching '.git*' 14:21:14 INFO - Installing collected packages: jsonschema, functools32 14:21:14 INFO - Running setup.py install for functools32 14:21:15 INFO - warning: no files found matching '*.txt' 14:21:15 INFO - no previously-included directories found matching 'build' 14:21:15 INFO - no previously-included directories found matching 'dist' 14:21:15 INFO - no previously-included directories found matching '.git*' 14:21:15 INFO - Successfully installed jsonschema functools32 14:21:15 INFO - Cleaning up... 14:21:15 INFO - Return code: 0 14:21:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:15 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 0x7f4fd6782f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, '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': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', '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 14:21:15 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 14:21:15 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 14:21:15 INFO - Using env: {'DISPLAY': ':0', 14:21:15 INFO - 'HOME': '/home/cltbld', 14:21:15 INFO - 'LANG': 'en_US.UTF-8', 14:21:15 INFO - 'LANGUAGE': 'en_US:en', 14:21:15 INFO - 'LOGNAME': 'cltbld', 14:21:15 INFO - 'MAIL': '/var/mail/cltbld', 14:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:15 INFO - 'MOZ_NO_REMOTE': '1', 14:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:15 INFO - 'NO_EM_RESTART': '1', 14:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:15 INFO - 'PWD': '/builds/slave/test', 14:21:15 INFO - 'SHELL': '/bin/bash', 14:21:15 INFO - 'SHLVL': '1', 14:21:15 INFO - 'TERM': 'linux', 14:21:15 INFO - 'TMOUT': '86400', 14:21:15 INFO - 'USER': 'cltbld', 14:21:15 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:15 INFO - '_': '/tools/buildbot/bin/python'} 14:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:15 INFO - Downloading/unpacking flake8 14:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:21:16 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 14:21:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:21:17 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 14:21:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:17 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 14:21:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:21:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:17 INFO - no previously-included directories found matching 'docs/_build' 14:21:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:21:17 INFO - Running setup.py install for pep8 14:21:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:17 INFO - no previously-included directories found matching 'docs/_build' 14:21:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:21:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:21:17 INFO - Cleaning up... 14:21:17 INFO - Return code: 0 14:21:17 INFO - Running post-action listener: _resource_record_post_action 14:21:17 INFO - Running post-action listener: _start_resource_monitoring 14:21:17 INFO - Starting resource monitoring. 14:21:17 INFO - ##### 14:21:17 INFO - ##### Running install step. 14:21:17 INFO - ##### 14:21:17 INFO - Running pre-action listener: _resource_record_pre_action 14:21:17 INFO - Running main action method: install 14:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:18 INFO - Reading from file tmpfile_stdout 14:21:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:18 INFO - Reading from file tmpfile_stdout 14:21:18 INFO - Output received: 14:21:18 INFO - Usage: mozinstall [options] installer 14:21:18 INFO - Options: 14:21:18 INFO - -h, --help show this help message and exit 14:21:18 INFO - -d DEST, --destination=DEST 14:21:18 INFO - Directory to install application into. [default: 14:21:18 INFO - "/builds/slave/test"] 14:21:18 INFO - --app=APP Application being installed. [default: firefox] 14:21:18 INFO - mkdir: /builds/slave/test/build/application 14:21:18 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'] 14:21:18 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 14:21:32 INFO - Reading from file tmpfile_stdout 14:21:32 INFO - Output received: 14:21:32 INFO - /builds/slave/test/build/application/firefox/firefox 14:21:32 INFO - Running post-action listener: _resource_record_post_action 14:21:32 INFO - ##### 14:21:32 INFO - ##### Running run-tests step. 14:21:32 INFO - ##### 14:21:32 INFO - Running pre-action listener: _resource_record_pre_action 14:21:32 INFO - Running main action method: run_tests 14:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:21:32 INFO - Python 2.7.3 14:21:32 INFO - Return code: 0 14:21:32 INFO - grabbing minidump binary from tooltool 14:21: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')]} 14:21:32 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 0x28540b0>, '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 0x2854fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2855440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:21:32 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 14:21:32 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 14:21:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:21:32 INFO - Return code: 0 14:21:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:21:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:21:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:21:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:21:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:21:33 INFO - Return code: 0 14:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 14:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 14:21:33 INFO - Using env: {'DISPLAY': ':0', 14:21:33 INFO - 'HOME': '/home/cltbld', 14:21:33 INFO - 'LANG': 'en_US.UTF-8', 14:21:33 INFO - 'LANGUAGE': 'en_US:en', 14:21:33 INFO - 'LOGNAME': 'cltbld', 14:21:33 INFO - 'MAIL': '/var/mail/cltbld', 14:21:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:21:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:33 INFO - 'MOZ_NO_REMOTE': '1', 14:21:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:33 INFO - 'NO_EM_RESTART': '1', 14:21:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:33 INFO - 'PWD': '/builds/slave/test', 14:21:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:21:33 INFO - 'SHELL': '/bin/bash', 14:21:33 INFO - 'SHLVL': '1', 14:21:33 INFO - 'TERM': 'linux', 14:21:33 INFO - 'TMOUT': '86400', 14:21:33 INFO - 'USER': 'cltbld', 14:21:33 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1449267640.289658-923552272', 14:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:33 INFO - '_': '/tools/buildbot/bin/python'} 14:21:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 14:21:33 INFO - mozversion INFO | application_buildid: 20151204094024 14:21:33 INFO - mozversion INFO | application_changeset: 18a0014d720691eb17a609352d29426ab2821f4f 14:21:33 INFO - mozversion INFO | application_display_name: Nightly 14:21:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:21:33 INFO - mozversion INFO | application_name: Firefox 14:21:33 INFO - mozversion INFO | application_remotingname: firefox 14:21:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/cedar 14:21:33 INFO - mozversion INFO | application_vendor: Mozilla 14:21:33 INFO - mozversion INFO | application_version: 45.0a1 14:21:33 INFO - mozversion INFO | platform_buildid: 20151204094024 14:21:33 INFO - mozversion INFO | platform_changeset: 18a0014d720691eb17a609352d29426ab2821f4f 14:21:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/cedar 14:21:33 INFO - mozversion INFO | platform_version: 45.0a1 14:21:33 INFO - 2015-12-04 14:21:33,869 DEBUG : using testdate: 1449267693 14:21:33 INFO - 2015-12-04 14:21:33,869 DEBUG : actual date: 1449267693 14:21:33 INFO - 2015-12-04 14:21:33,944 INFO : starting webserver on 'localhost:45671' 14:21:33 INFO - 2015-12-04 14:21:33,945 INFO : Starting test suite talos-linux64-ix-053 14:21:33 INFO - 2015-12-04 14:21:33,945 INFO : Starting test dromaeo_css 14:21:33 INFO - 2015-12-04 14:21:33,945 DEBUG : operating with platform_type : linux_ 14:21:33 INFO - 2015-12-04 14:21:33,946 INFO : Initialising browser for dromaeo_css test... 14:21:33 INFO - 2015-12-04 14:21:33,962 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZLTA2/profile http://localhost:45671/getInfo.html 14:21:38 INFO - 2015-12-04 14:21:38,365 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:21:38 INFO - 2015-12-04 14:21:38,365 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:21:38 INFO - 2015-12-04 14:21:38,365 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:21:38 INFO - 2015-12-04 14:21:38,365 DEBUG : BROWSER_OUTPUT: __metrics 14:21:38 INFO - 2015-12-04 14:21:38,466 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] 14:21:38 INFO - 2015-12-04 14:21:38,522 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:39 INFO - 2015-12-04 14:21:39,382 INFO : Browser initialized. 14:21:39 INFO - 2015-12-04 14:21:39,383 INFO : Running cycle 1/1 for dromaeo_css test... 14:21:39 INFO - 2015-12-04 14:21:39,383 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZLTA2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:21:51 INFO - 2015-12-04 14:21:51,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 142966784 14:21:51 INFO - 2015-12-04 14:21:51,320 DEBUG : BROWSER_OUTPUT: 14:22:42 INFO - 2015-12-04 14:22:42,155 DEBUG : BROWSER_OUTPUT: 1449267762152 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] 14:24:55 INFO - 2015-12-04 14:24:55,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45671/tests/dromaeo/cssquery-ext.html) 14:24:56 INFO - 2015-12-04 14:24:56,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 257744896 14:24:56 INFO - 2015-12-04 14:24:56,665 DEBUG : BROWSER_OUTPUT: 14:27:59 INFO - 2015-12-04 14:27:59,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-ext.html (next: http://localhost:45671/tests/dromaeo/cssquery-jquery.html) 14:27:59 INFO - 2015-12-04 14:27:59,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 217108480 14:27:59 INFO - 2015-12-04 14:27:59,800 DEBUG : BROWSER_OUTPUT: 14:31:01 INFO - 2015-12-04 14:31:01,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45671/tests/dromaeo/cssquery-mootools.html) 14:31:02 INFO - 2015-12-04 14:31:02,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 215425024 14:31:02 INFO - 2015-12-04 14:31:02,402 DEBUG : BROWSER_OUTPUT: 14:34:04 INFO - 2015-12-04 14:34:04,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45671/tests/dromaeo/cssquery-prototype.html) 14:34:04 INFO - 2015-12-04 14:34:04,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 199372800 14:34:04 INFO - 2015-12-04 14:34:04,897 DEBUG : BROWSER_OUTPUT: 14:37:07 INFO - 2015-12-04 14:37:07,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45671/tests/dromaeo/cssquery-yui.html) 14:37:08 INFO - 2015-12-04 14:37:08,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 207065088 14:37:08 INFO - 2015-12-04 14:37:08,250 DEBUG : BROWSER_OUTPUT: 14:40:10 INFO - 2015-12-04 14:40:10,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/dromaeo/cssquery-yui.html (next: http://localhost:45671/tests/dromaeo/cssquery-dojo.html) 14:40:11 INFO - 2015-12-04 14:40:11,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 212443136 14:40:11 INFO - 2015-12-04 14:40:11,031 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,032 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:40:11 INFO - 2015-12-04 14:40:11,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:40:11 INFO - 2015-12-04 14:40:11,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:40:11 INFO - 2015-12-04 14:40:11,032 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:40:11 INFO - 2015-12-04 14:40:11,034 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2649.4436168404636;2739.260399692082;2745.0117957535285;2757.200411880556;2769.8199617024898;4539.364488971547;4696.906061878761;4805.90388192236;4843.200871856139;4845.321654968303;4695.366125573055;4725;4783.808647654098;4789.976050119744;4870.342503761991;4338.067315527161;4362.236608593499;4377.2777491713905;4400.163968845909;4434.935615452285;4236.788160591974;4420.138073075752;4424.889377765549;4457.24226881431;4478.97760511197;4254.149170165979;4289.592488713567;4303.053328267776;4318.568143185687;4341.978290108561;4359.237133501624;4368.89077773055;4397.450318710161;4408.757518336491;4422.159789639958;4188.308929026707;4363.040131171138;4365.585269399434;4377.146456440995;4404.823807047715;4596.747178905159;4619.16854966106;4623.144718227139;4701.177293973541;4732.574068333832;5116.923246151311;5166.121759300928;5170.819021334235;5172.844814655567;5223.817166399196;4872.634552408584;5184.040952423814;5191.636585439021;5200.323957885488;5201.921971170435;4634.119517291704;4686.671932964728;4692.249240121599;4694.483606803249;4732.52674732524;5286;5315.495027972336;5316.76074576645;5320.388155362106;5322.201669749491;4735.479097299294;5080.695158290514;5088.618353623493;5096.923546146811;5139.049275883974;4974.801007959713;4993.90012199754;5049.394072711299;5115.283860259567;5134;5086.3896332440345;5128.538431541105;5134.178531435027;5135.306733590917;5191.870203244949;4861.781219845116;5083.212102124176;5101.387833460009;5107.821226257063;5110.66780659256;4114.732542384735;4168.937465938014;4234.047339348684;4234.280172370704;4256.4679415073115;3718.4236443351324;3724.2365315110337;3734.8506059757306;3740.8129593520216;3771.283456143324;4179.2477354076555;4416.80124394403;4429.889252768707;4430.734155950653;4453.910921781611;4919.655624106278;4973.8010479581135;5083.339165908408;5184.662996905189;5226.790928362899;4384.101259241847;4395.780210989502;4402.163588918095;4405.823767049346;4451.332300154938;4264;4525.977370113128;4535.070310586322;4546.136234115507;4578.793954271999;4760.928586071212;4791.784369703302;4801.375821143229;4904.8773780655765;4906.2640603909695;5154.201098829687;5160.045391602415;5166.844994650167;5169.121249387688;5171.663841850268;4900.068986892479;4902.656814022984;4918.2376731606655;4920.581750551243;4956.083124621957;4726.007538416971;4833.492483289345;4841.782119804688;4886.047220791911;5015.799368025238;5142.8971420572125;5150.098732721834;5152.27868098459;5154.639175257696;5174.068667639861;4977.253411988231;4978.153713868579;4993.176125939324;4993.226049962116;5024.698518088926;4728.739919304334;4817.78319975595;4845.394325709286;4857.1742803724155;4971.850844474671;4912.926306105483;4922.187839006667;4927.162382394929;4940.6788558745;4977.8257760978195;5049.84850454487;5051.545360917535;5059.291699162047;5090.720010399464;5100.515451032146;4642.651801114863;4717.056588682209;4765.785539650793;4852.175130227799;4979.178435558092 14:40:11 INFO - 2015-12-04 14:40:11,035 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.0961640514316;571.0862619808307;578.9710514474281;591.4588151841066;598.8023952095807;28097.438051238987;28807.71192288079;28920.710792892063;37202.62797372032;37935.620643793554;40792;41396.172076558454;41445.37831932523;41494.79252603733;41505.377419338736;7850.254225848549;8041.8793718094275;8042;8046.114927357986;8049.557274349909;7242.674079666402;7391.260873912593;10113.64602238918;10444.21668374875;10457.633982810603;10043;10151.390916544993;10157.238207134495;10160;10162.28863979518;7280.199178090459;7432.962835185789;10015.349002314862;10131.746706332364;10139.340942838766;10100.343477673927;10441.68674939753;10443.42561159136;10445.738856528647;10451.68644940653;37346.813265933495;38199.04502387435;38234.23531529354;38239.61760382416;38255;2670.8798104085363;2824.0257111296773;3126.437241296566;3228.677132286776;3331.3670402623425;27981.860090699418;28049.85975070132;28066.85966570154;28212.153635390972;28283.292917677016;3335.34960682667;3507.368673638744;3511.1924257420683;3515.1915059536195;3649.543807024122;212294;216695;217612;218035;218875;56950.14574781382;57415.71292143512;57469;57474.71262643744;57513.137302940486;54796.45203547993;56687;58130.709346453;58974;59262.40737592655;14522.419103235963;14598.34307456167;14697.338619762137;14705.338259778335;14717.411303547953;11262.887371126348;11314;11315.547378104948;11331.433428328715;11336;19422.611547768967;19790.70313945292;19794.70307945382;19800.20799168017;19806.108725107406;7606;7708.18651192322;7820.413468989848;7879.290863822283;8011.994002998501;816.6978218059356;875.9605817738217;941.7127776028377;958.4680502321139;973.0123924216925;26905.461890762075;27010.72989270082;27218.591721124198;27330.180094597195;27345.45309093807;900.7793090692822;946.3470205558281;951.2247518272586;952.8665986761858;1019.1897441533998;13647.795283070762;13831.30843457823;13840.515581954583;13973.720525589431;13979.720405591832;325519;333531;333572;334820;335760;46749.29876051794;47179.05641887143;47266.29100563494;47323.76338118287;47358.76320618375;1036.7770929250248;1130.4178348150708;1206.5053328135248;1231.7474917641862;1240.6526172671665;28025.71974280231;28349.716502834708;29142.417151656424;29148.125556233346;29149.7085029147;40607.796961015;41944.161116776886;41966.58033419627;41979.37030944477;42028.15943681171;161536;163182;167453;169172;237314;28497.145085647462;28510.714892851636;28515.572266415606;28564.857175713987;28957.85521072381;35631.28737425289;36620.26759464849;37043.62956370402;37408.251834963696;37473.250534988605;31001.689983100783;33660.66339336673;34944.65055349516;35290.82354588211;35627.46558801672;38140.618593813706;39220;39960.80019599883;40240.19519609533;40608.390874137505;38769.6123038766;39090.609093909836;39375.21249574935;39583.60416395799;40105.79947100246;31551.526727099572;32544;32612.51081233736;32726;33925.151871203416;24396;24616;24750.25749227526;24804.751952480245;24843.254702358958 14:40:11 INFO - 2015-12-04 14:40:11,039 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.36925787117684;331.62857599488575;331.75118661004257;331.76113198497075;334.8543383628122;12082.395880205999;12387.256764594109;14749.705005899876;15244;15461.226938653064;13989.650258743537;14327.570172894804;14402;14805.777913331309;14810.629734256649;4368.410264614268;4665.346851440801;4796.280557916306;4891.633127515451;4937.851864444055;4938.432080310774;4975.577075948549;4980.900381992358;4986.252062190682;4996.925046124311;4811.566958973692;4941.258811178334;4945.505449455061;4956.355673762424;4969.875753106165;4932.926006109911;4946.159152944008;4959.380077490314;4963.751812409401;4964.180910149839;4299.91400171998;4392.758398288093;4414.668899832525;4419.911601767979;4423.535528769465;10642.680719578348;10992.780144397067;18451.169697363515;18691.065446727745;18763.812361876342;1715.8884672496247;1774.201609275831;1805.4132406967656;1818.5180927054341;1846.6860633692304;8461.450005749606;8484;8565.100664430207;8599.4840309581;8611.138886111401;1637.1568642149302;1661.4268077513238;1670.6575152093912;1675;1704.3779020657494;54072.18891716628;55389;55994.16008759913;56309.43690563083;57344;9439.669611563562;9482.762930926781;9500.287478439006;9501.049895010581;9546.90453095474;10840.13278937683;11065.944670276758;11423.885761142448;12166.209196402382;12168.756624867454;5347.946520534822;5487.64330318528;6007.819765406957;7358.448116391292;7395.186529481753;7097.290270972965;7112.786616401516;7128.037714908524;7143.642817859086;7168.637958787814;4030.6775457963295;4092.570280120604;4098.159877225162;4118.855840045584;4121.175764847043;1700.7023770840053;1732.0819965418098;1757.3409971260778;1758.5076178669992;1758.753774471575;819.700809204636;844.5608283692568;859.8925134358205;868.9739307820776;935.3919952031234;15344.386224551115;15414.84585154134;15470.84529154694;15843.366265349257;15877.12675802842;841.4993079117914;855.7432770168924;870.277669534285;879.4020066354813;940.2337095267335;7162.4628152888745;8712.21590056898;8835.911640883638;8914.643414263357;8922.286217102615;461499;461545;471389;476492;479816;70467.2953270471;71000.47708026806;71585.43344634866;71918.28081719116;72664.63667681628;1045.8274384726435;1087.211771465681;1092.8961748633867;1097.506122244977;1107.0645304717661;13195.934020329836;13629.454821807414;13821.516246931309;13963.022588418713;14295;23839.64240536428;29371.41257174887;29761.404771904872;33102.5034624476;33354.4996825043;38923;39086.804565976985;39216;41161.38257926074;42238.788806055774;8017.118117007008;8649.178328059075;8768.649254029768;8783.692570759993;8845.071267516818;9444.905550944402;9452.621895124117;9547;9652.613895444103;9679.516024198903;9505.572249248662;12582.937085314881;12913.870861291267;12987.935060324638;13321.067525273138;12523.436445360163;12576.434060467118;12833.807492887427;13080.803787942998;13401.06192566511;12641.93679031599;12698.68253293638;12891.935540322238;13474.730505390033;13603.115797473529;11169.273997190157;12379.319137447526;12717.87282127204;13589.592312230649;13605.795913061114;8425.578721064045;8640;8748.47509149453;8761.03628600866;9095.408798428081 14:40:11 INFO - 2015-12-04 14:40:11,039 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1422.1253928833758;1641.8440248176423;1702.4296860551715;1707.137895362842;1736.3054778088772;5759.913601295984;7171.641417929102;7376.631168441583;7385.076865391826;7402.074740657418;7189.89215161773;7312.926870731304;7347.853042939151;7350.669219885104;7355;2044.0903797810017;2071.1818831561523;2075.1284460526617;2075.7960382977913;2077.3767869639123;2066.8863212523306;2069.492974221318;2080.2927004818357;2120.7561130469962;2124.02294944325;2058.7014882841977;2060.7424071991;2070.6169358668617;2078.76094249161;2079.6152711748373;2048.7336646235967;2077.1483691686335;2077.210659949225;2077.854550181488;2080.1887263967064;2024.0588126521238;2041.3773798991301;2070.1926248762993;2072.336852207294;2074.7406574178226;7209.315115064061;7284.74503392384;7285.089363829521;7288.08898887639;7288.708451661927;4192.098698779777;4270.743755374688;4276.486821581399;4310.159518893817;4311.223979683656;2606.8696565171667;2620.9213723588323;2629.447815958651;2690.4350086481863;2730.57676060211;801.7153910361795;801.9094032116317;808.6805711743829;827.8427098851259;860.3074525007366;9995.450250236234;10014.198864090855;10020.34867733595;10025.097741203326;10030.398176109384;3915.060385507458;3922.156736301709;3969.8412063517712;3979.343408337592;4009.7794621296107;8493.641017437303;8524.31805455562;8561.22948934599;8566.357523185787;8580.699675511327;4344.630706389992;4347.847825326098;4360.65114790816;4368.388425620416;4370.8033138508845;3098.209956461088;3172.1118086935694;3804.2771873343977;3952.802359882052;3959.762414255154;3381.847816848248;3444.2767018925806;3445.5693038370205;3456.792592444461;3493.039414161126;1110.7001109700336;1125.5722825326325;1126.6845283320683;1129.9152563557766;1134.2570616246371;876.7369789063256;887.924526415249;895.3553441522093;896.3008853094597;993.0218734546465;6804.795856124324;6909.239983601799;6909.30906909305;6913.585184888822;6917.757878474229;939.5155654066558;949.1599934058409;985.2413641496008;1019.6482213636284;1083.6369816111692;5389.056915039852;5432.320959880015;5494.313210848644;5496.285482887199;5497.092979658311;8650.264727498106;8757.605907734167;8761.956190219136;8778.209961103532;8846.911530884738;8514.70198543048;8552.059273479912;8647.654093836176;8715.825683486295;8786.648534058693;6807.523473356917;6859.485538584626;6867.244603093655;6913.930860691429;6915.239323674392;6765.932340676531;6900.102986611709;6903.275156108737;6924.619145947021;6930.965345173242;7658.081030276402;7892.289693927574;7946.523208607502;8008.15914328987;8021.959890200745;8035.035795704553;8035.236652518001;8171.877421838558;8302.294304983903;8306.460080094774;5238.345206849144;5448.182772584144;6037.396260374103;6245.96877015612;6358.332375100548;6957.756478523227;6960.547564408297;6978.511504194861;6992.0910281663055;7004.0544526488275;6467.838304042437;6488.188976377953;6545.2800191979795;6630.90053649186;6744.763933262312;6361.109444677842;6432.131662225727;6471.967640161769;6522.34776522363;6588.209414870246;6015.428534289235;6044.7279872406725;6046.7581296749395;6052.364501727256;6065.969670151621;5726.4273572642405;5731.799387021601;5761.884762304814;5879.941200587939;5928.170056192223;5948.553858460719;5976.8804623908145;5985.281766187911;5985.461308482258;5988.311344195473 14:40:11 INFO - 2015-12-04 14:40:11,040 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.198608113026;274.72390247800956;278.60020870051466;278.76444404478207;280.0492328544591;5261.526462618363;5352.330958630171;5359.490848369408;5373.7581808818595;5396.541293990011;5216.426193118754;5363.222332761748;5366.034113859504;5374.516293533581;5375.865603359918;4088.468499095128;4091.488563929509;4094.303968325392;4096.610821971908;4097.323941549641;3887;3994.26106170358;3997.7201595888155;4084.1627466369323;4092.7339722918064;4034.495688038995;4034.7175697701173;4034.9798251008706;4050.2709512287774;4059.8376064957515;4066.593340665939;4067.2068946555432;4072.470578824749;4073.1853629274265;4080.1839632073556;3532.6467353264725;3532.964670353315;3533.94699079514;3534.6818786309354;3540.4689296605457;5056.671316364462;5159.122949098624;5170.663906846043;5171.095058364809;5177.58579313654;4659.091477161955;4681.431720373679;4681.789319480631;4681.836135735233;4684.461286951976;5603.691796951166;5603.8879222415735;5604.047311956977;5612.522935550483;5615.382307946123;3619.7647152934974;3736.6263373662687;3765.585785563586;3835.290471262825;3841.3661745811905;5904.793332233394;5919.348871624118;5924.170616113704;5937.703114844284;5939.346671866135;3927.7643341399607;3927.9410808837893;3928.3125453046173;3932.0563064864227;3935.330993731073;3979.2638361902564;3988.4216788566077;3988.9401658974557;3993.2612466693754;3998.820053097618;4527.9547204527535;4613.653975951817;4614.169449499055;4619.722816631013;4623.838165664186;5617.073182924772;5619.438056194348;5631.324241091095;5636.830895073154;5639.238702775155;1395.2605119286795;1410.0693542262059;1411.2167746900568;1413.0885578801615;1413.1662319231702;941.5809964565702;948.6821914658528;949.4113649537193;967.2213867836459;968.8837339519303;4951.158303088484;4958.876028099255;4966.279889416014;4969.229769385751;4969.229769385751;5847.590668653153;5852.531797456193;5853.2976042875125;5865;5867.413258674183;4953.331300274417;4955.98402327522;4957.529034741694;4958.8760280993265;4959.2809042688605;3070.078976307099;3128.780985331005;3148.5592017117624;3161.873525059018;3164.161497203243;5608.298962629671;5611.579131565149;5651.350094739076;5652.717364131777;5653.406392328829;6099.146119543268;6103.84740381494;6107.870044041866;6108.694565271808;6112.847178820565;5617.354004289477;5634.633748806396;5639.351474580394;5641.323041235078;5642.915356269577;5718.914216286842;5914.497267732291;5926.555508336978;5942.73257703413;5945;5534.889302213853;5698.088305871041;5790.247267855152;5791.53667706574;5805.477507024388;5498.80754173602;5607.186957891001;5613.859653508532;5625.718714064362;5642.125470552071;3872.690184785267;3908.511436070491;3920.137569734654;3924.7252692311263;3925.156091440354;5901.734421950937;5907.409259074058;5910.261217347832;5913.497352725067;5914.319853216935;5521.944780552143;5684.317881854204;5685.374608793112;5688.744006519633;5693.8861222774485;5693.373728889902;5694;5699.344575373885;5701.458361455655;5704.543636509153;5542.2795036644975;5576.832695019156;5579.637323573955;5580.441955804387;5584.525315348241;5611.214429979887;5721.799737009184;5745.683987380734;5752.338481074563;5755.942440575708;5554.555635549227;5555.138953462219;5555.30558680165;5556.499915007668;5560.527355174693 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: |5;yui.html;662.5858838226109;701.2286484866647;707.6709330161474;716.8673795347861;721.0842230367433;11519.596814111508;11707;11711.707207319821;11765.588204412847;11767.470463829126;11516.366599837005;11691;11718.941405292982;11728.413579321043;11735.589254376098;626.0952923026229;631.7378288010493;794.7258195922412;809.5668817182808;813.3980854167933;801.8115742800467;810.5177419435427;813.975580732576;815.8449894520052;817.2767101115496;831.0401486283353;839.8236370362231;839.8278352937664;840.0759164918571;840.504102579478;651.7165033210545;660.1451120798578;830.1822704635929;841.4278290762279;842;624.6564389585756;624.6658037949675;629.8173529676434;629.8425393651587;630.3381449478076;11467.31196128235;11704.063674905987;11739.471723772365;11768.235064720766;11782.293062416282;10934.781304373948;11539.711507212387;11627.12796540263;11691.415429228504;11774.941125294405;9351.906480935171;9395.812083758356;9487.383320084173;9498.335116541844;9502.287328450393;3190.3140824722564;3191.69678880506;3210.502372132323;3254.7558933079877;3259.5925509311337;39063.21873562513;39380;39646;39894.401583976556;40204.19591608181;8936.553172341357;9215.128664995467;9273.860892086625;9398.389104708309;9404.94918470794;15058.774118388234;15113.697726045417;15127.924360378127;15134.016288941184;15156.545303640909;6057;6282.528810339243;6442.967785161138;6543.672816359163;6721.865562688817;3559.964400356015;3662.597114317423;3686.9078273043388;3773.4905787718853;3801.752886062397;2696.501147287758;2736.480068786924;2736.808423410342;2741.7669498092487;2742.191053639181;471.2530638937254;476.9904601908012;484.1841497077436;484.29776823605914;486.39443892354245;454.5976810522711;485.12435054725853;495.74221404869985;503.97732102055494;558.4722437296797;7187.460940429489;7331.413486921034;7371.189169191384;7383.335499805044;7617.695292188361;583.3437382944188;591.6923199936009;594.1562980567518;605.3825098399608;616.140484024783;3515.6660117288816;3554.573451185874;3620.87326943561;3675.5956844747056;3706.388445906395;47409.762951185716;47599.04801904012;47741.5225847744;51114.74442627763;51616;40471.59528404737;40508.39237411441;40647.1870562593;40737.79631101825;41862.79068604698;40279.39580906289;40356;41123.1775364497;41164;41431.171376572296;7243.167035790952;7648.923510765044;7675.616219188906;7773.261540153676;8274.875876861972;31374.215644608154;31791.88728394495;32546.67453325531;32778.344433111684;33114.50328245127;40348.59651403566;40617;40645;40739.1852162961;40881.59118408778;10039.749006274902;10308.948455257676;10375.377477351383;10439.425831579032;10507.842382364424;11629.476673549541;11816.881831181578;11915.702107447383;12026.75946481083;12199.451024703732;10035.598576056876;10047.045530674573;10130.392176469435;10259.281850270409;10484.056434920894;10656.89343106559;10761.461926903467;10851.511681974487;11180.720481988015;11631.47658355359;8406.52091971367;10104.595816167564;10307.484625768531;10353.844692329772;10405.583776649151;8415.064535157071;8552.102029286836;8720.302375809793;8799.384043117176;9132.132447417485;7856.25365590268;8208.753737387888;8322.375821813268;8445.535495547803;8447.197516235949 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268811031__endTimestamp 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,044 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4701.81 Median:4833.49 stddev:503.61 (10.4%) stddev-sans-first:478.73 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: Values: 2649.4 2739.3 2745.0 2757.2 2769.8 4539.4 4696.9 4805.9 4843.2 4845.3 4695.4 4725.0 4783.8 4790.0 4870.3 4338.1 4362.2 4377.3 4400.2 4434.9 4236.8 4420.1 4424.9 4457.2 4479.0 4254.1 4289.6 4303.1 4318.6 4342.0 4359.2 4368.9 4397.5 4408.8 4422.2 4188.3 4363.0 4365.6 4377.1 4404.8 4596.7 4619.2 4623.1 4701.2 4732.6 5116.9 5166.1 5170.8 5172.8 5223.8 4872.6 5184.0 5191.6 5200.3 5201.9 4634.1 4686.7 4692.2 4694.5 4732.5 5286.0 5315.5 5316.8 5320.4 5322.2 4735.5 5080.7 5088.6 5096.9 5139.0 4974.8 4993.9 5049.4 5115.3 5134.0 5086.4 5128.5 5134.2 5135.3 5191.9 4861.8 5083.2 5101.4 5107.8 5110.7 4114.7 4168.9 4234.0 4234.3 4256.5 3718.4 3724.2 3734.9 3740.8 3771.3 4179.2 4416.8 4429.9 4430.7 4453.9 4919.7 4973.8 5083.3 5184.7 5226.8 4384.1 4395.8 4402.2 4405.8 4451.3 4264.0 4526.0 4535.1 4546.1 4578.8 4760.9 4791.8 4801.4 4904.9 4906.3 5154.2 5160.0 5166.8 5169.1 5171.7 4900.1 4902.7 4918.2 4920.6 4956.1 4726.0 4833.5 4841.8 4886.0 5015.8 5142.9 5150.1 5152.3 5154.6 5174.1 4977.3 4978.2 4993.2 4993.2 5024.7 4728.7 4817.8 4845.4 4857.2 4971.9 4912.9 4922.2 4927.2 4940.7 4977.8 5049.8 5051.5 5059.3 5090.7 5100.5 4642.7 4717.1 4765.8 4852.2 4979.2 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41349.31 Median:3333.36 stddev:66001.55 (1980.0%) stddev-sans-first:66115.61 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: Values: 552.1 571.1 579.0 591.5 598.8 28097.4 28807.7 28920.7 37202.6 37935.6 40792.0 41396.2 41445.4 41494.8 41505.4 7850.3 8041.9 8042.0 8046.1 8049.6 7242.7 7391.3 10113.6 10444.2 10457.6 10043.0 10151.4 10157.2 10160.0 10162.3 7280.2 7433.0 10015.3 10131.7 10139.3 10100.3 10441.7 10443.4 10445.7 10451.7 37346.8 38199.0 38234.2 38239.6 38255.0 2670.9 2824.0 3126.4 3228.7 3331.4 27981.9 28049.9 28066.9 28212.2 28283.3 3335.3 3507.4 3511.2 3515.2 3649.5 212294.0 216695.0 217612.0 218035.0 218875.0 56950.1 57415.7 57469.0 57474.7 57513.1 54796.5 56687.0 58130.7 58974.0 59262.4 14522.4 14598.3 14697.3 14705.3 14717.4 11262.9 11314.0 11315.5 11331.4 11336.0 19422.6 19790.7 19794.7 19800.2 19806.1 7606.0 7708.2 7820.4 7879.3 8012.0 816.7 876.0 941.7 958.5 973.0 26905.5 27010.7 27218.6 27330.2 27345.5 900.8 946.3 951.2 952.9 1019.2 13647.8 13831.3 13840.5 13973.7 13979.7 325519.0 333531.0 333572.0 334820.0 335760.0 46749.3 47179.1 47266.3 47323.8 47358.8 1036.8 1130.4 1206.5 1231.7 1240.7 28025.7 28349.7 29142.4 29148.1 29149.7 40607.8 41944.2 41966.6 41979.4 42028.2 161536.0 163182.0 167453.0 169172.0 237314.0 28497.1 28510.7 28515.6 28564.9 28957.9 35631.3 36620.3 37043.6 37408.3 37473.3 31001.7 33660.7 34944.7 35290.8 35627.5 38140.6 39220.0 39960.8 40240.2 40608.4 38769.6 39090.6 39375.2 39583.6 40105.8 31551.5 32544.0 32612.5 32726.0 33925.2 24396.0 24616.0 24750.3 24804.8 24843.3 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25183.46 Median:4380.58 stddev:76882.09 (1755.1%) stddev-sans-first:77075.12 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: Values: 329.4 331.6 331.8 331.8 334.9 12082.4 12387.3 14749.7 15244.0 15461.2 13989.7 14327.6 14402.0 14805.8 14810.6 4368.4 4665.3 4796.3 4891.6 4937.9 4938.4 4975.6 4980.9 4986.3 4996.9 4811.6 4941.3 4945.5 4956.4 4969.9 4932.9 4946.2 4959.4 4963.8 4964.2 4299.9 4392.8 4414.7 4419.9 4423.5 10642.7 10992.8 18451.2 18691.1 18763.8 1715.9 1774.2 1805.4 1818.5 1846.7 8461.5 8484.0 8565.1 8599.5 8611.1 1637.2 1661.4 1670.7 1675.0 1704.4 54072.2 55389.0 55994.2 56309.4 57344.0 9439.7 9482.8 9500.3 9501.0 9546.9 10840.1 11065.9 11423.9 12166.2 12168.8 5347.9 5487.6 6007.8 7358.4 7395.2 7097.3 7112.8 7128.0 7143.6 7168.6 4030.7 4092.6 4098.2 4118.9 4121.2 1700.7 1732.1 1757.3 1758.5 1758.8 819.7 844.6 859.9 869.0 935.4 15344.4 15414.8 15470.8 15843.4 15877.1 841.5 855.7 870.3 879.4 940.2 7162.5 8712.2 8835.9 8914.6 8922.3 461499.0 461545.0 471389.0 476492.0 479816.0 70467.3 71000.5 71585.4 71918.3 72664.6 1045.8 1087.2 1092.9 1097.5 1107.1 13195.9 13629.5 13821.5 13963.0 14295.0 23839.6 29371.4 29761.4 33102.5 33354.5 38923.0 39086.8 39216.0 41161.4 42238.8 8017.1 8649.2 8768.6 8783.7 8845.1 9444.9 9452.6 9547.0 9652.6 9679.5 9505.6 12582.9 12913.9 12987.9 13321.1 12523.4 12576.4 12833.8 13080.8 13401.1 12641.9 12698.7 12891.9 13474.7 13603.1 11169.3 12379.3 12717.9 13589.6 13605.8 8425.6 8640.0 8748.5 8761.0 9095.4 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5044.84 Median:6041.06 stddev:2659.28 (44.0%) stddev-sans-first:2652.80 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: Values: 1422.1 1641.8 1702.4 1707.1 1736.3 5759.9 7171.6 7376.6 7385.1 7402.1 7189.9 7312.9 7347.9 7350.7 7355.0 2044.1 2071.2 2075.1 2075.8 2077.4 2066.9 2069.5 2080.3 2120.8 2124.0 2058.7 2060.7 2070.6 2078.8 2079.6 2048.7 2077.1 2077.2 2077.9 2080.2 2024.1 2041.4 2070.2 2072.3 2074.7 7209.3 7284.7 7285.1 7288.1 7288.7 4192.1 4270.7 4276.5 4310.2 4311.2 2606.9 2620.9 2629.4 2690.4 2730.6 801.7 801.9 808.7 827.8 860.3 9995.5 10014.2 10020.3 10025.1 10030.4 3915.1 3922.2 3969.8 3979.3 4009.8 8493.6 8524.3 8561.2 8566.4 8580.7 4344.6 4347.8 4360.7 4368.4 4370.8 3098.2 3172.1 3804.3 3952.8 3959.8 3381.8 3444.3 3445.6 3456.8 3493.0 1110.7 1125.6 1126.7 1129.9 1134.3 876.7 887.9 895.4 896.3 993.0 6804.8 6909.2 6909.3 6913.6 6917.8 939.5 949.2 985.2 1019.6 1083.6 5389.1 5432.3 5494.3 5496.3 5497.1 8650.3 8757.6 8762.0 8778.2 8846.9 8514.7 8552.1 8647.7 8715.8 8786.6 6807.5 6859.5 6867.2 6913.9 6915.2 6765.9 6900.1 6903.3 6924.6 6931.0 7658.1 7892.3 7946.5 8008.2 8022.0 8035.0 8035.2 8171.9 8302.3 8306.5 5238.3 5448.2 6037.4 6246.0 6358.3 6957.8 6960.5 6978.5 6992.1 7004.1 6467.8 6488.2 6545.3 6630.9 6744.8 6361.1 6432.1 6472.0 6522.3 6588.2 6015.4 6044.7 6046.8 6052.4 6066.0 5726.4 5731.8 5761.9 5879.9 5928.2 5948.6 5976.9 5985.3 5985.5 5988.3 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,045 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4663.02 Median:5369.90 stddev:1409.34 (26.2%) stddev-sans-first:1374.21 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: Values: 271.2 274.7 278.6 278.8 280.0 5261.5 5352.3 5359.5 5373.8 5396.5 5216.4 5363.2 5366.0 5374.5 5375.9 4088.5 4091.5 4094.3 4096.6 4097.3 3887.0 3994.3 3997.7 4084.2 4092.7 4034.5 4034.7 4035.0 4050.3 4059.8 4066.6 4067.2 4072.5 4073.2 4080.2 3532.6 3533.0 3533.9 3534.7 3540.5 5056.7 5159.1 5170.7 5171.1 5177.6 4659.1 4681.4 4681.8 4681.8 4684.5 5603.7 5603.9 5604.0 5612.5 5615.4 3619.8 3736.6 3765.6 3835.3 3841.4 5904.8 5919.3 5924.2 5937.7 5939.3 3927.8 3927.9 3928.3 3932.1 3935.3 3979.3 3988.4 3988.9 3993.3 3998.8 4528.0 4613.7 4614.2 4619.7 4623.8 5617.1 5619.4 5631.3 5636.8 5639.2 1395.3 1410.1 1411.2 1413.1 1413.2 941.6 948.7 949.4 967.2 968.9 4951.2 4958.9 4966.3 4969.2 4969.2 5847.6 5852.5 5853.3 5865.0 5867.4 4953.3 4956.0 4957.5 4958.9 4959.3 3070.1 3128.8 3148.6 3161.9 3164.2 5608.3 5611.6 5651.4 5652.7 5653.4 6099.1 6103.8 6107.9 6108.7 6112.8 5617.4 5634.6 5639.4 5641.3 5642.9 5718.9 5914.5 5926.6 5942.7 5945.0 5534.9 5698.1 5790.2 5791.5 5805.5 5498.8 5607.2 5613.9 5625.7 5642.1 3872.7 3908.5 3920.1 3924.7 3925.2 5901.7 5907.4 5910.3 5913.5 5914.3 5521.9 5684.3 5685.4 5688.7 5693.9 5693.4 5694.0 5699.3 5701.5 5704.5 5542.3 5576.8 5579.6 5580.4 5584.5 5611.2 5721.8 5745.7 5752.3 5755.9 5554.6 5555.1 5555.3 5556.5 5560.5 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12083.19 Median:41143.59 stddev:13611.84 (33.1%) stddev-sans-first:13623.00 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: Values: 662.6 701.2 707.7 716.9 721.1 11519.6 11707.0 11711.7 11765.6 11767.5 11516.4 11691.0 11718.9 11728.4 11735.6 626.1 631.7 794.7 809.6 813.4 801.8 810.5 814.0 815.8 817.3 831.0 839.8 839.8 840.1 840.5 651.7 660.1 830.2 841.4 842.0 624.7 624.7 629.8 629.8 630.3 11467.3 11704.1 11739.5 11768.2 11782.3 10934.8 11539.7 11627.1 11691.4 11774.9 9351.9 9395.8 9487.4 9498.3 9502.3 3190.3 3191.7 3210.5 3254.8 3259.6 39063.2 39380.0 39646.0 39894.4 40204.2 8936.6 9215.1 9273.9 9398.4 9404.9 15058.8 15113.7 15127.9 15134.0 15156.5 6057.0 6282.5 6443.0 6543.7 6721.9 3560.0 3662.6 3686.9 3773.5 3801.8 2696.5 2736.5 2736.8 2741.8 2742.2 471.3 477.0 484.2 484.3 486.4 454.6 485.1 495.7 504.0 558.5 7187.5 7331.4 7371.2 7383.3 7617.7 583.3 591.7 594.2 605.4 616.1 3515.7 3554.6 3620.9 3675.6 3706.4 47409.8 47599.0 47741.5 51114.7 51616.0 40471.6 40508.4 40647.2 40737.8 41862.8 40279.4 40356.0 41123.2 41164.0 41431.2 7243.2 7648.9 7675.6 7773.3 8274.9 31374.2 31791.9 32546.7 32778.3 33114.5 40348.6 40617.0 40645.0 40739.2 40881.6 10039.7 10308.9 10375.4 10439.4 10507.8 11629.5 11816.9 11915.7 12026.8 12199.5 10035.6 10047.0 10130.4 10259.3 10484.1 10656.9 10761.5 10851.5 11180.7 11631.5 8406.5 10104.6 10307.5 10353.8 10405.6 8415.1 8552.1 8720.3 8799.4 9132.1 7856.3 8208.8 8322.4 8445.5 8447.2 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:40:11 INFO - 2015-12-04 14:40:11,047 DEBUG : BROWSER_OUTPUT: 14:40:11 INFO - 2015-12-04 14:40:11,802 INFO : Browser exited with error code: 0 14:40:11 INFO - 2015-12-04 14:40:11,818 INFO : Completed test dromaeo_css (00:18:37) 14:40:11 INFO - 2015-12-04 14:40:11,818 INFO : Starting test kraken 14:40:11 INFO - 2015-12-04 14:40:11,818 DEBUG : operating with platform_type : linux_ 14:40:11 INFO - 2015-12-04 14:40:11,819 INFO : Initialising browser for kraken test... 14:40:11 INFO - 2015-12-04 14:40:11,825 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQdSdt/profile http://localhost:45671/getInfo.html 14:40:15 INFO - 2015-12-04 14:40:15,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:40:15 INFO - 2015-12-04 14:40:15,831 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:40:15 INFO - 2015-12-04 14:40:15,831 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:40:15 INFO - 2015-12-04 14:40:15,831 DEBUG : BROWSER_OUTPUT: __metrics 14:40:15 INFO - 2015-12-04 14:40:15,915 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] 14:40:15 INFO - 2015-12-04 14:40:15,991 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:16 INFO - 2015-12-04 14:40:16,274 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:40:16 INFO - 2015-12-04 14:40:16,893 INFO : Browser initialized. 14:40:16 INFO - 2015-12-04 14:40:16,893 INFO : Running cycle 1/1 for kraken test... 14:40:16 INFO - 2015-12-04 14:40:16,894 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGQdSdt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:40:28 INFO - 2015-12-04 14:40:28,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 140390400 14:40:28 INFO - 2015-12-04 14:40:28,940 DEBUG : BROWSER_OUTPUT: 14:40:31 INFO - 2015-12-04 14:40:31,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45671/tests/kraken/driver.html?testName=audio-beat-detection) 14:40:32 INFO - 2015-12-04 14:40:32,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 176656384 14:40:32 INFO - 2015-12-04 14:40:32,160 DEBUG : BROWSER_OUTPUT: 14:40:34 INFO - 2015-12-04 14:40:34,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45671/tests/kraken/driver.html?testName=audio-dft) 14:40:35 INFO - 2015-12-04 14:40:35,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 165638144 14:40:35 INFO - 2015-12-04 14:40:35,481 DEBUG : BROWSER_OUTPUT: 14:40:38 INFO - 2015-12-04 14:40:38,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45671/tests/kraken/driver.html?testName=audio-fft) 14:40:39 INFO - 2015-12-04 14:40:39,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 151875584 14:40:39 INFO - 2015-12-04 14:40:39,045 DEBUG : BROWSER_OUTPUT: 14:40:41 INFO - 2015-12-04 14:40:41,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45671/tests/kraken/driver.html?testName=audio-oscillator) 14:40:41 INFO - 2015-12-04 14:40:41,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 154288128 14:40:41 INFO - 2015-12-04 14:40:41,680 DEBUG : BROWSER_OUTPUT: 14:40:43 INFO - 2015-12-04 14:40:43,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45671/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:40:44 INFO - 2015-12-04 14:40:44,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 154923008 14:40:44 INFO - 2015-12-04 14:40:44,483 DEBUG : BROWSER_OUTPUT: 14:40:47 INFO - 2015-12-04 14:40:47,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45671/tests/kraken/driver.html?testName=imaging-darkroom) 14:40:48 INFO - 2015-12-04 14:40:48,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 155209728 14:40:48 INFO - 2015-12-04 14:40:48,076 DEBUG : BROWSER_OUTPUT: 14:40:51 INFO - 2015-12-04 14:40:51,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45671/tests/kraken/driver.html?testName=imaging-desaturate) 14:40:52 INFO - 2015-12-04 14:40:52,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 156708864 14:40:52 INFO - 2015-12-04 14:40:52,048 DEBUG : BROWSER_OUTPUT: 14:40:54 INFO - 2015-12-04 14:40:54,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45671/tests/kraken/driver.html?testName=json-parse-financial) 14:40:55 INFO - 2015-12-04 14:40:55,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 14:40:55 INFO - 2015-12-04 14:40:55,439 DEBUG : BROWSER_OUTPUT: 14:40:57 INFO - 2015-12-04 14:40:57,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45671/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:40:57 INFO - 2015-12-04 14:40:57,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 163020800 14:40:57 INFO - 2015-12-04 14:40:57,753 DEBUG : BROWSER_OUTPUT: 14:40:59 INFO - 2015-12-04 14:40:59,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:00 INFO - 2015-12-04 14:41:00,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 163667968 14:41:00 INFO - 2015-12-04 14:41:00,236 DEBUG : BROWSER_OUTPUT: 14:41:02 INFO - 2015-12-04 14:41:02,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:02 INFO - 2015-12-04 14:41:02,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 178929664 14:41:02 INFO - 2015-12-04 14:41:02,927 DEBUG : BROWSER_OUTPUT: 14:41:05 INFO - 2015-12-04 14:41:05,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:06 INFO - 2015-12-04 14:41:06,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 182681600 14:41:06 INFO - 2015-12-04 14:41:06,001 DEBUG : BROWSER_OUTPUT: 14:41:08 INFO - 2015-12-04 14:41:08,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:09 INFO - 2015-12-04 14:41:09,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 180551680 14:41:09 INFO - 2015-12-04 14:41:09,167 DEBUG : BROWSER_OUTPUT: 14:41:10 INFO - 2015-12-04 14:41:10,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45671/tests/kraken/driver.html?testName=ai-astar) 14:41:11 INFO - 2015-12-04 14:41:11,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 239304704 14:41:11 INFO - 2015-12-04 14:41:11,178 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,182 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:41:11 INFO - 2015-12-04 14:41:11,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:41:11 INFO - 2015-12-04 14:41:11,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:41:11 INFO - 2015-12-04 14:41:11,182 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:41:11 INFO - 2015-12-04 14:41:11,182 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;104;109;111;110;100;109;110;116 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;150;160;131;155;155;131;170;135 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;161;160;162;161;161;160;161 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;76;84;90;73;78;72;103;94;73 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;129;94;93;93;130;94;94;129 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;111;110 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;149;147;148;147;148;146;147 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;95;95;96;95;95 14:41:11 INFO - 2015-12-04 14:41:11,183 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;70;70;70;71;70;78;67;68 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;69;69;69;69;68;68 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;84;92;85;83;84;83;87;83 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;122;119;117;124;121;122;121;125;127 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;149;150;143;137;143;157;142;150;133 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;67;69;68;68;70;68;67 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:41:11 INFO - 2015-12-04 14:41:11,184 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:41:11 INFO - 2015-12-04 14:41:11,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 14:41:11 INFO - 2015-12-04 14:41:11,185 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:41:11 INFO - 2015-12-04 14:41:11,185 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268871180__endTimestamp 14:41:11 INFO - 2015-12-04 14:41:11,185 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,188 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:41:11 INFO - 2015-12-04 14:41:11,188 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:41:11 INFO - 2015-12-04 14:41:11,188 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,188 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:4.29 (3.9%) stddev-sans-first:4.54 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 104.0 109.0 111.0 110.0 100.0 109.0 110.0 116.0 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:155.00 stddev:14.39 (9.3%) stddev-sans-first:14.77 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 150.0 160.0 131.0 155.0 155.0 131.0 170.0 135.0 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 161.0 160.0 162.0 161.0 161.0 160.0 161.0 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:77.00 stddev:10.88 (14.1%) stddev-sans-first:10.98 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 72.0 76.0 84.0 90.0 73.0 78.0 72.0 103.0 94.0 73.0 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:93.00 stddev:17.35 (18.7%) stddev-sans-first:17.92 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 129.0 94.0 93.0 93.0 130.0 94.0 94.0 129.0 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 14:41:11 INFO - 2015-12-04 14:41:11,189 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 111.0 110.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 149.0 147.0 148.0 147.0 148.0 146.0 147.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.40 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.09 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 70.0 71.0 70.0 78.0 67.0 68.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 68.0 68.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:2.90 (3.4%) stddev-sans-first:2.89 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 84.0 92.0 85.0 83.0 84.0 83.0 87.0 83.0 14:41:11 INFO - 2015-12-04 14:41:11,190 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:2.94 (2.4%) stddev-sans-first:3.04 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: Values: 120.0 122.0 119.0 117.0 124.0 121.0 122.0 121.0 125.0 127.0 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:146.00 stddev:8.06 (5.5%) stddev-sans-first:7.37 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: Values: 132.0 149.0 150.0 143.0 137.0 143.0 157.0 142.0 150.0 133.0 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 14:41:11 INFO - 2015-12-04 14:41:11,191 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 67.0 69.0 68.0 68.0 70.0 68.0 67.0 14:41:11 INFO - 2015-12-04 14:41:11,192 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:41:11 INFO - 2015-12-04 14:41:11,192 DEBUG : BROWSER_OUTPUT: 14:41:12 INFO - 2015-12-04 14:41:12,066 INFO : Browser exited with error code: 0 14:41:12 INFO - 2015-12-04 14:41:12,114 INFO : Completed test kraken (00:01:00) 14:41:12 INFO - 2015-12-04 14:41:12,114 INFO : Starting test v8_7 14:41:12 INFO - 2015-12-04 14:41:12,114 DEBUG : operating with platform_type : linux_ 14:41:12 INFO - 2015-12-04 14:41:12,114 INFO : Initialising browser for v8_7 test... 14:41:12 INFO - 2015-12-04 14:41:12,121 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFIHiJ/profile http://localhost:45671/getInfo.html 14:41:16 INFO - 2015-12-04 14:41:16,028 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:41:16 INFO - 2015-12-04 14:41:16,029 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:41:16 INFO - 2015-12-04 14:41:16,029 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:41:16 INFO - 2015-12-04 14:41:16,029 DEBUG : BROWSER_OUTPUT: __metrics 14:41:16 INFO - 2015-12-04 14:41:16,146 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] 14:41:16 INFO - 2015-12-04 14:41:16,201 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:41:16 ERROR - 2015-12-04 14:41:16,209 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:41:17 INFO - 2015-12-04 14:41:17,091 INFO : Browser initialized. 14:41:17 INFO - 2015-12-04 14:41:17,092 INFO : Running cycle 1/1 for v8_7 test... 14:41:17 INFO - 2015-12-04 14:41:17,092 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFIHiJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:41:29 INFO - 2015-12-04 14:41:29,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 14:41:29 INFO - 2015-12-04 14:41:29,136 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45671/tests/v8_7/run.html (next: http://localhost:45671/tests/v8_7/run.html) 14:41:50 INFO - 2015-12-04 14:41:50,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 455884800 14:41:50 INFO - 2015-12-04 14:41:50,838 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 14:41:50 INFO - 2015-12-04 14:41:50,839 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.04651162790697 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |6;Boyer;11929.411764705883 14:41:50 INFO - 2015-12-04 14:41:50,840 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 14:41:50 INFO - 2015-12-04 14:41:50,841 DEBUG : BROWSER_OUTPUT: |8;Splay;620.3473945409429 14:41:50 INFO - 2015-12-04 14:41:50,841 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 14:41:50 INFO - 2015-12-04 14:41:50,841 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:41:50 INFO - 2015-12-04 14:41:50,841 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268910837__endTimestamp 14:41:50 INFO - 2015-12-04 14:41:50,841 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,842 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:41:50 INFO - 2015-12-04 14:41:50,842 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:41:50 INFO - 2015-12-04 14:41:50,842 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,842 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,842 DEBUG : BROWSER_OUTPUT: Values: 166.3 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.05 Median:186.05 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: Values: 186.0 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,843 DEBUG : BROWSER_OUTPUT: Values: 278.3 14:41:50 INFO - 2015-12-04 14:41:50,844 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,844 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,844 DEBUG : BROWSER_OUTPUT: Values: 5117.3 14:41:50 INFO - 2015-12-04 14:41:50,844 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,844 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,845 DEBUG : BROWSER_OUTPUT: Values: 2006.0 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: Values: 785.5 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11929.41 Median:11929.41 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: Values: 11929.4 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: Values: 27054.1 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.35 Median:620.35 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: Values: 620.3 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: 14:41:50 INFO - 2015-12-04 14:41:50,846 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 14:41:50 INFO - 2015-12-04 14:41:50,847 DEBUG : BROWSER_OUTPUT: Values: 4864.1 14:41:50 INFO - 2015-12-04 14:41:50,847 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:41:50 INFO - 2015-12-04 14:41:50,847 DEBUG : BROWSER_OUTPUT: 14:41:51 INFO - 2015-12-04 14:41:51,786 INFO : Browser exited with error code: 0 14:41:51 INFO - 2015-12-04 14:41:51,798 INFO : Completed test v8_7 (00:00:39) 14:41:51 INFO - 2015-12-04 14:41:51,829 INFO : Completed test suite (00:20:17) 14:41:51 INFO - 2015-12-04 14:41:51,830 DEBUG : Working with test: dromaeo_css 14:41:51 INFO - 2015-12-04 14:41:51,830 DEBUG : Generating results file: dromaeo_css 14:41:51 INFO - 2015-12-04 14:41:51,831 DEBUG : Working with test: kraken 14:41:51 INFO - 2015-12-04 14:41:51,831 DEBUG : Generating results file: kraken 14:41:51 INFO - 2015-12-04 14:41:51,832 INFO : javascript benchmark 14:41:51 INFO - 2015-12-04 14:41:51,832 DEBUG : Working with test: v8_7 14:41:51 INFO - 2015-12-04 14:41:51,832 DEBUG : Generating results file: v8_7 14:41:51 INFO - 2015-12-04 14:41:51,832 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:41:51 INFO - 2015-12-04 14:41:51,892 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,26,35]] 14:41:51 INFO - 2015-12-04 14:41:51,892 DEBUG : process_Request line: dromaeo_css 6300.93 graph.html#tests=[[72,26,35]] 14:41:51 INFO - 2015-12-04 14:41:51,892 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:41:51 INFO - 2015-12-04 14:41:51,923 DEBUG : process_Request line: kraken 1512.10 graph.html#tests=[[232,26,35]] 14:41:51 INFO - 2015-12-04 14:41:51,923 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:41:51 INFO - 2015-12-04 14:41:51,955 DEBUG : process_Request line: v8_7 19788.39 graph.html#tests=[[230,26,35]] 14:41:51 INFO - 2015-12-04 14:41:51,957 INFO : javascript benchmark 14:41:52 INFO - 2015-12-04 14:41:51,960 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2649.4436168404636, 2739.260399692082, 2745.0117957535285, 2757.200411880556, 2769.8199617024898, 4539.364488971547, 4696.906061878761, 4805.90388192236, 4843.200871856139, 4845.321654968303, 4695.366125573055, 4725.0, 4783.808647654098, 4789.976050119744, 4870.342503761991, 4338.067315527161, 4362.236608593499, 4377.2777491713905, 4400.163968845909, 4434.935615452285, 4236.788160591974, 4420.138073075752, 4424.889377765549, 4457.24226881431, 4478.97760511197, 4254.149170165979, 4289.592488713567, 4303.053328267776, 4318.568143185687, 4341.978290108561, 4359.237133501624, 4368.89077773055, 4397.450318710161, 4408.757518336491, 4422.159789639958, 4188.308929026707, 4363.040131171138, 4365.585269399434, 4377.146456440995, 4404.823807047715, 4596.747178905159, 4619.16854966106, 4623.144718227139, 4701.177293973541, 4732.574068333832, 5116.923246151311, 5166.121759300928, 5170.819021334235, 5172.844814655567, 5223.817166399196, 4872.634552408584, 5184.040952423814, 5191.636585439021, 5200.323957885488, 5201.921971170435, 4634.119517291704, 4686.671932964728, 4692.249240121599, 4694.483606803249, 4732.52674732524, 5286.0, 5315.495027972336, 5316.76074576645, 5320.388155362106, 5322.201669749491, 4735.479097299294, 5080.695158290514, 5088.618353623493, 5096.923546146811, 5139.049275883974, 4974.801007959713, 4993.90012199754, 5049.394072711299, 5115.283860259567, 5134.0, 5086.3896332440345, 5128.538431541105, 5134.178531435027, 5135.306733590917, 5191.870203244949, 4861.781219845116, 5083.212102124176, 5101.387833460009, 5107.821226257063, 5110.66780659256, 4114.732542384735, 4168.937465938014, 4234.047339348684, 4234.280172370704, 4256.4679415073115, 3718.4236443351324, 3724.2365315110337, 3734.8506059757306, 3740.8129593520216, 3771.283456143324, 4179.2477354076555, 4416.80124394403, 4429.889252768707, 4430.734155950653, 4453.910921781611, 4919.655624106278, 4973.8010479581135, 5083.339165908408, 5184.662996905189, 5226.790928362899, 4384.101259241847, 4395.780210989502, 4402.163588918095, 4405.823767049346, 4451.332300154938, 4264.0, 4525.977370113128, 4535.070310586322, 4546.136234115507, 4578.793954271999, 4760.928586071212, 4791.784369703302, 4801.375821143229, 4904.8773780655765, 4906.2640603909695, 5154.201098829687, 5160.045391602415, 5166.844994650167, 5169.121249387688, 5171.663841850268, 4900.068986892479, 4902.656814022984, 4918.2376731606655, 4920.581750551243, 4956.083124621957, 4726.007538416971, 4833.492483289345, 4841.782119804688, 4886.047220791911, 5015.799368025238, 5142.8971420572125, 5150.098732721834, 5152.27868098459, 5154.639175257696, 5174.068667639861, 4977.253411988231, 4978.153713868579, 4993.176125939324, 4993.226049962116, 5024.698518088926, 4728.739919304334, 4817.78319975595, 4845.394325709286, 4857.1742803724155, 4971.850844474671, 4912.926306105483, 4922.187839006667, 4927.162382394929, 4940.6788558745, 4977.8257760978195, 5049.84850454487, 5051.545360917535, 5059.291699162047, 5090.720010399464, 5100.515451032146, 4642.651801114863, 4717.056588682209, 4765.785539650793, 4852.175130227799, 4979.178435558092], "unit": "ms", "name": "dojo.html", "value": 4670.233760627836}, {"lowerIsBetter": false, "replicates": [552.0961640514316, 571.0862619808307, 578.9710514474281, 591.4588151841066, 598.8023952095807, 28097.438051238987, 28807.71192288079, 28920.710792892063, 37202.62797372032, 37935.620643793554, 40792.0, 41396.172076558454, 41445.37831932523, 41494.79252603733, 41505.377419338736, 7850.254225848549, 8041.8793718094275, 8042.0, 8046.114927357986, 8049.557274349909, 7242.674079666402, 7391.260873912593, 10113.64602238918, 10444.21668374875, 10457.633982810603, 10043.0, 10151.390916544993, 10157.238207134495, 10160.0, 10162.28863979518, 7280.199178090459, 7432.962835185789, 10015.349002314862, 10131.746706332364, 10139.340942838766, 10100.343477673927, 10441.68674939753, 10443.42561159136, 10445.738856528647, 10451.68644940653, 37346.813265933495, 38199.04502387435, 38234.23531529354, 38239.61760382416, 38255.0, 2670.8798104085363, 2824.0257111296773, 3126.437241296566, 3228.677132286776, 3331.3670402623425, 27981.860090699418, 28049.85975070132, 28066.85966570154, 28212.153635390972, 28283.292917677016, 3335.34960682667, 3507.368673638744, 3511.1924257420683, 3515.1915059536195, 3649.543807024122, 212294.0, 216695.0, 217612.0, 218035.0, 218875.0, 56950.14574781382, 57415.71292143512, 57469.0, 57474.71262643744, 57513.137302940486, 54796.45203547993, 56687.0, 58130.709346453, 58974.0, 59262.40737592655, 14522.419103235963, 14598.34307456167, 14697.338619762137, 14705.338259778335, 14717.411303547953, 11262.887371126348, 11314.0, 11315.547378104948, 11331.433428328715, 11336.0, 19422.611547768967, 19790.70313945292, 19794.70307945382, 19800.20799168017, 19806.108725107406, 7606.0, 7708.18651192322, 7820.413468989848, 7879.290863822283, 8011.994002998501, 816.6978218059356, 875.9605817738217, 941.7127776028377, 958.4680502321139, 973.0123924216925, 26905.461890762075, 27010.72989270082, 27218.591721124198, 27330.180094597195, 27345.45309093807, 900.7793090692822, 946.3470205558281, 951.2247518272586, 952.8665986761858, 1019.1897441533998, 13647.795283070762, 13831.30843457823, 13840.515581954583, 13973.720525589431, 13979.720405591832, 325519.0, 333531.0, 333572.0, 334820.0, 335760.0, 46749.29876051794, 47179.05641887143, 47266.29100563494, 47323.76338118287, 47358.76320618375, 1036.7770929250248, 1130.4178348150708, 1206.5053328135248, 1231.7474917641862, 1240.6526172671665, 28025.71974280231, 28349.716502834708, 29142.417151656424, 29148.125556233346, 29149.7085029147, 40607.796961015, 41944.161116776886, 41966.58033419627, 41979.37030944477, 42028.15943681171, 161536.0, 163182.0, 167453.0, 169172.0, 237314.0, 28497.145085647462, 28510.714892851636, 28515.572266415606, 28564.857175713987, 28957.85521072381, 35631.28737425289, 36620.26759464849, 37043.62956370402, 37408.251834963696, 37473.250534988605, 31001.689983100783, 33660.66339336673, 34944.65055349516, 35290.82354588211, 35627.46558801672, 38140.618593813706, 39220.0, 39960.80019599883, 40240.19519609533, 40608.390874137505, 38769.6123038766, 39090.609093909836, 39375.21249574935, 39583.60416395799, 40105.79947100246, 31551.526727099572, 32544.0, 32612.51081233736, 32726.0, 33925.151871203416, 24396.0, 24616.0, 24750.25749227526, 24804.751952480245, 24843.254702358958], "unit": "ms", "name": "ext.html", "value": 17573.003966415385}, {"lowerIsBetter": false, "replicates": [329.36925787117684, 331.62857599488575, 331.75118661004257, 331.76113198497075, 334.8543383628122, 12082.395880205999, 12387.256764594109, 14749.705005899876, 15244.0, 15461.226938653064, 13989.650258743537, 14327.570172894804, 14402.0, 14805.777913331309, 14810.629734256649, 4368.410264614268, 4665.346851440801, 4796.280557916306, 4891.633127515451, 4937.851864444055, 4938.432080310774, 4975.577075948549, 4980.900381992358, 4986.252062190682, 4996.925046124311, 4811.566958973692, 4941.258811178334, 4945.505449455061, 4956.355673762424, 4969.875753106165, 4932.926006109911, 4946.159152944008, 4959.380077490314, 4963.751812409401, 4964.180910149839, 4299.91400171998, 4392.758398288093, 4414.668899832525, 4419.911601767979, 4423.535528769465, 10642.680719578348, 10992.780144397067, 18451.169697363515, 18691.065446727745, 18763.812361876342, 1715.8884672496247, 1774.201609275831, 1805.4132406967656, 1818.5180927054341, 1846.6860633692304, 8461.450005749606, 8484.0, 8565.100664430207, 8599.4840309581, 8611.138886111401, 1637.1568642149302, 1661.4268077513238, 1670.6575152093912, 1675.0, 1704.3779020657494, 54072.18891716628, 55389.0, 55994.16008759913, 56309.43690563083, 57344.0, 9439.669611563562, 9482.762930926781, 9500.287478439006, 9501.049895010581, 9546.90453095474, 10840.13278937683, 11065.944670276758, 11423.885761142448, 12166.209196402382, 12168.756624867454, 5347.946520534822, 5487.64330318528, 6007.819765406957, 7358.448116391292, 7395.186529481753, 7097.290270972965, 7112.786616401516, 7128.037714908524, 7143.642817859086, 7168.637958787814, 4030.6775457963295, 4092.570280120604, 4098.159877225162, 4118.855840045584, 4121.175764847043, 1700.7023770840053, 1732.0819965418098, 1757.3409971260778, 1758.5076178669992, 1758.753774471575, 819.700809204636, 844.5608283692568, 859.8925134358205, 868.9739307820776, 935.3919952031234, 15344.386224551115, 15414.84585154134, 15470.84529154694, 15843.366265349257, 15877.12675802842, 841.4993079117914, 855.7432770168924, 870.277669534285, 879.4020066354813, 940.2337095267335, 7162.4628152888745, 8712.21590056898, 8835.911640883638, 8914.643414263357, 8922.286217102615, 461499.0, 461545.0, 471389.0, 476492.0, 479816.0, 70467.2953270471, 71000.47708026806, 71585.43344634866, 71918.28081719116, 72664.63667681628, 1045.8274384726435, 1087.211771465681, 1092.8961748633867, 1097.506122244977, 1107.0645304717661, 13195.934020329836, 13629.454821807414, 13821.516246931309, 13963.022588418713, 14295.0, 23839.64240536428, 29371.41257174887, 29761.404771904872, 33102.5034624476, 33354.4996825043, 38923.0, 39086.804565976985, 39216.0, 41161.38257926074, 42238.788806055774, 8017.118117007008, 8649.178328059075, 8768.649254029768, 8783.692570759993, 8845.071267516818, 9444.905550944402, 9452.621895124117, 9547.0, 9652.613895444103, 9679.516024198903, 9505.572249248662, 12582.937085314881, 12913.870861291267, 12987.935060324638, 13321.067525273138, 12523.436445360163, 12576.434060467118, 12833.807492887427, 13080.803787942998, 13401.06192566511, 12641.93679031599, 12698.68253293638, 12891.935540322238, 13474.730505390033, 13603.115797473529, 11169.273997190157, 12379.319137447526, 12717.87282127204, 13589.592312230649, 13605.795913061114, 8425.578721064045, 8640.0, 8748.47509149453, 8761.03628600866, 9095.408798428081], "unit": "ms", "name": "jquery.html", "value": 7832.99882871999}, {"lowerIsBetter": false, "replicates": [1422.1253928833758, 1641.8440248176423, 1702.4296860551715, 1707.137895362842, 1736.3054778088772, 5759.913601295984, 7171.641417929102, 7376.631168441583, 7385.076865391826, 7402.074740657418, 7189.89215161773, 7312.926870731304, 7347.853042939151, 7350.669219885104, 7355.0, 2044.0903797810017, 2071.1818831561523, 2075.1284460526617, 2075.7960382977913, 2077.3767869639123, 2066.8863212523306, 2069.492974221318, 2080.2927004818357, 2120.7561130469962, 2124.02294944325, 2058.7014882841977, 2060.7424071991, 2070.6169358668617, 2078.76094249161, 2079.6152711748373, 2048.7336646235967, 2077.1483691686335, 2077.210659949225, 2077.854550181488, 2080.1887263967064, 2024.0588126521238, 2041.3773798991301, 2070.1926248762993, 2072.336852207294, 2074.7406574178226, 7209.315115064061, 7284.74503392384, 7285.089363829521, 7288.08898887639, 7288.708451661927, 4192.098698779777, 4270.743755374688, 4276.486821581399, 4310.159518893817, 4311.223979683656, 2606.8696565171667, 2620.9213723588323, 2629.447815958651, 2690.4350086481863, 2730.57676060211, 801.7153910361795, 801.9094032116317, 808.6805711743829, 827.8427098851259, 860.3074525007366, 9995.450250236234, 10014.198864090855, 10020.34867733595, 10025.097741203326, 10030.398176109384, 3915.060385507458, 3922.156736301709, 3969.8412063517712, 3979.343408337592, 4009.7794621296107, 8493.641017437303, 8524.31805455562, 8561.22948934599, 8566.357523185787, 8580.699675511327, 4344.630706389992, 4347.847825326098, 4360.65114790816, 4368.388425620416, 4370.8033138508845, 3098.209956461088, 3172.1118086935694, 3804.2771873343977, 3952.802359882052, 3959.762414255154, 3381.847816848248, 3444.2767018925806, 3445.5693038370205, 3456.792592444461, 3493.039414161126, 1110.7001109700336, 1125.5722825326325, 1126.6845283320683, 1129.9152563557766, 1134.2570616246371, 876.7369789063256, 887.924526415249, 895.3553441522093, 896.3008853094597, 993.0218734546465, 6804.795856124324, 6909.239983601799, 6909.30906909305, 6913.585184888822, 6917.757878474229, 939.5155654066558, 949.1599934058409, 985.2413641496008, 1019.6482213636284, 1083.6369816111692, 5389.056915039852, 5432.320959880015, 5494.313210848644, 5496.285482887199, 5497.092979658311, 8650.264727498106, 8757.605907734167, 8761.956190219136, 8778.209961103532, 8846.911530884738, 8514.70198543048, 8552.059273479912, 8647.654093836176, 8715.825683486295, 8786.648534058693, 6807.523473356917, 6859.485538584626, 6867.244603093655, 6913.930860691429, 6915.239323674392, 6765.932340676531, 6900.102986611709, 6903.275156108737, 6924.619145947021, 6930.965345173242, 7658.081030276402, 7892.289693927574, 7946.523208607502, 8008.15914328987, 8021.959890200745, 8035.035795704553, 8035.236652518001, 8171.877421838558, 8302.294304983903, 8306.460080094774, 5238.345206849144, 5448.182772584144, 6037.396260374103, 6245.96877015612, 6358.332375100548, 6957.756478523227, 6960.547564408297, 6978.511504194861, 6992.0910281663055, 7004.0544526488275, 6467.838304042437, 6488.188976377953, 6545.2800191979795, 6630.90053649186, 6744.763933262312, 6361.109444677842, 6432.131662225727, 6471.967640161769, 6522.34776522363, 6588.209414870246, 6015.428534289235, 6044.7279872406725, 6046.7581296749395, 6052.364501727256, 6065.969670151621, 5726.4273572642405, 5731.799387021601, 5761.884762304814, 5879.941200587939, 5928.170056192223, 5948.553858460719, 5976.8804623908145, 5985.281766187911, 5985.461308482258, 5988.311344195473], "unit": "ms", "name": "mootools.html", "value": 4113.801692031159}, {"lowerIsBetter": false, "replicates": [271.198608113026, 274.72390247800956, 278.60020870051466, 278.76444404478207, 280.0492328544591, 5261.526462618363, 5352.330958630171, 5359.490848369408, 5373.7581808818595, 5396.541293990011, 5216.426193118754, 5363.222332761748, 5366.034113859504, 5374.516293533581, 5375.865603359918, 4088.468499095128, 4091.488563929509, 4094.303968325392, 4096.610821971908, 4097.323941549641, 3887.0, 3994.26106170358, 3997.7201595888155, 4084.1627466369323, 4092.7339722918064, 4034.495688038995, 4034.7175697701173, 4034.9798251008706, 4050.2709512287774, 4059.8376064957515, 4066.593340665939, 4067.2068946555432, 4072.470578824749, 4073.1853629274265, 4080.1839632073556, 3532.6467353264725, 3532.964670353315, 3533.94699079514, 3534.6818786309354, 3540.4689296605457, 5056.671316364462, 5159.122949098624, 5170.663906846043, 5171.095058364809, 5177.58579313654, 4659.091477161955, 4681.431720373679, 4681.789319480631, 4681.836135735233, 4684.461286951976, 5603.691796951166, 5603.8879222415735, 5604.047311956977, 5612.522935550483, 5615.382307946123, 3619.7647152934974, 3736.6263373662687, 3765.585785563586, 3835.290471262825, 3841.3661745811905, 5904.793332233394, 5919.348871624118, 5924.170616113704, 5937.703114844284, 5939.346671866135, 3927.7643341399607, 3927.9410808837893, 3928.3125453046173, 3932.0563064864227, 3935.330993731073, 3979.2638361902564, 3988.4216788566077, 3988.9401658974557, 3993.2612466693754, 3998.820053097618, 4527.9547204527535, 4613.653975951817, 4614.169449499055, 4619.722816631013, 4623.838165664186, 5617.073182924772, 5619.438056194348, 5631.324241091095, 5636.830895073154, 5639.238702775155, 1395.2605119286795, 1410.0693542262059, 1411.2167746900568, 1413.0885578801615, 1413.1662319231702, 941.5809964565702, 948.6821914658528, 949.4113649537193, 967.2213867836459, 968.8837339519303, 4951.158303088484, 4958.876028099255, 4966.279889416014, 4969.229769385751, 4969.229769385751, 5847.590668653153, 5852.531797456193, 5853.2976042875125, 5865.0, 5867.413258674183, 4953.331300274417, 4955.98402327522, 4957.529034741694, 4958.8760280993265, 4959.2809042688605, 3070.078976307099, 3128.780985331005, 3148.5592017117624, 3161.873525059018, 3164.161497203243, 5608.298962629671, 5611.579131565149, 5651.350094739076, 5652.717364131777, 5653.406392328829, 6099.146119543268, 6103.84740381494, 6107.870044041866, 6108.694565271808, 6112.847178820565, 5617.354004289477, 5634.633748806396, 5639.351474580394, 5641.323041235078, 5642.915356269577, 5718.914216286842, 5914.497267732291, 5926.555508336978, 5942.73257703413, 5945.0, 5534.889302213853, 5698.088305871041, 5790.247267855152, 5791.53667706574, 5805.477507024388, 5498.80754173602, 5607.186957891001, 5613.859653508532, 5625.718714064362, 5642.125470552071, 3872.690184785267, 3908.511436070491, 3920.137569734654, 3924.7252692311263, 3925.156091440354, 5901.734421950937, 5907.409259074058, 5910.261217347832, 5913.497352725067, 5914.319853216935, 5521.944780552143, 5684.317881854204, 5685.374608793112, 5688.744006519633, 5693.8861222774485, 5693.373728889902, 5694.0, 5699.344575373885, 5701.458361455655, 5704.543636509153, 5542.2795036644975, 5576.832695019156, 5579.637323573955, 5580.441955804387, 5584.525315348241, 5611.214429979887, 5721.799737009184, 5745.683987380734, 5752.338481074563, 5755.942440575708, 5554.555635549227, 5555.138953462219, 5555.30558680165, 5556.499915007668, 5560.527355174693], "unit": "ms", "name": "prototype.html", "value": 4199.030818967889}, {"lowerIsBetter": false, "replicates": [662.5858838226109, 701.2286484866647, 707.6709330161474, 716.8673795347861, 721.0842230367433, 11519.596814111508, 11707.0, 11711.707207319821, 11765.588204412847, 11767.470463829126, 11516.366599837005, 11691.0, 11718.941405292982, 11728.413579321043, 11735.589254376098, 626.0952923026229, 631.7378288010493, 794.7258195922412, 809.5668817182808, 813.3980854167933, 801.8115742800467, 810.5177419435427, 813.975580732576, 815.8449894520052, 817.2767101115496, 831.0401486283353, 839.8236370362231, 839.8278352937664, 840.0759164918571, 840.504102579478, 651.7165033210545, 660.1451120798578, 830.1822704635929, 841.4278290762279, 842.0, 624.6564389585756, 624.6658037949675, 629.8173529676434, 629.8425393651587, 630.3381449478076, 11467.31196128235, 11704.063674905987, 11739.471723772365, 11768.235064720766, 11782.293062416282, 10934.781304373948, 11539.711507212387, 11627.12796540263, 11691.415429228504, 11774.941125294405, 9351.906480935171, 9395.812083758356, 9487.383320084173, 9498.335116541844, 9502.287328450393, 3190.3140824722564, 3191.69678880506, 3210.502372132323, 3254.7558933079877, 3259.5925509311337, 39063.21873562513, 39380.0, 39646.0, 39894.401583976556, 40204.19591608181, 8936.553172341357, 9215.128664995467, 9273.860892086625, 9398.389104708309, 9404.94918470794, 15058.774118388234, 15113.697726045417, 15127.924360378127, 15134.016288941184, 15156.545303640909, 6057.0, 6282.528810339243, 6442.967785161138, 6543.672816359163, 6721.865562688817, 3559.964400356015, 3662.597114317423, 3686.9078273043388, 3773.4905787718853, 3801.752886062397, 2696.501147287758, 2736.480068786924, 2736.808423410342, 2741.7669498092487, 2742.191053639181, 471.2530638937254, 476.9904601908012, 484.1841497077436, 484.29776823605914, 486.39443892354245, 454.5976810522711, 485.12435054725853, 495.74221404869985, 503.97732102055494, 558.4722437296797, 7187.460940429489, 7331.413486921034, 7371.189169191384, 7383.335499805044, 7617.695292188361, 583.3437382944188, 591.6923199936009, 594.1562980567518, 605.3825098399608, 616.140484024783, 3515.6660117288816, 3554.573451185874, 3620.87326943561, 3675.5956844747056, 3706.388445906395, 47409.762951185716, 47599.04801904012, 47741.5225847744, 51114.74442627763, 51616.0, 40471.59528404737, 40508.39237411441, 40647.1870562593, 40737.79631101825, 41862.79068604698, 40279.39580906289, 40356.0, 41123.1775364497, 41164.0, 41431.171376572296, 7243.167035790952, 7648.923510765044, 7675.616219188906, 7773.261540153676, 8274.875876861972, 31374.215644608154, 31791.88728394495, 32546.67453325531, 32778.344433111684, 33114.50328245127, 40348.59651403566, 40617.0, 40645.0, 40739.1852162961, 40881.59118408778, 10039.749006274902, 10308.948455257676, 10375.377477351383, 10439.425831579032, 10507.842382364424, 11629.476673549541, 11816.881831181578, 11915.702107447383, 12026.75946481083, 12199.451024703732, 10035.598576056876, 10047.045530674573, 10130.392176469435, 10259.281850270409, 10484.056434920894, 10656.89343106559, 10761.461926903467, 10851.511681974487, 11180.720481988015, 11631.47658355359, 8406.52091971367, 10104.595816167564, 10307.484625768531, 10353.844692329772, 10405.583776649151, 8415.064535157071, 8552.102029286836, 8720.302375809793, 8799.384043117176, 9132.132447417485, 7856.25365590268, 8208.753737387888, 8322.375821813268, 8445.535495547803, 8447.197516235949], "unit": "ms", "name": "yui.html", "value": 5634.806122164941}], "name": "dromaeo_css", "value": 6300.934367102393}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 111.0, 110.0, 100.0, 109.0, 110.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 150.0, 160.0, 131.0, 155.0, 155.0, 131.0, 170.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 84.0, 90.0, 73.0, 78.0, 72.0, 103.0, 94.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 129.0, 94.0, 93.0, 93.0, 130.0, 94.0, 94.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 78.0, 67.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 84.0, 92.0, 85.0, 83.0, 84.0, 83.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 119.0, 117.0, 124.0, 121.0, 122.0, 121.0, 125.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [132.0, 149.0, 150.0, 143.0, 137.0, 143.0, 157.0, 142.0, 150.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 70.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1512.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [186.04651162790697], "unit": "score", "name": "DeltaBlue", "value": 355.38425000000007}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [11929.411764705883], "unit": "score", "name": "Boyer", "value": 55.867214003944795}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [620.3473945409429], "unit": "score", "name": "Splay", "value": 131.363492}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19788.39492973941}]} 14:41:52 INFO - RETURN: dromaeo_css: 6300.93 14:41:52 INFO - RETURN: kraken: 1512.10 14:41:52 INFO - RETURN: v8_7: 19788.39 14:41:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,26,35]]", "result": "19788.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,26,35]]", "result": "1512.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,26,35]]", "result": "6300.93"}}} 14:41:52 INFO - Return code: 0 14:41:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:41:52 ERROR - # TBPL SUCCESS # 14:41:52 INFO - Running post-action listener: _resource_record_post_action 14:41:52 INFO - Running post-run listener: _resource_record_post_run 14:41:53 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 577536; Write bytes: 288768000; Read time: 56; Write time: 178740 14:41:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14344192; Read time: 0; Write time: 3880 14:41:53 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 577536; Write bytes: 274423808; Read time: 56; Write time: 174860 14:41:53 INFO - Running post-run listener: _upload_blobber_files 14:41:53 INFO - Blob upload gear active. 14:41:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:41:53 INFO - Copying logs to upload dir... 14:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.067169 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-04 14:41:53.207214) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:41:53.210768) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009495 build_url: 'https://queue.taskcluster.net/v1/task/WHPd1ih_SgWQHY-rkaackg/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 14:41:53.262492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:41:53.262804) ========= 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=919420d7ee4ef147bef0346300000385-1449267640.289658-923552272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:41:53.312392) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 14:41:53.312843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 14:41:53.313317) ========= ========= Total master_lag: 0.22 =========