builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1449890013.64 results: success (0) buildid: 20151211184532 builduid: 4a80942b922c4d75a351696627c1cdbf revision: 9a5268189d9865506f1e41b7580743e22128d0a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.637294) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.637775) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.638436) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006349 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.702449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.702771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.787236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.787609) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.848975) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.849944) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.850653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:33.851404) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 19:13:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2015-12-11 19:13:34 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.053750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.054152) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014603 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.109458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.109821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a5268189d9865506f1e41b7580743e22128d0a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9a5268189d9865506f1e41b7580743e22128d0a6 --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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 19:13:34,517 truncating revision to first 12 chars 2015-12-11 19:13:34,517 Setting DEBUG logging. 2015-12-11 19:13:34,517 attempt 1/10 2015-12-11 19:13:34,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a5268189d98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 19:13:34,761 unpacking tar archive at: fx-team-9a5268189d98/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543852 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.669286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.669653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.684777) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.685075) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 19:13:34.685560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-11 19:13:34.685888) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:13:35 INFO - MultiFileLogger online at 20151211 19:13:35 in /builds/slave/test 19:13:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:13:35 INFO - {'append_to_log': False, 19:13:35 INFO - 'base_work_dir': '/builds/slave/test', 19:13:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:13:35 INFO - 'branch': 'Fx-Team-Non-PGO', 19:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:13:35 INFO - 'config_files': ('talos/linux_config.py',), 19:13:35 INFO - 'default_actions': ('clobber', 19:13:35 INFO - 'read-buildbot-config', 19:13:35 INFO - 'download-and-extract', 19:13:35 INFO - 'populate-webroot', 19:13:35 INFO - 'create-virtualenv', 19:13:35 INFO - 'install', 19:13:35 INFO - 'run-tests'), 19:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:13:35 INFO - 'download_minidump_stackwalk': True, 19:13:35 INFO - 'download_symbols': 'ondemand', 19:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:13:35 INFO - 'installer_path': 'installer.exe', 19:13:35 INFO - 'log_level': 'info', 19:13:35 INFO - 'log_name': 'talos', 19:13:35 INFO - 'log_to_console': True, 19:13:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:13:35 INFO - 'opt_config_files': (), 19:13:35 INFO - 'pip_index': False, 19:13:35 INFO - 'sps_profile': False, 19:13:35 INFO - 'sps_profile_interval': 0, 19:13:35 INFO - 'suite': 'dromaeojs', 19:13:35 INFO - 'system_bits': '64', 19:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:13:35 INFO - 'title': 'talos-linux64-ix-047', 19:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:13:35 INFO - 'use_talos_json': True, 19:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:13:35 INFO - 'work_dir': 'build'} 19:13:35 INFO - ##### 19:13:35 INFO - ##### Running clobber step. 19:13:35 INFO - ##### 19:13:35 INFO - Running pre-action listener: _resource_record_pre_action 19:13:35 INFO - Running main action method: clobber 19:13:35 INFO - rmtree: /builds/slave/test/build 19:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:13:35 INFO - Running post-action listener: _resource_record_post_action 19:13:35 INFO - ##### 19:13:35 INFO - ##### Running read-buildbot-config step. 19:13:35 INFO - ##### 19:13:35 INFO - Running pre-action listener: _resource_record_pre_action 19:13:35 INFO - Running main action method: read_buildbot_config 19:13:35 INFO - Using buildbot properties: 19:13:35 INFO - { 19:13:35 INFO - "properties": { 19:13:35 INFO - "buildnumber": 1007, 19:13:35 INFO - "product": "firefox", 19:13:35 INFO - "script_repo_revision": "production", 19:13:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:13:35 INFO - "repository": "", 19:13:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:13:35 INFO - "buildid": "20151211184532", 19:13:35 INFO - "slavename": "talos-linux64-ix-047", 19:13:35 INFO - "pgo_build": "False", 19:13:35 INFO - "basedir": "/builds/slave/test", 19:13:35 INFO - "project": "", 19:13:35 INFO - "platform": "ubuntu64_hw", 19:13:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:13:35 INFO - "slavebuilddir": "test", 19:13:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:13:35 INFO - "branch": "fx-team", 19:13:35 INFO - "repo_path": "integration/fx-team", 19:13:35 INFO - "stage_platform": "linux64", 19:13:35 INFO - "builduid": "4a80942b922c4d75a351696627c1cdbf", 19:13:35 INFO - "revision": "9a5268189d9865506f1e41b7580743e22128d0a6" 19:13:35 INFO - }, 19:13:35 INFO - "sourcestamp": { 19:13:35 INFO - "repository": "", 19:13:35 INFO - "hasPatch": false, 19:13:35 INFO - "project": "", 19:13:35 INFO - "branch": "fx-team-linux64-talos", 19:13:35 INFO - "changes": [ 19:13:35 INFO - { 19:13:35 INFO - "category": null, 19:13:35 INFO - "files": [ 19:13:35 INFO - { 19:13:35 INFO - "url": null, 19:13:35 INFO - "name": "https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:13:35 INFO - } 19:13:35 INFO - ], 19:13:35 INFO - "repository": "", 19:13:35 INFO - "rev": "9a5268189d9865506f1e41b7580743e22128d0a6", 19:13:35 INFO - "who": "philringnalda@gmail.com", 19:13:35 INFO - "when": 1449889953, 19:13:35 INFO - "number": 7354587, 19:13:35 INFO - "comments": "Back out 30d3b887b4ec (bug 1230213) for Android 4.3 crashes in test_TelemetryLog.js", 19:13:35 INFO - "project": "", 19:13:35 INFO - "at": "Fri 11 Dec 2015 19:12:33", 19:13:35 INFO - "branch": "fx-team-linux64-talos", 19:13:35 INFO - "revlink": "", 19:13:35 INFO - "properties": [ 19:13:35 INFO - [ 19:13:35 INFO - "buildid", 19:13:35 INFO - "20151211184532", 19:13:35 INFO - "Change" 19:13:35 INFO - ], 19:13:35 INFO - [ 19:13:35 INFO - "builduid", 19:13:35 INFO - "4a80942b922c4d75a351696627c1cdbf", 19:13:35 INFO - "Change" 19:13:35 INFO - ], 19:13:35 INFO - [ 19:13:35 INFO - "pgo_build", 19:13:35 INFO - "False", 19:13:35 INFO - "Change" 19:13:35 INFO - ] 19:13:35 INFO - ], 19:13:35 INFO - "revision": "9a5268189d9865506f1e41b7580743e22128d0a6" 19:13:35 INFO - } 19:13:35 INFO - ], 19:13:35 INFO - "revision": "9a5268189d9865506f1e41b7580743e22128d0a6" 19:13:35 INFO - } 19:13:35 INFO - } 19:13:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:13:35 INFO - Running post-action listener: _resource_record_post_action 19:13:35 INFO - ##### 19:13:35 INFO - ##### Running download-and-extract step. 19:13:35 INFO - ##### 19:13:35 INFO - Running pre-action listener: _resource_record_pre_action 19:13:35 INFO - Running main action method: download_and_extract 19:13:35 INFO - mkdir: /builds/slave/test/build/tests 19:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:35 INFO - https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/test_packages.json 19:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/test_packages.json 19:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:13:40 INFO - Downloaded 1302 bytes. 19:13:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:13:40 INFO - Using the following test package requirements: 19:13:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:13:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:13:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'jsshell-linux-x86_64.zip'], 19:13:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:13:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:13:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:13:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:13:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:13:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:13:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:13:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:40 INFO - https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:42 INFO - Downloaded 21874385 bytes. 19:13:42 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 19:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:42 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 19:13:43 INFO - Return code: 0 19:13:43 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 19:13: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')]} 19:13:43 INFO - https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:44 INFO - Downloaded 21874385 bytes. 19:13:44 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 19:13:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:13:44 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 19:13:46 INFO - Return code: 0 19:13: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')]} 19:13:46 INFO - https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:47 INFO - Downloaded 11132038 bytes. 19:13:47 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 19:13:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:47 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 19:13:47 INFO - Return code: 0 19:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:47 INFO - https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/47S_1bF8S6mrFVeGjHyccw/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 19:13:48 INFO - Downloaded 57731857 bytes. 19:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:13:48 INFO - mkdir: /builds/slave/test/properties 19:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:13:48 INFO - Contents: 19:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:13:48 INFO - Running post-action listener: _resource_record_post_action 19:13:48 INFO - Running post-action listener: set_extra_try_arguments 19:13:48 INFO - ##### 19:13:48 INFO - ##### Running populate-webroot step. 19:13:48 INFO - ##### 19:13:48 INFO - Running pre-action listener: _resource_record_pre_action 19:13:48 INFO - Running main action method: populate_webroot 19:13:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:13:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:13:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:13:48 INFO - '--tppagecycles', 19:13:48 INFO - '7'], 19:13:48 INFO - 'tests': ['tsvgm']}}, 19:13:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:13:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:13:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:13:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:13:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'tests': ['damp', 'tps']}, 19:13:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['damp', 'tps']}, 19:13:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:13:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:13:48 INFO - 'other': {'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'other_l64': {'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'other_nol64': {'tests': ['a11yr', 19:13:48 INFO - 'ts_paint', 19:13:48 INFO - 'tpaint', 19:13:48 INFO - 'sessionrestore', 19:13:48 INFO - 'sessionrestore_no_auto_restore']}, 19:13:48 INFO - 'svgr': {'tests': ['tsvgx', 19:13:48 INFO - 'tsvgr_opacity', 19:13:48 INFO - 'tart', 19:13:48 INFO - 'tscrollx', 19:13:48 INFO - 'cart']}, 19:13:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['tsvgx', 19:13:48 INFO - 'tsvgr_opacity', 19:13:48 INFO - 'tart', 19:13:48 INFO - 'tscrollx', 19:13:48 INFO - 'cart']}, 19:13:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'tests': ['tp5o']}, 19:13:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'talos_options': ['--e10s'], 19:13:48 INFO - 'tests': ['tp5o']}, 19:13:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'talos_options': ['--xperf_path', 19:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:48 INFO - 'tests': ['tp5n']}, 19:13:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:48 INFO - 'talos_options': ['--e10s', 19:13:48 INFO - '--xperf_path', 19:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:48 INFO - 'tests': ['tp5n']}}, 19:13:48 INFO - 'talos.zip': {'path': '', 19:13:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:13:48 INFO - Running post-action listener: _resource_record_post_action 19:13:48 INFO - ##### 19:13:48 INFO - ##### Running create-virtualenv step. 19:13:48 INFO - ##### 19:13:48 INFO - Running pre-action listener: _resource_record_pre_action 19:13:48 INFO - Running main action method: create_virtualenv 19:13:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:13:48 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 19:13:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:13:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:13:48 INFO - Using real prefix '/usr' 19:13:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:13:49 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:51 INFO - Installing pip.................done. 19:13:51 INFO - Return code: 0 19:13:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:51 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:13:51 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 19:13:51 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 19:13:51 INFO - Using env: {'DISPLAY': ':0', 19:13:51 INFO - 'HOME': '/home/cltbld', 19:13:51 INFO - 'LANG': 'en_US.UTF-8', 19:13:51 INFO - 'LANGUAGE': 'en_US:en', 19:13:51 INFO - 'LOGNAME': 'cltbld', 19:13:51 INFO - 'MAIL': '/var/mail/cltbld', 19:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:51 INFO - 'MOZ_NO_REMOTE': '1', 19:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:51 INFO - 'NO_EM_RESTART': '1', 19:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:51 INFO - 'PWD': '/builds/slave/test', 19:13:51 INFO - 'SHELL': '/bin/bash', 19:13:51 INFO - 'SHLVL': '1', 19:13:51 INFO - 'TERM': 'linux', 19:13:51 INFO - 'TMOUT': '86400', 19:13:51 INFO - 'USER': 'cltbld', 19:13:51 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:51 INFO - '_': '/tools/buildbot/bin/python'} 19:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:51 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 19:13:51 INFO - Cleaning up... 19:13:51 INFO - Return code: 0 19:13:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:51 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:13:51 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 19:13:51 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 19:13:51 INFO - Using env: {'DISPLAY': ':0', 19:13:51 INFO - 'HOME': '/home/cltbld', 19:13:51 INFO - 'LANG': 'en_US.UTF-8', 19:13:51 INFO - 'LANGUAGE': 'en_US:en', 19:13:51 INFO - 'LOGNAME': 'cltbld', 19:13:51 INFO - 'MAIL': '/var/mail/cltbld', 19:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:51 INFO - 'MOZ_NO_REMOTE': '1', 19:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:51 INFO - 'NO_EM_RESTART': '1', 19:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:51 INFO - 'PWD': '/builds/slave/test', 19:13:51 INFO - 'SHELL': '/bin/bash', 19:13:51 INFO - 'SHLVL': '1', 19:13:51 INFO - 'TERM': 'linux', 19:13:51 INFO - 'TMOUT': '86400', 19:13:51 INFO - 'USER': 'cltbld', 19:13:51 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:51 INFO - '_': '/tools/buildbot/bin/python'} 19:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:51 INFO - Downloading/unpacking psutil>=0.7.1 19:13:51 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 19:13:51 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 19:13:51 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 19:13:51 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 19:13:51 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 19:13:51 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 19:13:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:13:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:53 INFO - Installing collected packages: psutil 19:13:53 INFO - Running setup.py install for psutil 19:13:53 INFO - building 'psutil._psutil_linux' extension 19:13:53 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 19:13:53 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 19:13:54 INFO - building 'psutil._psutil_posix' extension 19:13:54 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 19:13:54 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 19:13:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:54 INFO - Successfully installed psutil 19:13:54 INFO - Cleaning up... 19:13:54 INFO - Return code: 0 19:13:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:54 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:13:54 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 19:13:54 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 19:13:54 INFO - Using env: {'DISPLAY': ':0', 19:13:54 INFO - 'HOME': '/home/cltbld', 19:13:54 INFO - 'LANG': 'en_US.UTF-8', 19:13:54 INFO - 'LANGUAGE': 'en_US:en', 19:13:54 INFO - 'LOGNAME': 'cltbld', 19:13:54 INFO - 'MAIL': '/var/mail/cltbld', 19:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:54 INFO - 'MOZ_NO_REMOTE': '1', 19:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:54 INFO - 'NO_EM_RESTART': '1', 19:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:54 INFO - 'PWD': '/builds/slave/test', 19:13:54 INFO - 'SHELL': '/bin/bash', 19:13:54 INFO - 'SHLVL': '1', 19:13:54 INFO - 'TERM': 'linux', 19:13:54 INFO - 'TMOUT': '86400', 19:13:54 INFO - 'USER': 'cltbld', 19:13:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:54 INFO - '_': '/tools/buildbot/bin/python'} 19:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:13:56 INFO - Installing collected packages: mozsystemmonitor 19:13:56 INFO - Running setup.py install for mozsystemmonitor 19:13:56 INFO - Successfully installed mozsystemmonitor 19:13:56 INFO - Cleaning up... 19:13:56 INFO - Return code: 0 19:13:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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', '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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:13: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 blobuploader==1.2.4 19:13:56 INFO - Using env: {'DISPLAY': ':0', 19:13:56 INFO - 'HOME': '/home/cltbld', 19:13:56 INFO - 'LANG': 'en_US.UTF-8', 19:13:56 INFO - 'LANGUAGE': 'en_US:en', 19:13:56 INFO - 'LOGNAME': 'cltbld', 19:13:56 INFO - 'MAIL': '/var/mail/cltbld', 19:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:56 INFO - 'MOZ_NO_REMOTE': '1', 19:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:56 INFO - 'NO_EM_RESTART': '1', 19:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:56 INFO - 'PWD': '/builds/slave/test', 19:13:56 INFO - 'SHELL': '/bin/bash', 19:13:56 INFO - 'SHLVL': '1', 19:13:56 INFO - 'TERM': 'linux', 19:13:56 INFO - 'TMOUT': '86400', 19:13:56 INFO - 'USER': 'cltbld', 19:13:56 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:56 INFO - '_': '/tools/buildbot/bin/python'} 19:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:13:56 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 19:13:56 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 19:13:56 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 19:13:56 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 19:13:56 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 19:13:56 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 19:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:13:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:13:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:58 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 19:13:59 INFO - Downloading docopt-0.6.1.tar.gz 19:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:13:59 INFO - Running setup.py install for blobuploader 19:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:13:59 INFO - Running setup.py install for requests 19:13:59 INFO - Running setup.py install for docopt 19:13:59 INFO - Successfully installed blobuploader requests docopt 19:13:59 INFO - Cleaning up... 19:13:59 INFO - Return code: 0 19:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:59 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:13:59 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 19:13:59 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 19:13:59 INFO - Using env: {'DISPLAY': ':0', 19:13:59 INFO - 'HOME': '/home/cltbld', 19:13:59 INFO - 'LANG': 'en_US.UTF-8', 19:13:59 INFO - 'LANGUAGE': 'en_US:en', 19:13:59 INFO - 'LOGNAME': 'cltbld', 19:13:59 INFO - 'MAIL': '/var/mail/cltbld', 19:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:59 INFO - 'MOZ_NO_REMOTE': '1', 19:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:59 INFO - 'NO_EM_RESTART': '1', 19:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:59 INFO - 'PWD': '/builds/slave/test', 19:13:59 INFO - 'SHELL': '/bin/bash', 19:13:59 INFO - 'SHLVL': '1', 19:13:59 INFO - 'TERM': 'linux', 19:13:59 INFO - 'TMOUT': '86400', 19:13:59 INFO - 'USER': 'cltbld', 19:13:59 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:59 INFO - '_': '/tools/buildbot/bin/python'} 19:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:59 INFO - Running setup.py (path:/tmp/pip-9VBGe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:00 INFO - Running setup.py (path:/tmp/pip-clheG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:00 INFO - Running setup.py (path:/tmp/pip-aGd384-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:00 INFO - Running setup.py (path:/tmp/pip-Bi3VAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:00 INFO - Running setup.py (path:/tmp/pip-KN9KSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:00 INFO - Running setup.py (path:/tmp/pip-0oBjkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:00 INFO - Running setup.py (path:/tmp/pip-Fhniwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:00 INFO - Running setup.py (path:/tmp/pip-9JxuzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:00 INFO - Running setup.py (path:/tmp/pip-odtLoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:00 INFO - Running setup.py (path:/tmp/pip-ZcivS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:00 INFO - Running setup.py (path:/tmp/pip-KLPY2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:00 INFO - Running setup.py (path:/tmp/pip-INnXTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:00 INFO - Running setup.py (path:/tmp/pip-mep5kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:00 INFO - Running setup.py (path:/tmp/pip-Ot1kQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:00 INFO - Running setup.py (path:/tmp/pip-00SLb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:01 INFO - Running setup.py (path:/tmp/pip-Rvsd7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:01 INFO - Running setup.py (path:/tmp/pip-v3M5PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:14:01 INFO - Running setup.py install for manifestparser 19:14:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Running setup.py install for mozcrash 19:14:01 INFO - Running setup.py install for mozdebug 19:14:01 INFO - Running setup.py install for mozdevice 19:14:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Running setup.py install for mozfile 19:14:01 INFO - Running setup.py install for mozhttpd 19:14:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Running setup.py install for mozinfo 19:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Running setup.py install for mozInstall 19:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:14:01 INFO - Running setup.py install for mozleak 19:14:02 INFO - Running setup.py install for mozlog 19:14:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Running setup.py install for moznetwork 19:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Running setup.py install for mozprocess 19:14:02 INFO - Running setup.py install for mozprofile 19:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Running setup.py install for mozrunner 19:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Running setup.py install for mozscreenshot 19:14:02 INFO - Running setup.py install for moztest 19:14:02 INFO - Running setup.py install for mozversion 19:14:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:14:02 INFO - Cleaning up... 19:14:02 INFO - Return code: 0 19:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 19:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 19:14:02 INFO - Using env: {'DISPLAY': ':0', 19:14:02 INFO - 'HOME': '/home/cltbld', 19:14:02 INFO - 'LANG': 'en_US.UTF-8', 19:14:02 INFO - 'LANGUAGE': 'en_US:en', 19:14:02 INFO - 'LOGNAME': 'cltbld', 19:14:02 INFO - 'MAIL': '/var/mail/cltbld', 19:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:02 INFO - 'MOZ_NO_REMOTE': '1', 19:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:02 INFO - 'NO_EM_RESTART': '1', 19:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:02 INFO - 'PWD': '/builds/slave/test', 19:14:02 INFO - 'SHELL': '/bin/bash', 19:14:02 INFO - 'SHLVL': '1', 19:14:02 INFO - 'TERM': 'linux', 19:14:02 INFO - 'TMOUT': '86400', 19:14:02 INFO - 'USER': 'cltbld', 19:14:02 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:02 INFO - '_': '/tools/buildbot/bin/python'} 19:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:03 INFO - Running setup.py (path:/tmp/pip-MYvdCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:03 INFO - Running setup.py (path:/tmp/pip-vf6Kly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:03 INFO - Running setup.py (path:/tmp/pip-Q6HYbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:03 INFO - Running setup.py (path:/tmp/pip-CVqz8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:03 INFO - Running setup.py (path:/tmp/pip-LO0Ca5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:03 INFO - Running setup.py (path:/tmp/pip-EQ3mLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:03 INFO - Running setup.py (path:/tmp/pip-LQdSAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:03 INFO - Running setup.py (path:/tmp/pip-hM_HB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:03 INFO - Running setup.py (path:/tmp/pip-CEc7P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:03 INFO - Running setup.py (path:/tmp/pip-P7IgOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:03 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)) 19:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:03 INFO - Running setup.py (path:/tmp/pip-XDjoWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:04 INFO - Running setup.py (path:/tmp/pip-996eKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:04 INFO - Running setup.py (path:/tmp/pip-fMG0F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:04 INFO - Running setup.py (path:/tmp/pip-idM8IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:04 INFO - Running setup.py (path:/tmp/pip-I48apo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:04 INFO - Running setup.py (path:/tmp/pip-0Upizt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:04 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)) 19:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:04 INFO - Running setup.py (path:/tmp/pip-rj_AGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:04 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)) 19:14:04 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)) 19:14:04 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)) 19:14:04 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)) 19:14:04 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)) 19:14:04 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)) 19:14:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:06 INFO - Downloading blessings-1.5.1.tar.gz 19:14:06 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 19:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:14:06 INFO - Installing collected packages: blessings 19:14:06 INFO - Running setup.py install for blessings 19:14:06 INFO - Successfully installed blessings 19:14:06 INFO - Cleaning up... 19:14:06 INFO - Return code: 0 19:14:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:06 INFO - Reading from file tmpfile_stdout 19:14:06 INFO - Current package versions: 19:14:06 INFO - argparse == 1.2.1 19:14:06 INFO - blessings == 1.5.1 19:14:06 INFO - blobuploader == 1.2.4 19:14:06 INFO - docopt == 0.6.1 19:14:06 INFO - manifestparser == 1.1 19:14:06 INFO - mozInstall == 1.12 19:14:06 INFO - mozcrash == 0.16 19:14:06 INFO - mozdebug == 0.1 19:14:06 INFO - mozdevice == 0.47 19:14:06 INFO - mozfile == 1.2 19:14:06 INFO - mozhttpd == 0.7 19:14:06 INFO - mozinfo == 0.9 19:14:06 INFO - mozleak == 0.1 19:14:06 INFO - mozlog == 3.1 19:14:06 INFO - moznetwork == 0.27 19:14:06 INFO - mozprocess == 0.22 19:14:06 INFO - mozprofile == 0.27 19:14:06 INFO - mozrunner == 6.11 19:14:06 INFO - mozscreenshot == 0.1 19:14:06 INFO - mozsystemmonitor == 0.0 19:14:06 INFO - moztest == 0.7 19:14:06 INFO - mozversion == 1.4 19:14:06 INFO - psutil == 3.1.1 19:14:06 INFO - requests == 1.2.3 19:14:06 INFO - wsgiref == 0.1.2 19:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:06 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')]} 19:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:06 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')]} 19:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:06 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:14:06 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 19:14:06 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 19:14:06 INFO - Using env: {'DISPLAY': ':0', 19:14:06 INFO - 'HOME': '/home/cltbld', 19:14:06 INFO - 'LANG': 'en_US.UTF-8', 19:14:06 INFO - 'LANGUAGE': 'en_US:en', 19:14:06 INFO - 'LOGNAME': 'cltbld', 19:14:06 INFO - 'MAIL': '/var/mail/cltbld', 19:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:06 INFO - 'MOZ_NO_REMOTE': '1', 19:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:06 INFO - 'NO_EM_RESTART': '1', 19:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:06 INFO - 'PWD': '/builds/slave/test', 19:14:06 INFO - 'SHELL': '/bin/bash', 19:14:06 INFO - 'SHLVL': '1', 19:14:06 INFO - 'TERM': 'linux', 19:14:06 INFO - 'TMOUT': '86400', 19:14:06 INFO - 'USER': 'cltbld', 19:14:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:06 INFO - '_': '/tools/buildbot/bin/python'} 19:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 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)) 19:14:06 INFO - Cleaning up... 19:14:06 INFO - Return code: 0 19:14:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:14:06 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')]} 19:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:06 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')]} 19:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:06 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:14:06 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 19:14:06 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 19:14:06 INFO - Using env: {'DISPLAY': ':0', 19:14:06 INFO - 'HOME': '/home/cltbld', 19:14:06 INFO - 'LANG': 'en_US.UTF-8', 19:14:06 INFO - 'LANGUAGE': 'en_US:en', 19:14:06 INFO - 'LOGNAME': 'cltbld', 19:14:06 INFO - 'MAIL': '/var/mail/cltbld', 19:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:06 INFO - 'MOZ_NO_REMOTE': '1', 19:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:06 INFO - 'NO_EM_RESTART': '1', 19:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:06 INFO - 'PWD': '/builds/slave/test', 19:14:06 INFO - 'SHELL': '/bin/bash', 19:14:06 INFO - 'SHLVL': '1', 19:14:06 INFO - 'TERM': 'linux', 19:14:06 INFO - 'TMOUT': '86400', 19:14:06 INFO - 'USER': 'cltbld', 19:14:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:06 INFO - '_': '/tools/buildbot/bin/python'} 19:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:06 INFO - Downloading/unpacking jsonschema 19:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:14:08 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 19:14:08 INFO - Downloading/unpacking functools32 (from jsonschema) 19:14:08 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 19:14:08 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 19:14:08 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 19:14:08 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 19:14:08 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 19:14:08 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 19:14:08 INFO - Downloading functools32-3.2.3-2.tar.gz 19:14:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:14:08 INFO - warning: no files found matching '*.txt' 19:14:08 INFO - no previously-included directories found matching 'build' 19:14:08 INFO - no previously-included directories found matching 'dist' 19:14:08 INFO - no previously-included directories found matching '.git*' 19:14:08 INFO - Installing collected packages: jsonschema, functools32 19:14:08 INFO - Running setup.py install for functools32 19:14:09 INFO - warning: no files found matching '*.txt' 19:14:09 INFO - no previously-included directories found matching 'build' 19:14:09 INFO - no previously-included directories found matching 'dist' 19:14:09 INFO - no previously-included directories found matching '.git*' 19:14:09 INFO - Successfully installed jsonschema functools32 19:14:09 INFO - Cleaning up... 19:14:09 INFO - Return code: 0 19:14:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:14:09 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')]} 19:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:09 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')]} 19:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:09 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 0x7f17de812f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', '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 19:14:09 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 19:14:09 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 19:14:09 INFO - Using env: {'DISPLAY': ':0', 19:14:09 INFO - 'HOME': '/home/cltbld', 19:14:09 INFO - 'LANG': 'en_US.UTF-8', 19:14:09 INFO - 'LANGUAGE': 'en_US:en', 19:14:09 INFO - 'LOGNAME': 'cltbld', 19:14:09 INFO - 'MAIL': '/var/mail/cltbld', 19:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:09 INFO - 'MOZ_NO_REMOTE': '1', 19:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:09 INFO - 'NO_EM_RESTART': '1', 19:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:09 INFO - 'PWD': '/builds/slave/test', 19:14:09 INFO - 'SHELL': '/bin/bash', 19:14:09 INFO - 'SHLVL': '1', 19:14:09 INFO - 'TERM': 'linux', 19:14:09 INFO - 'TMOUT': '86400', 19:14:09 INFO - 'USER': 'cltbld', 19:14:09 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:09 INFO - '_': '/tools/buildbot/bin/python'} 19:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:09 INFO - Downloading/unpacking flake8 19:14:09 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 19:14:09 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 19:14:09 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 19:14:09 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 19:14:09 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 19:14:09 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 19:14:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:14:11 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 19:14:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:14:11 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 19:14:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 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 19:14:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:14:11 INFO - no previously-included directories found matching 'docs/_build' 19:14:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:14:11 INFO - Running setup.py install for pep8 19:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:14:11 INFO - no previously-included directories found matching 'docs/_build' 19:14:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:14:11 INFO - Cleaning up... 19:14:11 INFO - Return code: 0 19:14:11 INFO - Running post-action listener: _resource_record_post_action 19:14:11 INFO - Running post-action listener: _start_resource_monitoring 19:14:11 INFO - Starting resource monitoring. 19:14:11 INFO - ##### 19:14:11 INFO - ##### Running install step. 19:14:11 INFO - ##### 19:14:11 INFO - Running pre-action listener: _resource_record_pre_action 19:14:11 INFO - Running main action method: install 19:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:12 INFO - Reading from file tmpfile_stdout 19:14:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:14:12 INFO - Reading from file tmpfile_stdout 19:14:12 INFO - Output received: 19:14:12 INFO - Usage: mozinstall [options] installer 19:14:12 INFO - Options: 19:14:12 INFO - -h, --help show this help message and exit 19:14:12 INFO - -d DEST, --destination=DEST 19:14:12 INFO - Directory to install application into. [default: 19:14:12 INFO - "/builds/slave/test"] 19:14:12 INFO - --app=APP Application being installed. [default: firefox] 19:14:12 INFO - mkdir: /builds/slave/test/build/application 19:14:12 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'] 19:14:12 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 19:14:26 INFO - Reading from file tmpfile_stdout 19:14:26 INFO - Output received: 19:14:26 INFO - /builds/slave/test/build/application/firefox/firefox 19:14:26 INFO - Running post-action listener: _resource_record_post_action 19:14:26 INFO - ##### 19:14:26 INFO - ##### Running run-tests step. 19:14:26 INFO - ##### 19:14:26 INFO - Running pre-action listener: _resource_record_pre_action 19:14:26 INFO - Running main action method: run_tests 19:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:14:26 INFO - Python 2.7.3 19:14:26 INFO - Return code: 0 19:14:26 INFO - grabbing minidump binary from tooltool 19:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:26 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 0x14520b0>, '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 0x1452fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1453440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:14:26 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 19:14:26 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 19:14:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:14:26 INFO - Return code: 0 19:14:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:14:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:14:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:14:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:14:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:14:27 INFO - Return code: 0 19:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 19:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 19:14:27 INFO - Using env: {'DISPLAY': ':0', 19:14:27 INFO - 'HOME': '/home/cltbld', 19:14:27 INFO - 'LANG': 'en_US.UTF-8', 19:14:27 INFO - 'LANGUAGE': 'en_US:en', 19:14:27 INFO - 'LOGNAME': 'cltbld', 19:14:27 INFO - 'MAIL': '/var/mail/cltbld', 19:14:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:14:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:27 INFO - 'MOZ_NO_REMOTE': '1', 19:14:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:27 INFO - 'NO_EM_RESTART': '1', 19:14:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:27 INFO - 'PWD': '/builds/slave/test', 19:14:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:14:27 INFO - 'SHELL': '/bin/bash', 19:14:27 INFO - 'SHLVL': '1', 19:14:27 INFO - 'TERM': 'linux', 19:14:27 INFO - 'TMOUT': '86400', 19:14:27 INFO - 'USER': 'cltbld', 19:14:27 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142', 19:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:27 INFO - '_': '/tools/buildbot/bin/python'} 19:14:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 19:14:27 INFO - mozversion INFO | application_buildid: 20151211184532 19:14:27 INFO - mozversion INFO | application_changeset: 9a5268189d9865506f1e41b7580743e22128d0a6 19:14:27 INFO - mozversion INFO | application_display_name: Nightly 19:14:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:14:27 INFO - mozversion INFO | application_name: Firefox 19:14:27 INFO - mozversion INFO | application_remotingname: firefox 19:14:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:14:27 INFO - mozversion INFO | application_vendor: Mozilla 19:14:27 INFO - mozversion INFO | application_version: 45.0a1 19:14:27 INFO - mozversion INFO | platform_buildid: 20151211184532 19:14:27 INFO - mozversion INFO | platform_changeset: 9a5268189d9865506f1e41b7580743e22128d0a6 19:14:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:14:27 INFO - mozversion INFO | platform_version: 45.0a1 19:14:27 INFO - 2015-12-11 19:14:27,989 DEBUG : using testdate: 1449890067 19:14:27 INFO - 2015-12-11 19:14:27,989 DEBUG : actual date: 1449890067 19:14:28 INFO - 2015-12-11 19:14:28,066 INFO : starting webserver on 'localhost:37947' 19:14:28 INFO - 2015-12-11 19:14:28,067 INFO : Starting test suite talos-linux64-ix-047 19:14:28 INFO - 2015-12-11 19:14:28,067 INFO : Starting test dromaeo_css 19:14:28 INFO - 2015-12-11 19:14:28,067 DEBUG : operating with platform_type : linux_ 19:14:28 INFO - 2015-12-11 19:14:28,068 INFO : Initialising browser for dromaeo_css test... 19:14:28 INFO - 2015-12-11 19:14:28,080 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tPXdK/profile http://localhost:37947/getInfo.html 19:14:32 INFO - 2015-12-11 19:14:32,700 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:14:32 INFO - 2015-12-11 19:14:32,701 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:14:32 INFO - 2015-12-11 19:14:32,701 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:14:32 INFO - 2015-12-11 19:14:32,701 DEBUG : BROWSER_OUTPUT: __metrics 19:14:32 INFO - 2015-12-11 19:14:32,790 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] 19:14:32 INFO - 2015-12-11 19:14:32,850 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] 19:14:33 INFO - 2015-12-11 19:14:33,700 INFO : Browser initialized. 19:14:33 INFO - 2015-12-11 19:14:33,700 INFO : Running cycle 1/1 for dromaeo_css test... 19:14:33 INFO - 2015-12-11 19:14:33,701 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tPXdK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:14:45 INFO - 2015-12-11 19:14:45,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 143450112 19:14:45 INFO - 2015-12-11 19:14:45,656 DEBUG : BROWSER_OUTPUT: 19:15:36 INFO - 2015-12-11 19:15:36,896 DEBUG : BROWSER_OUTPUT: 1449890136894 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] 19:17:48 INFO - 2015-12-11 19:17:48,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37947/tests/dromaeo/cssquery-ext.html) 19:17:49 INFO - 2015-12-11 19:17:49,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 247664640 19:17:49 INFO - 2015-12-11 19:17:49,978 DEBUG : BROWSER_OUTPUT: 19:20:52 INFO - 2015-12-11 19:20:52,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-ext.html (next: http://localhost:37947/tests/dromaeo/cssquery-jquery.html) 19:20:53 INFO - 2015-12-11 19:20:53,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 221667328 19:20:53 INFO - 2015-12-11 19:20:53,157 DEBUG : BROWSER_OUTPUT: 19:23:55 INFO - 2015-12-11 19:23:55,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37947/tests/dromaeo/cssquery-mootools.html) 19:23:55 INFO - 2015-12-11 19:23:55,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 222281728 19:23:55 INFO - 2015-12-11 19:23:55,817 DEBUG : BROWSER_OUTPUT: 19:26:57 INFO - 2015-12-11 19:26:57,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37947/tests/dromaeo/cssquery-prototype.html) 19:26:58 INFO - 2015-12-11 19:26:58,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 205520896 19:26:58 INFO - 2015-12-11 19:26:58,368 DEBUG : BROWSER_OUTPUT: 19:30:01 INFO - 2015-12-11 19:30:01,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37947/tests/dromaeo/cssquery-yui.html) 19:30:01 INFO - 2015-12-11 19:30:01,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 208007168 19:30:01 INFO - 2015-12-11 19:30:01,753 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/dromaeo/cssquery-yui.html (next: http://localhost:37947/tests/dromaeo/cssquery-dojo.html) 19:33:04 INFO - 2015-12-11 19:33:04,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 252899328 19:33:04 INFO - 2015-12-11 19:33:04,609 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,610 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:33:04 INFO - 2015-12-11 19:33:04,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:33:04 INFO - 2015-12-11 19:33:04,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:33:04 INFO - 2015-12-11 19:33:04,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:33:04 INFO - 2015-12-11 19:33:04,613 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.790096792257;2720.156751407064;2720.7415295546916;2736.3706347540065;2737.178846346096;4527.185106680796;4645.628349732022;4653.813847446107;4673.672842900998;4691.835785747499;4584.449866016074;4603.148417542757;4641.350210970467;4657.55753203446;4657.673962822604;4272.7863606819765;4340.1102773931425;4351.434313539251;4357.956420435787;4395.186890425265;4202.432671589342;4400.911981760363;4417.094495628405;4456.554344565534;4460;4179.853705120307;4244;4270.743755374688;4272.01743598974;4278.951656844078;4335.7181783184;4338.045629961435;4344.891377715582;4373.781310934441;4383.561643835623;4161.91676166475;4330.004099057203;4330.480342358937;4336.761478118702;4384.868453946387;4515.796789144496;4521.344405061281;4533.659975501851;4626.606738427237;4646.558576935186;5074.264231686385;5086.338775959101;5086.64393492452;5107.770150343244;5142.151544995108;4824.734639594821;5104.387473503203;5114.795408183705;5119.718415487147;5128.487151284879;4547.704399214107;4599.839005634787;4621.676482646216;4645.88385290367;4663.417072865892;5183.663061900965;5244.29202057725;5246.422893481714;5252;5297.364316282071;4729.716217026989;4991.326170966946;5002.774875130628;5012.598992080625;5055.368078990126;4905.656604037683;4951.554360107608;4974.179260422062;4994.350734404504;5018.573421259161;5007.549320561167;5028.145215313405;5028.974855125774;5033.697978121324;5080.872978175501;4776.379070720784;4991.80032798684;5000.774965126578;5007.69953802773;5061.31672224245;4105.8973525662095;4164.895877603023;4170.4995400551525;4183.560726123774;4214.536400995888;3681.0981309578788;3703.7962912039557;3720.720945929066;3721.9441708374397;3761.1725420407465;4113.814878330422;4328.783560821947;4335.2196604610845;4336.306191009423;4371.781410929504;4913.31213630092;4955.628327875424;4970.453250142481;5064.139096353629;5077.441481437039;4266.466691663542;4285.678574106954;4288.163808057461;4292.570742925683;4331.696781225347;4447.177272204653;4448.955510444919;4450.488193857683;4453.665975051884;4511.097780443924;4605.0559635274685;4676.462206846256;4723.220668589782;4725.716457012591;4733.739644319596;5112.182050871843;5113.897722045613;5116.15583428745;5120.129577971679;5157.200633901752;4827.468978412442;4828.493008234085;4832.685875418087;4835.323054772405;4877;4820.276958456259;4933.753312334297;5032.521910418504;5034.295198672262;5080.314157588826;4951.3810773653295;4977.0294792515115;5020.221865610836;5038.571721403721;5070.721110338819;4947.332110165082;4977.228529577921;4978.975105124451;4981.775820088033;5016.749162541785;4717;4910.705357678551;4920.6555541111775;4971.627127965345;5011.949880501148;4767.880802979953;4791.185498465339;4868.245421959602;4877;4897.289892965428;4938.209886418156;4965.975170124127;4971.453140154653;4973.154563724248;5017.297578339108;4659.068186362809;4825.662203645711;4850;4852.126617208936;4909.95090049095 19:33:04 INFO - 2015-12-11 19:33:04,614 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.2978396140669;582.606740450196;583.614814222613;585.5842351930129;595.3183604772536;27127.728722712767;27622.71847863582;27658;32747.83626081866;34251.143721406916;39051.41422878659;39542.20915581687;39650.60349396505;39677;39786.8010659947;7749.9225007749765;7883.881741773878;7920.445568810185;7920.762377128695;7922.722704705337;7193.496455248135;7384.113906331248;10017.449040302781;10270.7432314192;10277.691669249896;10094.343867648578;10187.388756674623;10200.387976721384;10201.183905287597;10207.744806379826;7230.349268565854;7426.108866935948;10008.549615267295;10118.747031324203;10127.13919316859;9872.35829671069;10044.397336159855;10084.798304033879;10087.949560252226;10090.192784577217;36719;37227;37241.81379093114;37291.4406283906;37312;2843.8009339346254;3544.503769472276;3638.818059097061;3659.762115462513;3714.7771133731794;28566.714332856613;28802;29002.70997290021;29448.70551294481;29640.258993525335;3238.91902702432;3249.8862539810993;3311.3708395405038;3352.6312105668358;3418.5555877735737;207787;207829;207842;208052;208329;45317.77341113339;46345.30482042772;46413.30380044302;59833.40166598278;61134;54110.45889541133;54143;54291.371258862295;54353.45646543563;54381.45618543764;13014.284214368112;13235.602931912059;13305.733885322239;13306.401211945486;13317.866821331856;9614.95192524047;9732.318737688294;9752.024797520191;9859.802803943881;9861.309708320348;18438.26246950107;18587.721184182246;18634.440966771017;18691.813081869008;18762.530936726693;7459.776206713807;7678.155402905676;7855.332296754726;7859.764207073797;7914.722984695623;756.5687558091945;780.6916268074192;907.4691305586174;964.3056998960737;1053.7629033467408;25488.362790930376;25528.48943021129;26682.466350673265;28779;29849.850750746107;868.1058509734983;890.7105190812882;898.4609234459402;919.4437365393974;919.5494207838245;13160.100586756138;13289.335533223493;13305.334733263491;13430.395632196574;13465.326733663278;260443;262738;264351;264590;264840;44777.55222447799;45050.54949450464;45058.54941450609;45077.54922450799;45119.32321015187;1182.3615247766281;1186.5135294529375;1194.8805119487981;1220.0666490135054;1238.8575313838844;21301.36095917125;24571.38571535726;25070;25229.621555676313;28442.288942776595;36505.26989460249;36903.26193476169;36921;36932.44601331036;36964.63035369612;199447;199971;200101;200454;225217;22775.430614234116;28560;28784.42431151407;28953.84184632591;29000.12999610015;33194.66805332012;38516.42225366566;39122.608773911896;39706;39750.60249397585;29796;29796.553051704675;30102.84948575243;31919.202019949687;33367.66632333743;29208.26979325534;29604.111876643736;29660.25849353697;29744.851275743484;29795;29162.56256156202;29509.26226844346;29734.702652973192;29786.404271914875;29807;26398.340041498348;29174.7082529172;29269.268268293465;29881.252968675955;29918.25204369908;22804.543909122058;22946.196883109013;22983.195588154333;23053.21002546541;23332.883335583214 19:33:04 INFO - 2015-12-11 19:33:04,615 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.7296789600425;336.9157710572357;337.4027970492229;337.5561137104707;337.8800525813336;12515.499380024788;12995.415206315714;14933.775993360096;15305.617359566017;15869.761953570705;8836.33727470439;11421.885781142186;11451.770964580703;12946.029047821428;14876.702465950702;4507.594316511513;4653.930191047137;4656.767161641921;4662.393888794469;4910.680805747633;3489.5638045244345;3584.6953008994265;4978.576820970222;5080.339555857733;5250.422453530108;5163.225516172585;5212.713300768456;5218.32161818963;5234.685918844882;5238.895222095556;5160.277561141444;5201;5660.094384898396;5663.5186009189265;5667.631603945731;5019;5022.42242142151;5026.723530205837;5030.698158110525;5031.345925029759;10989.670309890716;11377.601783937605;11382.772344553063;11394.031507321888;11608.709782255426;1756.2360373237682;1819.8362147406797;1863.8695291329611;1871.6069625378686;1883.1525813383896;8550.871736923951;8936.374453788238;9177.816443671156;10659.467026648637;12996.220226786423;1629.5600187949306;1703.8977661340236;1715.3138744502173;1733.5752740578512;1744.9309755161278;50885;53709.462905370834;55328.44671553273;55730.16404753972;56602.43397566054;9820.901790982141;9836.213102951746;9856.260780441495;9873.901260987443;9910.950445247727;12489.50041998328;12516.12387132892;12519.687007824696;12527.624171274876;12530.310832904277;6652.467802575782;6729.158855143107;6782.796516104525;6817.659117044227;6828.419584335288;6350.745970161234;6473.805785826433;6530.771423000172;6572.441342485942;6575.704093315812;4162.188373267184;4210.136921930997;4228.830846766156;4250;4258.68059895509;1635.3703824027598;1652.6198974235754;1684.7725557049887;1690.8309169082993;1732.3936622182136;745.143085451724;799.396455675961;893.7854914820397;909.6725178935578;970.7136394763562;15239.23803809805;15659;15783.605409864846;16016.519504414886;16085.678286434206;731.6597782031381;763.5380594740213;775.5501808950795;801.935845132388;906.4334790755778;8676.392652514263;8783.25342345895;8876.112388761072;9016.504092274989;9165.862512062324;456799;465865;467413;470577;475136;60768.69615651982;61824.690876545326;62462.68768656219;65094.67452662707;73605.26394736092;949.2785483032944;1008.9495525223709;1013.123648044451;1018.4296793795498;1020.6478764826123;13918.304084795922;13993.720125597634;13997.5100871469;14111.717765644424;14198;30405.543916840823;30486.695133049274;31088;31403.52894706627;31502.684973150892;45630.31554526618;45653.54346456493;46613.766931165126;48810.755946220044;48869.51130488792;8834.249088827264;8857.867131992896;9013.819723605622;9039.819203616022;9058.230050445522;15585.68828623444;15745;15798.76301855496;15833.762493562375;16355.100469474293;13379.264140472367;13548.729025419634;13692.65768355799;13757.79363309571;13956.720865582834;12717;12956.546520871725;12987.480500779862;13111.27887966171;13306.933465332611;10142.340747851365;10545.156387489136;11428.542858285575;13134.540291089766;13452;8542.846715693302;8626.568671566522;8653.870191947;8714.215720585178;8731.563421828756;12735.74528509406;12872.356382180666;12896.548620798603;12991.220526768424;13138.605841824761 19:33:04 INFO - 2015-12-11 19:33:04,616 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1180.9055275577955;1380.2615600653646;1398.8671076247758;1632.942847000355;1720.8623310135185;6016.969915150424;6769.627670478128;6971.233164351917;6973.198082220546;6979.546329488579;6885.758998435056;7037.507374483788;7038;7049.471289653271;7066.7173313067415;1761.3659082730208;1795.3985414885963;1992.9800701993013;2033.9694904576443;2057.187410972665;2095.905684244205;2113.4927617371795;2117.068489864462;2123.957520849582;2125.91496340147;2059.258666879922;2072.9378118656464;2112.3451729963685;2118.904649290778;2121.2575598540466;2052.7434070741156;2057.094878253579;2076.5431605046865;2076.584683063386;2080.4694802825184;2049.7027930950076;2080.147139672727;2082.1567265257595;2083.958320833575;2084.9791502084936;7001.894971575431;7092.50352475327;7094.503384763068;7104.11198600175;7109.928900710978;4039.171969746195;4061.2689715851134;4085.2850751118435;4107.281225785476;4179.707420480568;2677.772389346908;2697.7167397423186;2704.1211606228053;2705.864706764654;2708.729127087295;807.64059993303;811.8579248631524;822.1819289806621;850.974470765878;853.185208126238;8931.821363572757;8940.8658870117;8951.776205594848;8973.910260897374;8974.641014359418;3747.0819649186124;3771.585125636178;3893.6106389361403;3900.1809619979554;3908.5895980921596;7908.367330613537;7916.525008499509;7920.564368959763;7927.960360198277;7941.880871786928;4163.687723420695;4166.791660416967;4174.08170202561;4179.247735407595;4196.3705444183615;3750.587435382106;3769.6984241260634;3782.3002744491805;3787.791671458041;3792.943105853414;2975.5834183214365;3027.576139340494;3263.6618986216013;3329.500574913734;3356.9496457553155;1055.6674647486018;1057.2229411382627;1060.9920575453195;1062.1927335225284;1066.9519871605796;862.7239283429242;866.3891956170885;866.4627930683017;902.6118768929423;1143.7712457508533;6574.967125164344;6617.437517810944;6634.701438435282;6669.699863506154;6681.532292739462;1058.640062378795;1066.4934156275863;1070.5824728355947;1079.643717573199;1085.733995171188;5136.845894623168;5141.074606570854;5153.201253805666;5189.040027594907;5195.766190521435;8094.51432914027;8547.529885856338;8607.397482176313;8623.094575069654;8651.52416617092;8423.873641895254;8428.915710842935;8483.109273526314;8511.74464766058;8512.787180320542;6492.740290388331;6501.804945851632;6694.397504224643;6701.865962680817;6709.329067093349;6362.618242905441;6387.361263873576;6408.327125651926;6409.615423074444;6420.26166990802;7475.327220550176;7520.8495830082;7667.731629393167;7669.118051424158;7674.731384401519;7534.35957943581;7687.154413014676;7699.3840492761565;7704.38364930793;7740.651670674946;6011.368806275453;6183.412575805291;6261.436470717657;6261.812145635638;6265.373462653698;5555.30558680165;5617.606767526398;6184.969075154595;6328.778492752916;6571.704273307617;5975.641461512149;6040.244969378828;6085.2393450818645;6117.908231376622;6150.261968563801;5967.433093856077;6001.549883758648;6037.78867739627;6077.149199112039;6196.1635179250225;6090.086487026982;6173.32093469709;6176.474999625082;6188.164597779422;6207.81376558704;5578.386377498391;5602.1036634138345;5603.887922241451;5621.156826476062;5635.295588051494;5837.211976383303;5852.034414321589;5852.5317974561085;5865.061590145556;5871.823845284648 19:33:04 INFO - 2015-12-11 19:33:04,616 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.9589655396521;304.6496528991661;307.78147515264163;308.4032397311203;310.10998434493;5247.711375874325;5321.308229930113;5354.839354819352;5374.838754837361;5412.07994640911;5289.418164001966;5300.708461034642;5303;5307.283516725241;5312.814051508198;3970.622790834866;4181.937270940938;4183.435236243099;4186.602272784081;4196.118815048843;4062.939055914164;4064.2887494688457;4140.213359461708;4181.623653871151;4185.560516145792;4127.711060225785;4130.979345103286;4136.482939632546;4146.232946904832;4152.650388623694;3909.2181563687377;4008.8596899108684;4010.1779135277197;4121.752694838305;4138.917221655565;3651.2514934438377;3677.1358730698266;3677.5586929568353;3679.5032670589394;3687.3362794696945;5117.8720531987;5119.590432765407;5119.616028797818;5122.871928201825;5124.897502049976;4792.880177995543;4810.110129625996;4810.374651295344;4814.109389762905;4814.350062741555;5483.616146869721;5629.9437005629825;5636.887262254773;5638.971805140989;5655.462731040586;4004.199160167949;4015.217032678629;4015.4980627421573;4015.8996025099314;4017.678585713136;5880.911786323209;5912.6156799808305;5925.851853703649;5928.110783382484;5930.614510056833;4136.462259906253;4143.6892233082635;4145.585441455891;4148.087420767426;4149.937750933738;3949.19041596472;4115.135821477524;4206.57934206583;4206.8737937861915;4208.116295577902;4657.441107067174;4663.603593694506;4669.066186762661;4669.696469729457;4691.413573303337;5570.470805273492;5577.135543990688;5583.274174357389;5583.664980101125;5614.933162699074;1417.5392997275926;1445.645816774897;1446.7106578684304;1447.073872721459;1447.1389523233659;961.5480724059821;968;972.1639390124487;987.2644879564626;990.4601991914424;4908.509149085135;4911.361523001987;4929.679570827885;4931.309616653672;4933.333999910038;5801.7099145042575;5838.153467747153;5846.181534585162;5856.180134781134;5866.325372582122;4929.580985616263;4936.679115857458;4943.085529177114;4945.085159245551;4947.084789313988;2897.8116422432895;3018.0644000359957;3108.1452600535035;3118.4075025745037;3152.385284869474;5550.167474878801;5556.388797232301;5558.749856256478;5560.110382338807;5563.499285064364;6043.848903777441;6044.969775151184;6060.515158787286;6068.362821903725;6068.848278792977;5500.532454741312;5530.6128570999645;5532.336119665746;5549.972250138723;5559.555235581144;5731.283589551306;5869.853253668522;5901.734421951109;5910.822675319747;5913.733881975236;5747.051736463437;5749.741261643152;5753.079507278982;5757.453041961007;5764.625299355528;5543.334799824047;5548.0013597552825;5550.806576586054;5555.555555555465;5557.277553917965;3902.5902280260166;4034.596540345942;4061.756294622332;4073.0631954650003;4081.6122468365456;5816.82549523515;5842.065269556851;5848.327442344185;5850.034744267318;5853.2976042875125;5594.1049432092295;5607.43925607436;5617.9719101404235;5623.072193088258;5627.662340259598;5609.74756135983;5616.887662246814;5619.044762390322;5621.297337832771;5626.578006649435;5357.491038351351;5485.369182543899;5493.972530137324;5495.368032676133;5500.394956554695;5603.35561410443;5605.383407825218;5606.551475881838;5650.35020972577;5651.943480565306;5320.414754377093;5391.4608539145775;5486.1222204447095;5490.752916118704;5554.194641776839 19:33:04 INFO - 2015-12-11 19:33:04,617 DEBUG : BROWSER_OUTPUT: |5;yui.html;640.2381166411969;668.9364510371513;704.7110684619307;713.5611598866699;746.973855915043;10399.896001039988;10578.36529808212;10595.894041059588;10636.20228482863;10668.306560073599;11641.243319184247;11728.53085876564;11733.354665493394;13171.80242296364;13307.135036222662;630.5680608782975;637.6875331087757;811.8619834628098;812.1878121878121;826.6197549127409;811.7037281392279;819.9098099209082;821.5153059694779;826.4834478450969;826.7478419082178;852.3479538153317;859.8452278589851;860.1355637584219;861.4615865084322;861.8750281209221;653.7646447278976;662.499812641455;849.452103393314;873.3013589128735;874.0865795243922;618.3847072163181;618.5082859127004;622.6979914741347;623.8565130020075;624.2540164503421;11449.942750286278;11750.588729394516;11759.647210583697;11775.470103845348;11777;10599.523021464052;10754.946225268903;11115.666530004113;11586.47860846264;11730.88269117315;9364.531773411301;9462.432254064779;9560.330776845623;9574.377665451724;9684.370515916513;3091.5517249998848;3105.7515398768046;3180.984095079533;3211.0848408203783;3225.3388055448577;38612;39027.41458878119;39364.606353936666;39377.80311098455;39382.21235575272;9451.905480945103;9516.429014259167;9558.330916835755;9631.759206019906;9682.90317096834;16556.254968526446;16693.41573044962;16733.163341833104;16742.916285418494;16756.832431675528;6560.343965603402;6581.045748366556;6647.634380109141;6738.696758645872;6795;3525.4888041233876;3577.195131095483;3596.442551404484;3618.2582570572968;3695.287320471128;2672.5991101334566;2680.812343135962;2687.50281197979;2688.892444302206;2691.0715803047915;463.2240996331132;486.4260172995899;494.29809670268304;501.45842490110596;501.8494451664486;524.6904326447415;531.619891777381;531.912234481314;537.7418838957244;541.9024575576356;6922.5154239202775;7218.747343843045;7270.745523906744;7299.5255308404785;7523.661435235427;370.44803243167485;417.30989492555636;547.4170008940465;551.4540604801218;569.5671289819684;3063.417950589381;3462.722982161421;3694.538182727159;3701.8889433317045;3770.9057273567832;45598.77200614042;46074;46458;46528;46959.29561056518;41575;41603;41744;43197.56802431998;43202.135957280676;38769.61230387716;40099;40219.776923423204;40379.59620403758;40662.59337406647;6817.863642727217;6850.314968503109;6908.654567271717;6909.412699920563;7091.2554181810165;28851.7114828849;29882;29999.250018749706;30378.544321834746;30850.382992340477;37326.626733732315;37839;38205.42691859569;38603;38834.6116538831;9276.58255378523;9511.762205944906;9753.122219000325;9819.312648114563;9962;10952.040796079107;11174.497147628213;11208.88791112111;11276.548938042386;11657.941710291394;9892.901070989197;10069.194464442973;10299.124574411258;10632.89367106319;10657.680269591614;10264.58941642326;10279.897201028192;10327.845082323622;10328.638497652546;10566.366018038942;10041.297109202285;10096.596136154472;10328.380297182193;10414.73963150897;10577.153827693612;8124.715634952749;8666.739997800076;8698.13018698125;8780.209781119729;8980.281577473917;8880.86678699807;8899.154580315118;8943;8997;9190.218831399407 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,947 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: __startTimestamp1449891184610__endTimestamp 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,618 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4643.62 Median:4733.74 stddev:492.36 (10.4%) stddev-sans-first:467.68 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: Values: 2623.8 2720.2 2720.7 2736.4 2737.2 4527.2 4645.6 4653.8 4673.7 4691.8 4584.4 4603.1 4641.4 4657.6 4657.7 4272.8 4340.1 4351.4 4358.0 4395.2 4202.4 4400.9 4417.1 4456.6 4460.0 4179.9 4244.0 4270.7 4272.0 4279.0 4335.7 4338.0 4344.9 4373.8 4383.6 4161.9 4330.0 4330.5 4336.8 4384.9 4515.8 4521.3 4533.7 4626.6 4646.6 5074.3 5086.3 5086.6 5107.8 5142.2 4824.7 5104.4 5114.8 5119.7 5128.5 4547.7 4599.8 4621.7 4645.9 4663.4 5183.7 5244.3 5246.4 5252.0 5297.4 4729.7 4991.3 5002.8 5012.6 5055.4 4905.7 4951.6 4974.2 4994.4 5018.6 5007.5 5028.1 5029.0 5033.7 5080.9 4776.4 4991.8 5000.8 5007.7 5061.3 4105.9 4164.9 4170.5 4183.6 4214.5 3681.1 3703.8 3720.7 3721.9 3761.2 4113.8 4328.8 4335.2 4336.3 4371.8 4913.3 4955.6 4970.5 5064.1 5077.4 4266.5 4285.7 4288.2 4292.6 4331.7 4447.2 4449.0 4450.5 4453.7 4511.1 4605.1 4676.5 4723.2 4725.7 4733.7 5112.2 5113.9 5116.2 5120.1 5157.2 4827.5 4828.5 4832.7 4835.3 4877.0 4820.3 4933.8 5032.5 5034.3 5080.3 4951.4 4977.0 5020.2 5038.6 5070.7 4947.3 4977.2 4979.0 4981.8 5016.7 4717.0 4910.7 4920.7 4971.6 5011.9 4767.9 4791.2 4868.2 4877.0 4897.3 4938.2 4966.0 4971.5 4973.2 5017.3 4659.1 4825.7 4850.0 4852.1 4910.0 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38311.08 Median:29795.50 stddev:59014.78 (198.1%) stddev-sans-first:59112.34 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: Values: 580.3 582.6 583.6 585.6 595.3 27127.7 27622.7 27658.0 32747.8 34251.1 39051.4 39542.2 39650.6 39677.0 39786.8 7749.9 7883.9 7920.4 7920.8 7922.7 7193.5 7384.1 10017.4 10270.7 10277.7 10094.3 10187.4 10200.4 10201.2 10207.7 7230.3 7426.1 10008.5 10118.7 10127.1 9872.4 10044.4 10084.8 10087.9 10090.2 36719.0 37227.0 37241.8 37291.4 37312.0 2843.8 3544.5 3638.8 3659.8 3714.8 28566.7 28802.0 29002.7 29448.7 29640.3 3238.9 3249.9 3311.4 3352.6 3418.6 207787.0 207829.0 207842.0 208052.0 208329.0 45317.8 46345.3 46413.3 59833.4 61134.0 54110.5 54143.0 54291.4 54353.5 54381.5 13014.3 13235.6 13305.7 13306.4 13317.9 9615.0 9732.3 9752.0 9859.8 9861.3 18438.3 18587.7 18634.4 18691.8 18762.5 7459.8 7678.2 7855.3 7859.8 7914.7 756.6 780.7 907.5 964.3 1053.8 25488.4 25528.5 26682.5 28779.0 29849.9 868.1 890.7 898.5 919.4 919.5 13160.1 13289.3 13305.3 13430.4 13465.3 260443.0 262738.0 264351.0 264590.0 264840.0 44777.6 45050.5 45058.5 45077.5 45119.3 1182.4 1186.5 1194.9 1220.1 1238.9 21301.4 24571.4 25070.0 25229.6 28442.3 36505.3 36903.3 36921.0 36932.4 36964.6 199447.0 199971.0 200101.0 200454.0 225217.0 22775.4 28560.0 28784.4 28953.8 29000.1 33194.7 38516.4 39122.6 39706.0 39750.6 29796.0 29796.6 30102.8 31919.2 33367.7 29208.3 29604.1 29660.3 29744.9 29795.0 29162.6 29509.3 29734.7 29786.4 29807.0 26398.3 29174.7 29269.3 29881.3 29918.3 22804.5 22946.2 22983.2 23053.2 23332.9 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25238.32 Median:4254.34 stddev:76294.09 (1793.3%) stddev-sans-first:76485.19 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: Values: 333.7 336.9 337.4 337.6 337.9 12515.5 12995.4 14933.8 15305.6 15869.8 8836.3 11421.9 11451.8 12946.0 14876.7 4507.6 4653.9 4656.8 4662.4 4910.7 3489.6 3584.7 4978.6 5080.3 5250.4 5163.2 5212.7 5218.3 5234.7 5238.9 5160.3 5201.0 5660.1 5663.5 5667.6 5019.0 5022.4 5026.7 5030.7 5031.3 10989.7 11377.6 11382.8 11394.0 11608.7 1756.2 1819.8 1863.9 1871.6 1883.2 8550.9 8936.4 9177.8 10659.5 12996.2 1629.6 1703.9 1715.3 1733.6 1744.9 50885.0 53709.5 55328.4 55730.2 56602.4 9820.9 9836.2 9856.3 9873.9 9911.0 12489.5 12516.1 12519.7 12527.6 12530.3 6652.5 6729.2 6782.8 6817.7 6828.4 6350.7 6473.8 6530.8 6572.4 6575.7 4162.2 4210.1 4228.8 4250.0 4258.7 1635.4 1652.6 1684.8 1690.8 1732.4 745.1 799.4 893.8 909.7 970.7 15239.2 15659.0 15783.6 16016.5 16085.7 731.7 763.5 775.6 801.9 906.4 8676.4 8783.3 8876.1 9016.5 9165.9 456799.0 465865.0 467413.0 470577.0 475136.0 60768.7 61824.7 62462.7 65094.7 73605.3 949.3 1008.9 1013.1 1018.4 1020.6 13918.3 13993.7 13997.5 14111.7 14198.0 30405.5 30486.7 31088.0 31403.5 31502.7 45630.3 45653.5 46613.8 48810.8 48869.5 8834.2 8857.9 9013.8 9039.8 9058.2 15585.7 15745.0 15798.8 15833.8 16355.1 13379.3 13548.7 13692.7 13757.8 13956.7 12717.0 12956.5 12987.5 13111.3 13306.9 10142.3 10545.2 11428.5 13134.5 13452.0 8542.8 8626.6 8653.9 8714.2 8731.6 12735.7 12872.4 12896.5 12991.2 13138.6 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,620 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4839.24 Median:6006.46 stddev:2488.16 (41.4%) stddev-sans-first:2479.94 19:33:04 INFO - 2015-12-11 19:33:04,621 DEBUG : BROWSER_OUTPUT: Values: 1180.9 1380.3 1398.9 1632.9 1720.9 6017.0 6769.6 6971.2 6973.2 6979.5 6885.8 7037.5 7038.0 7049.5 7066.7 1761.4 1795.4 1993.0 2034.0 2057.2 2095.9 2113.5 2117.1 2124.0 2125.9 2059.3 2072.9 2112.3 2118.9 2121.3 2052.7 2057.1 2076.5 2076.6 2080.5 2049.7 2080.1 2082.2 2084.0 2085.0 7001.9 7092.5 7094.5 7104.1 7109.9 4039.2 4061.3 4085.3 4107.3 4179.7 2677.8 2697.7 2704.1 2705.9 2708.7 807.6 811.9 822.2 851.0 853.2 8931.8 8940.9 8951.8 8973.9 8974.6 3747.1 3771.6 3893.6 3900.2 3908.6 7908.4 7916.5 7920.6 7928.0 7941.9 4163.7 4166.8 4174.1 4179.2 4196.4 3750.6 3769.7 3782.3 3787.8 3792.9 2975.6 3027.6 3263.7 3329.5 3356.9 1055.7 1057.2 1061.0 1062.2 1067.0 862.7 866.4 866.5 902.6 1143.8 6575.0 6617.4 6634.7 6669.7 6681.5 1058.6 1066.5 1070.6 1079.6 1085.7 5136.8 5141.1 5153.2 5189.0 5195.8 8094.5 8547.5 8607.4 8623.1 8651.5 8423.9 8428.9 8483.1 8511.7 8512.8 6492.7 6501.8 6694.4 6701.9 6709.3 6362.6 6387.4 6408.3 6409.6 6420.3 7475.3 7520.8 7667.7 7669.1 7674.7 7534.4 7687.2 7699.4 7704.4 7740.7 6011.4 6183.4 6261.4 6261.8 6265.4 5555.3 5617.6 6185.0 6328.8 6571.7 5975.6 6040.2 6085.2 6117.9 6150.3 5967.4 6001.5 6037.8 6077.1 6196.2 6090.1 6173.3 6176.5 6188.2 6207.8 5578.4 5602.1 5603.9 5621.2 5635.3 5837.2 5852.0 5852.5 5865.1 5871.8 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4672.91 Median:5316.61 stddev:1372.39 (25.8%) stddev-sans-first:1336.49 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: Values: 304.0 304.6 307.8 308.4 310.1 5247.7 5321.3 5354.8 5374.8 5412.1 5289.4 5300.7 5303.0 5307.3 5312.8 3970.6 4181.9 4183.4 4186.6 4196.1 4062.9 4064.3 4140.2 4181.6 4185.6 4127.7 4131.0 4136.5 4146.2 4152.7 3909.2 4008.9 4010.2 4121.8 4138.9 3651.3 3677.1 3677.6 3679.5 3687.3 5117.9 5119.6 5119.6 5122.9 5124.9 4792.9 4810.1 4810.4 4814.1 4814.4 5483.6 5629.9 5636.9 5639.0 5655.5 4004.2 4015.2 4015.5 4015.9 4017.7 5880.9 5912.6 5925.9 5928.1 5930.6 4136.5 4143.7 4145.6 4148.1 4149.9 3949.2 4115.1 4206.6 4206.9 4208.1 4657.4 4663.6 4669.1 4669.7 4691.4 5570.5 5577.1 5583.3 5583.7 5614.9 1417.5 1445.6 1446.7 1447.1 1447.1 961.5 968.0 972.2 987.3 990.5 4908.5 4911.4 4929.7 4931.3 4933.3 5801.7 5838.2 5846.2 5856.2 5866.3 4929.6 4936.7 4943.1 4945.1 4947.1 2897.8 3018.1 3108.1 3118.4 3152.4 5550.2 5556.4 5558.7 5560.1 5563.5 6043.8 6045.0 6060.5 6068.4 6068.8 5500.5 5530.6 5532.3 5550.0 5559.6 5731.3 5869.9 5901.7 5910.8 5913.7 5747.1 5749.7 5753.1 5757.5 5764.6 5543.3 5548.0 5550.8 5555.6 5557.3 3902.6 4034.6 4061.8 4073.1 4081.6 5816.8 5842.1 5848.3 5850.0 5853.3 5594.1 5607.4 5618.0 5623.1 5627.7 5609.7 5616.9 5619.0 5621.3 5626.6 5357.5 5485.4 5494.0 5495.4 5500.4 5603.4 5605.4 5606.6 5650.4 5651.9 5320.4 5391.5 5486.1 5490.8 5554.2 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11856.28 Median:44400.45 stddev:13200.86 (29.7%) stddev-sans-first:13211.02 19:33:04 INFO - 2015-12-11 19:33:04,622 DEBUG : BROWSER_OUTPUT: Values: 640.2 668.9 704.7 713.6 747.0 10399.9 10578.4 10595.9 10636.2 10668.3 11641.2 11728.5 11733.4 13171.8 13307.1 630.6 637.7 811.9 812.2 826.6 811.7 819.9 821.5 826.5 826.7 852.3 859.8 860.1 861.5 861.9 653.8 662.5 849.5 873.3 874.1 618.4 618.5 622.7 623.9 624.3 11449.9 11750.6 11759.6 11775.5 11777.0 10599.5 10754.9 11115.7 11586.5 11730.9 9364.5 9462.4 9560.3 9574.4 9684.4 3091.6 3105.8 3181.0 3211.1 3225.3 38612.0 39027.4 39364.6 39377.8 39382.2 9451.9 9516.4 9558.3 9631.8 9682.9 16556.3 16693.4 16733.2 16742.9 16756.8 6560.3 6581.0 6647.6 6738.7 6795.0 3525.5 3577.2 3596.4 3618.3 3695.3 2672.6 2680.8 2687.5 2688.9 2691.1 463.2 486.4 494.3 501.5 501.8 524.7 531.6 531.9 537.7 541.9 6922.5 7218.7 7270.7 7299.5 7523.7 370.4 417.3 547.4 551.5 569.6 3063.4 3462.7 3694.5 3701.9 3770.9 45598.8 46074.0 46458.0 46528.0 46959.3 41575.0 41603.0 41744.0 43197.6 43202.1 38769.6 40099.0 40219.8 40379.6 40662.6 6817.9 6850.3 6908.7 6909.4 7091.3 28851.7 29882.0 29999.3 30378.5 30850.4 37326.6 37839.0 38205.4 38603.0 38834.6 9276.6 9511.8 9753.1 9819.3 9962.0 10952.0 11174.5 11208.9 11276.5 11657.9 9892.9 10069.2 10299.1 10632.9 10657.7 10264.6 10279.9 10327.8 10328.6 10566.4 10041.3 10096.6 10328.4 10414.7 10577.2 8124.7 8666.7 8698.1 8780.2 8980.3 8880.9 8899.2 8943.0 8997.0 9190.2 19:33:04 INFO - 2015-12-11 19:33:04,623 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:33:04 INFO - 2015-12-11 19:33:04,623 DEBUG : BROWSER_OUTPUT: 19:33:05 INFO - 2015-12-11 19:33:05,289 INFO : Browser exited with error code: 0 19:33:05 INFO - 2015-12-11 19:33:05,313 INFO : Completed test dromaeo_css (00:18:37) 19:33:05 INFO - 2015-12-11 19:33:05,313 INFO : Starting test kraken 19:33:05 INFO - 2015-12-11 19:33:05,313 DEBUG : operating with platform_type : linux_ 19:33:05 INFO - 2015-12-11 19:33:05,313 INFO : Initialising browser for kraken test... 19:33:05 INFO - 2015-12-11 19:33:05,319 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUzCJP/profile http://localhost:37947/getInfo.html 19:33:09 INFO - 2015-12-11 19:33:09,643 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:33:09 INFO - 2015-12-11 19:33:09,643 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:33:09 INFO - 2015-12-11 19:33:09,643 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:33:09 INFO - 2015-12-11 19:33:09,643 DEBUG : BROWSER_OUTPUT: __metrics 19:33:09 INFO - 2015-12-11 19:33:09,699 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] 19:33:09 INFO - 2015-12-11 19:33:09,755 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] 19:33:09 ERROR - 2015-12-11 19:33:09,763 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:33:10 INFO - 2015-12-11 19:33:10,689 INFO : Browser initialized. 19:33:10 INFO - 2015-12-11 19:33:10,689 INFO : Running cycle 1/1 for kraken test... 19:33:10 INFO - 2015-12-11 19:33:10,690 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUzCJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:33:22 INFO - 2015-12-11 19:33:22,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 142426112 19:33:22 INFO - 2015-12-11 19:33:22,749 DEBUG : BROWSER_OUTPUT: 19:33:25 INFO - 2015-12-11 19:33:25,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37947/tests/kraken/driver.html?testName=audio-beat-detection) 19:33:25 INFO - 2015-12-11 19:33:25,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 181153792 19:33:25 INFO - 2015-12-11 19:33:25,939 DEBUG : BROWSER_OUTPUT: 19:33:28 INFO - 2015-12-11 19:33:28,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37947/tests/kraken/driver.html?testName=audio-dft) 19:33:29 INFO - 2015-12-11 19:33:29,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 171020288 19:33:29 INFO - 2015-12-11 19:33:29,303 DEBUG : BROWSER_OUTPUT: 19:33:32 INFO - 2015-12-11 19:33:32,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37947/tests/kraken/driver.html?testName=audio-fft) 19:33:32 INFO - 2015-12-11 19:33:32,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 153763840 19:33:32 INFO - 2015-12-11 19:33:32,884 DEBUG : BROWSER_OUTPUT: 19:33:34 INFO - 2015-12-11 19:33:34,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37947/tests/kraken/driver.html?testName=audio-oscillator) 19:33:35 INFO - 2015-12-11 19:33:35,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 155500544 19:33:35 INFO - 2015-12-11 19:33:35,502 DEBUG : BROWSER_OUTPUT: 19:33:37 INFO - 2015-12-11 19:33:37,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:33:38 INFO - 2015-12-11 19:33:38,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 156868608 19:33:38 INFO - 2015-12-11 19:33:38,328 DEBUG : BROWSER_OUTPUT: 19:33:41 INFO - 2015-12-11 19:33:41,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37947/tests/kraken/driver.html?testName=imaging-darkroom) 19:33:41 INFO - 2015-12-11 19:33:41,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 157106176 19:33:41 INFO - 2015-12-11 19:33:41,881 DEBUG : BROWSER_OUTPUT: 19:33:45 INFO - 2015-12-11 19:33:45,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37947/tests/kraken/driver.html?testName=imaging-desaturate) 19:33:45 INFO - 2015-12-11 19:33:45,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 158007296 19:33:45 INFO - 2015-12-11 19:33:45,872 DEBUG : BROWSER_OUTPUT: 19:33:48 INFO - 2015-12-11 19:33:48,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37947/tests/kraken/driver.html?testName=json-parse-financial) 19:33:49 INFO - 2015-12-11 19:33:49,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 159289344 19:33:49 INFO - 2015-12-11 19:33:49,333 DEBUG : BROWSER_OUTPUT: 19:33:51 INFO - 2015-12-11 19:33:51,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:51 INFO - 2015-12-11 19:33:51,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 166592512 19:33:51 INFO - 2015-12-11 19:33:51,674 DEBUG : BROWSER_OUTPUT: 19:33:53 INFO - 2015-12-11 19:33:53,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:54 INFO - 2015-12-11 19:33:54,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 167280640 19:33:54 INFO - 2015-12-11 19:33:54,146 DEBUG : BROWSER_OUTPUT: 19:33:56 INFO - 2015-12-11 19:33:56,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:56 INFO - 2015-12-11 19:33:56,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 180350976 19:33:56 INFO - 2015-12-11 19:33:56,828 DEBUG : BROWSER_OUTPUT: 19:33:59 INFO - 2015-12-11 19:33:59,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:59 INFO - 2015-12-11 19:33:59,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 184467456 19:33:59 INFO - 2015-12-11 19:33:59,924 DEBUG : BROWSER_OUTPUT: 19:34:02 INFO - 2015-12-11 19:34:02,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:34:03 INFO - 2015-12-11 19:34:03,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 182239232 19:34:03 INFO - 2015-12-11 19:34:03,133 DEBUG : BROWSER_OUTPUT: 19:34:04 INFO - 2015-12-11 19:34:04,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37947/tests/kraken/driver.html?testName=ai-astar) 19:34:05 INFO - 2015-12-11 19:34:05,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 241000448 19:34:05 INFO - 2015-12-11 19:34:05,153 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,153 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:34:05 INFO - 2015-12-11 19:34:05,153 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:34:05 INFO - 2015-12-11 19:34:05,154 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:34:05 INFO - 2015-12-11 19:34:05,154 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:34:05 INFO - 2015-12-11 19:34:05,154 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;108;113;112;112;102;112;111;111 19:34:05 INFO - 2015-12-11 19:34:05,154 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;130;158;170;130;152;153;137;173;133 19:34:05 INFO - 2015-12-11 19:34:05,155 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;163;159;162;161;161;163;162 19:34:05 INFO - 2015-12-11 19:34:05,155 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;86;99;72;73;73;99;92;72 19:34:05 INFO - 2015-12-11 19:34:05,155 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;131;96;95;96;136;94;94;128 19:34:05 INFO - 2015-12-11 19:34:05,155 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;110;109;111;109 19:34:05 INFO - 2015-12-11 19:34:05,156 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;149;147;147;147;147;147;148 19:34:05 INFO - 2015-12-11 19:34:05,157 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 19:34:05 INFO - 2015-12-11 19:34:05,157 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;71;72;71;71;79;68;69 19:34:05 INFO - 2015-12-11 19:34:05,157 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;69;69;69;68;69;69 19:34:05 INFO - 2015-12-11 19:34:05,157 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;85;84;84;86;85;84;87;84 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;124;125;125;118;117;126;119;127;120 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;136;160;162;145;136;151;145;146;137 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;71;68;71;70;70;70;68;70 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 19:34:05 INFO - 2015-12-11 19:34:05,158 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:34:05 INFO - 2015-12-11 19:34:05,159 DEBUG : BROWSER_OUTPUT: __startTimestamp1449891245152__endTimestamp 19:34:05 INFO - 2015-12-11 19:34:05,159 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 108.0 113.0 112.0 112.0 102.0 112.0 111.0 111.0 19:34:05 INFO - 2015-12-11 19:34:05,166 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.50 stddev:16.28 (10.5%) stddev-sans-first:16.74 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: Values: 161.0 130.0 158.0 170.0 130.0 152.0 153.0 137.0 173.0 133.0 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 163.0 159.0 162.0 161.0 161.0 163.0 162.0 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:79.50 stddev:11.69 (14.7%) stddev-sans-first:11.92 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 86.0 99.0 72.0 73.0 73.0 99.0 92.0 72.0 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.76 (18.7%) stddev-sans-first:18.46 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 131.0 96.0 95.0 96.0 136.0 94.0 94.0 128.0 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 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 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 111.0 109.0 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,167 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 148.0 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:2.92 (4.1%) stddev-sans-first:3.09 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 71.0 72.0 71.0 71.0 79.0 68.0 69.0 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 69.0 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 85.0 84.0 84.0 86.0 85.0 84.0 87.0 84.0 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:125.00 stddev:3.88 (3.1%) stddev-sans-first:3.81 19:34:05 INFO - 2015-12-11 19:34:05,168 DEBUG : BROWSER_OUTPUT: Values: 127.0 124.0 125.0 125.0 118.0 117.0 126.0 119.0 127.0 120.0 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:145.50 stddev:9.87 (6.8%) stddev-sans-first:9.74 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 160.0 162.0 145.0 136.0 151.0 145.0 146.0 137.0 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.29 (1.8%) stddev-sans-first:1.17 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 68.0 71.0 70.0 70.0 70.0 68.0 70.0 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:34:05 INFO - 2015-12-11 19:34:05,169 DEBUG : BROWSER_OUTPUT: 19:34:06 INFO - 2015-12-11 19:34:06,061 INFO : Browser exited with error code: 0 19:34:06 INFO - 2015-12-11 19:34:06,115 INFO : Completed test kraken (00:01:00) 19:34:06 INFO - 2015-12-11 19:34:06,115 INFO : Starting test v8_7 19:34:06 INFO - 2015-12-11 19:34:06,115 DEBUG : operating with platform_type : linux_ 19:34:06 INFO - 2015-12-11 19:34:06,115 INFO : Initialising browser for v8_7 test... 19:34:06 INFO - 2015-12-11 19:34:06,121 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQUjMo/profile http://localhost:37947/getInfo.html 19:34:10 INFO - 2015-12-11 19:34:10,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:34:10 INFO - 2015-12-11 19:34:10,278 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:34:10 INFO - 2015-12-11 19:34:10,278 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:34:10 INFO - 2015-12-11 19:34:10,278 DEBUG : BROWSER_OUTPUT: __metrics 19:34:10 INFO - 2015-12-11 19:34:10,382 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] 19:34:10 INFO - 2015-12-11 19:34:10,443 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] 19:34:11 INFO - 2015-12-11 19:34:11,641 INFO : Browser initialized. 19:34:11 INFO - 2015-12-11 19:34:11,642 INFO : Running cycle 1/1 for v8_7 test... 19:34:11 INFO - 2015-12-11 19:34:11,642 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQUjMo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:34:23 INFO - 2015-12-11 19:34:23,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 143220736 19:34:23 INFO - 2015-12-11 19:34:23,653 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37947/tests/v8_7/run.html (next: http://localhost:37947/tests/v8_7/run.html) 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 433434624 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:34:45 INFO - 2015-12-11 19:34:45,284 DEBUG : BROWSER_OUTPUT: |0;Richards;168.94745734076702 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5284.210526315789 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |5;Earley;793.8144329896908 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |6;Boyer;12035.714285714286 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 19:34:45 INFO - 2015-12-11 19:34:45,285 DEBUG : BROWSER_OUTPUT: |8;Splay;595.0118764845606 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1449891285277__endTimestamp 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,286 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.95 Median:168.95 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: Values: 168.9 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: Values: 186.2 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: Values: 278.4 19:34:45 INFO - 2015-12-11 19:34:45,287 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: Values: 5284.2 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: Values: 1980.2 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,288 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.81 Median:793.81 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: Values: 793.8 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12035.71 Median:12035.71 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: Values: 12035.7 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: Values: 27081.1 19:34:45 INFO - 2015-12-11 19:34:45,289 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.01 Median:595.01 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: Values: 595.0 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: Values: 4845.4 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:34:45 INFO - 2015-12-11 19:34:45,290 DEBUG : BROWSER_OUTPUT: 19:34:46 INFO - 2015-12-11 19:34:46,189 INFO : Browser exited with error code: 0 19:34:46 INFO - 2015-12-11 19:34:46,206 INFO : Completed test v8_7 (00:00:40) 19:34:46 INFO - 2015-12-11 19:34:46,340 INFO : Completed test suite (00:20:18) 19:34:46 INFO - 2015-12-11 19:34:46,340 DEBUG : Working with test: dromaeo_css 19:34:46 INFO - 2015-12-11 19:34:46,340 DEBUG : Generating results file: dromaeo_css 19:34:46 INFO - 2015-12-11 19:34:46,341 DEBUG : Working with test: kraken 19:34:46 INFO - 2015-12-11 19:34:46,341 DEBUG : Generating results file: kraken 19:34:46 INFO - 2015-12-11 19:34:46,342 INFO : javascript benchmark 19:34:46 INFO - 2015-12-11 19:34:46,342 DEBUG : Working with test: v8_7 19:34:46 INFO - 2015-12-11 19:34:46,342 DEBUG : Generating results file: v8_7 19:34:46 INFO - 2015-12-11 19:34:46,342 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:34:46 INFO - 2015-12-11 19:34:46,397 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 19:34:46 INFO - 2015-12-11 19:34:46,397 DEBUG : process_Request line: dromaeo_css 6208.93 graph.html#tests=[[72,132,35]] 19:34:46 INFO - 2015-12-11 19:34:46,397 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:34:46 INFO - 2015-12-11 19:34:46,445 DEBUG : process_Request line: kraken 1523.80 graph.html#tests=[[232,132,35]] 19:34:46 INFO - 2015-12-11 19:34:46,445 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:34:46 INFO - 2015-12-11 19:34:46,469 DEBUG : process_Request line: v8_7 19768.53 graph.html#tests=[[230,132,35]] 19:34:46 INFO - 2015-12-11 19:34:46,471 INFO : javascript benchmark 19:34:46 INFO - 2015-12-11 19:34:46,474 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.790096792257, 2720.156751407064, 2720.7415295546916, 2736.3706347540065, 2737.178846346096, 4527.185106680796, 4645.628349732022, 4653.813847446107, 4673.672842900998, 4691.835785747499, 4584.449866016074, 4603.148417542757, 4641.350210970467, 4657.55753203446, 4657.673962822604, 4272.7863606819765, 4340.1102773931425, 4351.434313539251, 4357.956420435787, 4395.186890425265, 4202.432671589342, 4400.911981760363, 4417.094495628405, 4456.554344565534, 4460.0, 4179.853705120307, 4244.0, 4270.743755374688, 4272.01743598974, 4278.951656844078, 4335.7181783184, 4338.045629961435, 4344.891377715582, 4373.781310934441, 4383.561643835623, 4161.91676166475, 4330.004099057203, 4330.480342358937, 4336.761478118702, 4384.868453946387, 4515.796789144496, 4521.344405061281, 4533.659975501851, 4626.606738427237, 4646.558576935186, 5074.264231686385, 5086.338775959101, 5086.64393492452, 5107.770150343244, 5142.151544995108, 4824.734639594821, 5104.387473503203, 5114.795408183705, 5119.718415487147, 5128.487151284879, 4547.704399214107, 4599.839005634787, 4621.676482646216, 4645.88385290367, 4663.417072865892, 5183.663061900965, 5244.29202057725, 5246.422893481714, 5252.0, 5297.364316282071, 4729.716217026989, 4991.326170966946, 5002.774875130628, 5012.598992080625, 5055.368078990126, 4905.656604037683, 4951.554360107608, 4974.179260422062, 4994.350734404504, 5018.573421259161, 5007.549320561167, 5028.145215313405, 5028.974855125774, 5033.697978121324, 5080.872978175501, 4776.379070720784, 4991.80032798684, 5000.774965126578, 5007.69953802773, 5061.31672224245, 4105.8973525662095, 4164.895877603023, 4170.4995400551525, 4183.560726123774, 4214.536400995888, 3681.0981309578788, 3703.7962912039557, 3720.720945929066, 3721.9441708374397, 3761.1725420407465, 4113.814878330422, 4328.783560821947, 4335.2196604610845, 4336.306191009423, 4371.781410929504, 4913.31213630092, 4955.628327875424, 4970.453250142481, 5064.139096353629, 5077.441481437039, 4266.466691663542, 4285.678574106954, 4288.163808057461, 4292.570742925683, 4331.696781225347, 4447.177272204653, 4448.955510444919, 4450.488193857683, 4453.665975051884, 4511.097780443924, 4605.0559635274685, 4676.462206846256, 4723.220668589782, 4725.716457012591, 4733.739644319596, 5112.182050871843, 5113.897722045613, 5116.15583428745, 5120.129577971679, 5157.200633901752, 4827.468978412442, 4828.493008234085, 4832.685875418087, 4835.323054772405, 4877.0, 4820.276958456259, 4933.753312334297, 5032.521910418504, 5034.295198672262, 5080.314157588826, 4951.3810773653295, 4977.0294792515115, 5020.221865610836, 5038.571721403721, 5070.721110338819, 4947.332110165082, 4977.228529577921, 4978.975105124451, 4981.775820088033, 5016.749162541785, 4717.0, 4910.705357678551, 4920.6555541111775, 4971.627127965345, 5011.949880501148, 4767.880802979953, 4791.185498465339, 4868.245421959602, 4877.0, 4897.289892965428, 4938.209886418156, 4965.975170124127, 4971.453140154653, 4973.154563724248, 5017.297578339108, 4659.068186362809, 4825.662203645711, 4850.0, 4852.126617208936, 4909.95090049095], "unit": "ms", "name": "dojo.html", "value": 4612.9390663475415}, {"lowerIsBetter": false, "replicates": [580.2978396140669, 582.606740450196, 583.614814222613, 585.5842351930129, 595.3183604772536, 27127.728722712767, 27622.71847863582, 27658.0, 32747.83626081866, 34251.143721406916, 39051.41422878659, 39542.20915581687, 39650.60349396505, 39677.0, 39786.8010659947, 7749.9225007749765, 7883.881741773878, 7920.445568810185, 7920.762377128695, 7922.722704705337, 7193.496455248135, 7384.113906331248, 10017.449040302781, 10270.7432314192, 10277.691669249896, 10094.343867648578, 10187.388756674623, 10200.387976721384, 10201.183905287597, 10207.744806379826, 7230.349268565854, 7426.108866935948, 10008.549615267295, 10118.747031324203, 10127.13919316859, 9872.35829671069, 10044.397336159855, 10084.798304033879, 10087.949560252226, 10090.192784577217, 36719.0, 37227.0, 37241.81379093114, 37291.4406283906, 37312.0, 2843.8009339346254, 3544.503769472276, 3638.818059097061, 3659.762115462513, 3714.7771133731794, 28566.714332856613, 28802.0, 29002.70997290021, 29448.70551294481, 29640.258993525335, 3238.91902702432, 3249.8862539810993, 3311.3708395405038, 3352.6312105668358, 3418.5555877735737, 207787.0, 207829.0, 207842.0, 208052.0, 208329.0, 45317.77341113339, 46345.30482042772, 46413.30380044302, 59833.40166598278, 61134.0, 54110.45889541133, 54143.0, 54291.371258862295, 54353.45646543563, 54381.45618543764, 13014.284214368112, 13235.602931912059, 13305.733885322239, 13306.401211945486, 13317.866821331856, 9614.95192524047, 9732.318737688294, 9752.024797520191, 9859.802803943881, 9861.309708320348, 18438.26246950107, 18587.721184182246, 18634.440966771017, 18691.813081869008, 18762.530936726693, 7459.776206713807, 7678.155402905676, 7855.332296754726, 7859.764207073797, 7914.722984695623, 756.5687558091945, 780.6916268074192, 907.4691305586174, 964.3056998960737, 1053.7629033467408, 25488.362790930376, 25528.48943021129, 26682.466350673265, 28779.0, 29849.850750746107, 868.1058509734983, 890.7105190812882, 898.4609234459402, 919.4437365393974, 919.5494207838245, 13160.100586756138, 13289.335533223493, 13305.334733263491, 13430.395632196574, 13465.326733663278, 260443.0, 262738.0, 264351.0, 264590.0, 264840.0, 44777.55222447799, 45050.54949450464, 45058.54941450609, 45077.54922450799, 45119.32321015187, 1182.3615247766281, 1186.5135294529375, 1194.8805119487981, 1220.0666490135054, 1238.8575313838844, 21301.36095917125, 24571.38571535726, 25070.0, 25229.621555676313, 28442.288942776595, 36505.26989460249, 36903.26193476169, 36921.0, 36932.44601331036, 36964.63035369612, 199447.0, 199971.0, 200101.0, 200454.0, 225217.0, 22775.430614234116, 28560.0, 28784.42431151407, 28953.84184632591, 29000.12999610015, 33194.66805332012, 38516.42225366566, 39122.608773911896, 39706.0, 39750.60249397585, 29796.0, 29796.553051704675, 30102.84948575243, 31919.202019949687, 33367.66632333743, 29208.26979325534, 29604.111876643736, 29660.25849353697, 29744.851275743484, 29795.0, 29162.56256156202, 29509.26226844346, 29734.702652973192, 29786.404271914875, 29807.0, 26398.340041498348, 29174.7082529172, 29269.268268293465, 29881.252968675955, 29918.25204369908, 22804.543909122058, 22946.196883109013, 22983.195588154333, 23053.21002546541, 23332.883335583214], "unit": "ms", "name": "ext.html", "value": 16642.623593607866}, {"lowerIsBetter": false, "replicates": [333.7296789600425, 336.9157710572357, 337.4027970492229, 337.5561137104707, 337.8800525813336, 12515.499380024788, 12995.415206315714, 14933.775993360096, 15305.617359566017, 15869.761953570705, 8836.33727470439, 11421.885781142186, 11451.770964580703, 12946.029047821428, 14876.702465950702, 4507.594316511513, 4653.930191047137, 4656.767161641921, 4662.393888794469, 4910.680805747633, 3489.5638045244345, 3584.6953008994265, 4978.576820970222, 5080.339555857733, 5250.422453530108, 5163.225516172585, 5212.713300768456, 5218.32161818963, 5234.685918844882, 5238.895222095556, 5160.277561141444, 5201.0, 5660.094384898396, 5663.5186009189265, 5667.631603945731, 5019.0, 5022.42242142151, 5026.723530205837, 5030.698158110525, 5031.345925029759, 10989.670309890716, 11377.601783937605, 11382.772344553063, 11394.031507321888, 11608.709782255426, 1756.2360373237682, 1819.8362147406797, 1863.8695291329611, 1871.6069625378686, 1883.1525813383896, 8550.871736923951, 8936.374453788238, 9177.816443671156, 10659.467026648637, 12996.220226786423, 1629.5600187949306, 1703.8977661340236, 1715.3138744502173, 1733.5752740578512, 1744.9309755161278, 50885.0, 53709.462905370834, 55328.44671553273, 55730.16404753972, 56602.43397566054, 9820.901790982141, 9836.213102951746, 9856.260780441495, 9873.901260987443, 9910.950445247727, 12489.50041998328, 12516.12387132892, 12519.687007824696, 12527.624171274876, 12530.310832904277, 6652.467802575782, 6729.158855143107, 6782.796516104525, 6817.659117044227, 6828.419584335288, 6350.745970161234, 6473.805785826433, 6530.771423000172, 6572.441342485942, 6575.704093315812, 4162.188373267184, 4210.136921930997, 4228.830846766156, 4250.0, 4258.68059895509, 1635.3703824027598, 1652.6198974235754, 1684.7725557049887, 1690.8309169082993, 1732.3936622182136, 745.143085451724, 799.396455675961, 893.7854914820397, 909.6725178935578, 970.7136394763562, 15239.23803809805, 15659.0, 15783.605409864846, 16016.519504414886, 16085.678286434206, 731.6597782031381, 763.5380594740213, 775.5501808950795, 801.935845132388, 906.4334790755778, 8676.392652514263, 8783.25342345895, 8876.112388761072, 9016.504092274989, 9165.862512062324, 456799.0, 465865.0, 467413.0, 470577.0, 475136.0, 60768.69615651982, 61824.690876545326, 62462.68768656219, 65094.67452662707, 73605.26394736092, 949.2785483032944, 1008.9495525223709, 1013.123648044451, 1018.4296793795498, 1020.6478764826123, 13918.304084795922, 13993.720125597634, 13997.5100871469, 14111.717765644424, 14198.0, 30405.543916840823, 30486.695133049274, 31088.0, 31403.52894706627, 31502.684973150892, 45630.31554526618, 45653.54346456493, 46613.766931165126, 48810.755946220044, 48869.51130488792, 8834.249088827264, 8857.867131992896, 9013.819723605622, 9039.819203616022, 9058.230050445522, 15585.68828623444, 15745.0, 15798.76301855496, 15833.762493562375, 16355.100469474293, 13379.264140472367, 13548.729025419634, 13692.65768355799, 13757.79363309571, 13956.720865582834, 12717.0, 12956.546520871725, 12987.480500779862, 13111.27887966171, 13306.933465332611, 10142.340747851365, 10545.156387489136, 11428.542858285575, 13134.540291089766, 13452.0, 8542.846715693302, 8626.568671566522, 8653.870191947, 8714.215720585178, 8731.563421828756, 12735.74528509406, 12872.356382180666, 12896.548620798603, 12991.220526768424, 13138.605841824761], "unit": "ms", "name": "jquery.html", "value": 7950.109230018225}, {"lowerIsBetter": false, "replicates": [1180.9055275577955, 1380.2615600653646, 1398.8671076247758, 1632.942847000355, 1720.8623310135185, 6016.969915150424, 6769.627670478128, 6971.233164351917, 6973.198082220546, 6979.546329488579, 6885.758998435056, 7037.507374483788, 7038.0, 7049.471289653271, 7066.7173313067415, 1761.3659082730208, 1795.3985414885963, 1992.9800701993013, 2033.9694904576443, 2057.187410972665, 2095.905684244205, 2113.4927617371795, 2117.068489864462, 2123.957520849582, 2125.91496340147, 2059.258666879922, 2072.9378118656464, 2112.3451729963685, 2118.904649290778, 2121.2575598540466, 2052.7434070741156, 2057.094878253579, 2076.5431605046865, 2076.584683063386, 2080.4694802825184, 2049.7027930950076, 2080.147139672727, 2082.1567265257595, 2083.958320833575, 2084.9791502084936, 7001.894971575431, 7092.50352475327, 7094.503384763068, 7104.11198600175, 7109.928900710978, 4039.171969746195, 4061.2689715851134, 4085.2850751118435, 4107.281225785476, 4179.707420480568, 2677.772389346908, 2697.7167397423186, 2704.1211606228053, 2705.864706764654, 2708.729127087295, 807.64059993303, 811.8579248631524, 822.1819289806621, 850.974470765878, 853.185208126238, 8931.821363572757, 8940.8658870117, 8951.776205594848, 8973.910260897374, 8974.641014359418, 3747.0819649186124, 3771.585125636178, 3893.6106389361403, 3900.1809619979554, 3908.5895980921596, 7908.367330613537, 7916.525008499509, 7920.564368959763, 7927.960360198277, 7941.880871786928, 4163.687723420695, 4166.791660416967, 4174.08170202561, 4179.247735407595, 4196.3705444183615, 3750.587435382106, 3769.6984241260634, 3782.3002744491805, 3787.791671458041, 3792.943105853414, 2975.5834183214365, 3027.576139340494, 3263.6618986216013, 3329.500574913734, 3356.9496457553155, 1055.6674647486018, 1057.2229411382627, 1060.9920575453195, 1062.1927335225284, 1066.9519871605796, 862.7239283429242, 866.3891956170885, 866.4627930683017, 902.6118768929423, 1143.7712457508533, 6574.967125164344, 6617.437517810944, 6634.701438435282, 6669.699863506154, 6681.532292739462, 1058.640062378795, 1066.4934156275863, 1070.5824728355947, 1079.643717573199, 1085.733995171188, 5136.845894623168, 5141.074606570854, 5153.201253805666, 5189.040027594907, 5195.766190521435, 8094.51432914027, 8547.529885856338, 8607.397482176313, 8623.094575069654, 8651.52416617092, 8423.873641895254, 8428.915710842935, 8483.109273526314, 8511.74464766058, 8512.787180320542, 6492.740290388331, 6501.804945851632, 6694.397504224643, 6701.865962680817, 6709.329067093349, 6362.618242905441, 6387.361263873576, 6408.327125651926, 6409.615423074444, 6420.26166990802, 7475.327220550176, 7520.8495830082, 7667.731629393167, 7669.118051424158, 7674.731384401519, 7534.35957943581, 7687.154413014676, 7699.3840492761565, 7704.38364930793, 7740.651670674946, 6011.368806275453, 6183.412575805291, 6261.436470717657, 6261.812145635638, 6265.373462653698, 5555.30558680165, 5617.606767526398, 6184.969075154595, 6328.778492752916, 6571.704273307617, 5975.641461512149, 6040.244969378828, 6085.2393450818645, 6117.908231376622, 6150.261968563801, 5967.433093856077, 6001.549883758648, 6037.78867739627, 6077.149199112039, 6196.1635179250225, 6090.086487026982, 6173.32093469709, 6176.474999625082, 6188.164597779422, 6207.81376558704, 5578.386377498391, 5602.1036634138345, 5603.887922241451, 5621.156826476062, 5635.295588051494, 5837.211976383303, 5852.034414321589, 5852.5317974561085, 5865.061590145556, 5871.823845284648], "unit": "ms", "name": "mootools.html", "value": 3983.850236754879}, {"lowerIsBetter": false, "replicates": [303.9589655396521, 304.6496528991661, 307.78147515264163, 308.4032397311203, 310.10998434493, 5247.711375874325, 5321.308229930113, 5354.839354819352, 5374.838754837361, 5412.07994640911, 5289.418164001966, 5300.708461034642, 5303.0, 5307.283516725241, 5312.814051508198, 3970.622790834866, 4181.937270940938, 4183.435236243099, 4186.602272784081, 4196.118815048843, 4062.939055914164, 4064.2887494688457, 4140.213359461708, 4181.623653871151, 4185.560516145792, 4127.711060225785, 4130.979345103286, 4136.482939632546, 4146.232946904832, 4152.650388623694, 3909.2181563687377, 4008.8596899108684, 4010.1779135277197, 4121.752694838305, 4138.917221655565, 3651.2514934438377, 3677.1358730698266, 3677.5586929568353, 3679.5032670589394, 3687.3362794696945, 5117.8720531987, 5119.590432765407, 5119.616028797818, 5122.871928201825, 5124.897502049976, 4792.880177995543, 4810.110129625996, 4810.374651295344, 4814.109389762905, 4814.350062741555, 5483.616146869721, 5629.9437005629825, 5636.887262254773, 5638.971805140989, 5655.462731040586, 4004.199160167949, 4015.217032678629, 4015.4980627421573, 4015.8996025099314, 4017.678585713136, 5880.911786323209, 5912.6156799808305, 5925.851853703649, 5928.110783382484, 5930.614510056833, 4136.462259906253, 4143.6892233082635, 4145.585441455891, 4148.087420767426, 4149.937750933738, 3949.19041596472, 4115.135821477524, 4206.57934206583, 4206.8737937861915, 4208.116295577902, 4657.441107067174, 4663.603593694506, 4669.066186762661, 4669.696469729457, 4691.413573303337, 5570.470805273492, 5577.135543990688, 5583.274174357389, 5583.664980101125, 5614.933162699074, 1417.5392997275926, 1445.645816774897, 1446.7106578684304, 1447.073872721459, 1447.1389523233659, 961.5480724059821, 968.0, 972.1639390124487, 987.2644879564626, 990.4601991914424, 4908.509149085135, 4911.361523001987, 4929.679570827885, 4931.309616653672, 4933.333999910038, 5801.7099145042575, 5838.153467747153, 5846.181534585162, 5856.180134781134, 5866.325372582122, 4929.580985616263, 4936.679115857458, 4943.085529177114, 4945.085159245551, 4947.084789313988, 2897.8116422432895, 3018.0644000359957, 3108.1452600535035, 3118.4075025745037, 3152.385284869474, 5550.167474878801, 5556.388797232301, 5558.749856256478, 5560.110382338807, 5563.499285064364, 6043.848903777441, 6044.969775151184, 6060.515158787286, 6068.362821903725, 6068.848278792977, 5500.532454741312, 5530.6128570999645, 5532.336119665746, 5549.972250138723, 5559.555235581144, 5731.283589551306, 5869.853253668522, 5901.734421951109, 5910.822675319747, 5913.733881975236, 5747.051736463437, 5749.741261643152, 5753.079507278982, 5757.453041961007, 5764.625299355528, 5543.334799824047, 5548.0013597552825, 5550.806576586054, 5555.555555555465, 5557.277553917965, 3902.5902280260166, 4034.596540345942, 4061.756294622332, 4073.0631954650003, 4081.6122468365456, 5816.82549523515, 5842.065269556851, 5848.327442344185, 5850.034744267318, 5853.2976042875125, 5594.1049432092295, 5607.43925607436, 5617.9719101404235, 5623.072193088258, 5627.662340259598, 5609.74756135983, 5616.887662246814, 5619.044762390322, 5621.297337832771, 5626.578006649435, 5357.491038351351, 5485.369182543899, 5493.972530137324, 5495.368032676133, 5500.394956554695, 5603.35561410443, 5605.383407825218, 5606.551475881838, 5650.35020972577, 5651.943480565306, 5320.414754377093, 5391.4608539145775, 5486.1222204447095, 5490.752916118704, 5554.194641776839], "unit": "ms", "name": "prototype.html", "value": 4231.090829905328}, {"lowerIsBetter": false, "replicates": [640.2381166411969, 668.9364510371513, 704.7110684619307, 713.5611598866699, 746.973855915043, 10399.896001039988, 10578.36529808212, 10595.894041059588, 10636.20228482863, 10668.306560073599, 11641.243319184247, 11728.53085876564, 11733.354665493394, 13171.80242296364, 13307.135036222662, 630.5680608782975, 637.6875331087757, 811.8619834628098, 812.1878121878121, 826.6197549127409, 811.7037281392279, 819.9098099209082, 821.5153059694779, 826.4834478450969, 826.7478419082178, 852.3479538153317, 859.8452278589851, 860.1355637584219, 861.4615865084322, 861.8750281209221, 653.7646447278976, 662.499812641455, 849.452103393314, 873.3013589128735, 874.0865795243922, 618.3847072163181, 618.5082859127004, 622.6979914741347, 623.8565130020075, 624.2540164503421, 11449.942750286278, 11750.588729394516, 11759.647210583697, 11775.470103845348, 11777.0, 10599.523021464052, 10754.946225268903, 11115.666530004113, 11586.47860846264, 11730.88269117315, 9364.531773411301, 9462.432254064779, 9560.330776845623, 9574.377665451724, 9684.370515916513, 3091.5517249998848, 3105.7515398768046, 3180.984095079533, 3211.0848408203783, 3225.3388055448577, 38612.0, 39027.41458878119, 39364.606353936666, 39377.80311098455, 39382.21235575272, 9451.905480945103, 9516.429014259167, 9558.330916835755, 9631.759206019906, 9682.90317096834, 16556.254968526446, 16693.41573044962, 16733.163341833104, 16742.916285418494, 16756.832431675528, 6560.343965603402, 6581.045748366556, 6647.634380109141, 6738.696758645872, 6795.0, 3525.4888041233876, 3577.195131095483, 3596.442551404484, 3618.2582570572968, 3695.287320471128, 2672.5991101334566, 2680.812343135962, 2687.50281197979, 2688.892444302206, 2691.0715803047915, 463.2240996331132, 486.4260172995899, 494.29809670268304, 501.45842490110596, 501.8494451664486, 524.6904326447415, 531.619891777381, 531.912234481314, 537.7418838957244, 541.9024575576356, 6922.5154239202775, 7218.747343843045, 7270.745523906744, 7299.5255308404785, 7523.661435235427, 370.44803243167485, 417.30989492555636, 547.4170008940465, 551.4540604801218, 569.5671289819684, 3063.417950589381, 3462.722982161421, 3694.538182727159, 3701.8889433317045, 3770.9057273567832, 45598.77200614042, 46074.0, 46458.0, 46528.0, 46959.29561056518, 41575.0, 41603.0, 41744.0, 43197.56802431998, 43202.135957280676, 38769.61230387716, 40099.0, 40219.776923423204, 40379.59620403758, 40662.59337406647, 6817.863642727217, 6850.314968503109, 6908.654567271717, 6909.412699920563, 7091.2554181810165, 28851.7114828849, 29882.0, 29999.250018749706, 30378.544321834746, 30850.382992340477, 37326.626733732315, 37839.0, 38205.42691859569, 38603.0, 38834.6116538831, 9276.58255378523, 9511.762205944906, 9753.122219000325, 9819.312648114563, 9962.0, 10952.040796079107, 11174.497147628213, 11208.88791112111, 11276.548938042386, 11657.941710291394, 9892.901070989197, 10069.194464442973, 10299.124574411258, 10632.89367106319, 10657.680269591614, 10264.58941642326, 10279.897201028192, 10327.845082323622, 10328.638497652546, 10566.366018038942, 10041.297109202285, 10096.596136154472, 10328.380297182193, 10414.73963150897, 10577.153827693612, 8124.715634952749, 8666.739997800076, 8698.13018698125, 8780.209781119729, 8980.281577473917, 8880.86678699807, 8899.154580315118, 8943.0, 8997.0, 9190.218831399407], "unit": "ms", "name": "yui.html", "value": 5568.394995987286}], "name": "dromaeo_css", "value": 6208.935328022806}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 113.0, 112.0, 112.0, 102.0, 112.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 158.0, 170.0, 130.0, 152.0, 153.0, 137.0, 173.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 163.0, 159.0, 162.0, 161.0, 161.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 99.0, 72.0, 73.0, 73.0, 99.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 131.0, 96.0, 95.0, 96.0, 136.0, 94.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 72.0, 71.0, 71.0, 79.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 85.0, 84.0, 84.0, 86.0, 85.0, 84.0, 87.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 125.0, 125.0, 118.0, 117.0, 126.0, 119.0, 127.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [135.0, 136.0, 160.0, 162.0, 145.0, 136.0, 151.0, 145.0, 146.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 68.0, 71.0, 70.0, 70.0, 70.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1523.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.94745734076702], "unit": "score", "name": "Richards", "value": 208.952538}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [793.8144329896908], "unit": "score", "name": "Earley", "value": 839.5702727272724}, {"lowerIsBetter": false, "replicates": [12035.714285714286], "unit": "score", "name": "Boyer", "value": 55.37378041543021}, {"lowerIsBetter": false, "replicates": [27081.08108108108], "unit": "score", "name": "RegExp", "value": 33.63916666666665}, {"lowerIsBetter": false, "replicates": [595.0118764845606], "unit": "score", "name": "Splay", "value": 136.95693013972053}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19768.531541386514}]} 19:34:46 INFO - RETURN: dromaeo_css: 6208.93 19:34:46 INFO - RETURN: kraken: 1523.80 19:34:46 INFO - RETURN: v8_7: 19768.53 19:34:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19768.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6208.93"}}} 19:34:46 INFO - Return code: 0 19:34:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:34:46 ERROR - # TBPL SUCCESS # 19:34:46 INFO - Running post-action listener: _resource_record_post_action 19:34:46 INFO - Running post-run listener: _resource_record_post_run 19:34:47 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520007680; Read time: 12; Write time: 543592 19:34:47 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 242712576; Read time: 0; Write time: 379908 19:34:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276475904; Read time: 12; Write time: 163660 19:34:47 INFO - Running post-run listener: _upload_blobber_files 19:34:47 INFO - Blob upload gear active. 19:34:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:34:47 INFO - Copying logs to upload dir... 19:34:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.649303 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-11 19:34:47.367633) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 19:34:47.370774) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010188 build_url: 'https://queue.taskcluster.net/v1/task/47S_1bF8S6mrFVeGjHyccw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 19:34:47.426901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:34:47.427666) ========= 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=f5f5a079460e1a9be8676904000001c1-1449875050.11208-1326889142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 19:34:47.478283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 19:34:47.478620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 19:34:47.478941) ========= ========= Total master_lag: 0.31 =========