builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1449693024.54 results: success (0) buildid: 20151209115739 builduid: 94e1297d49474a9a8b6ff1fb9136d56f revision: 455af65081f54070206a8e38a512033311205282 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.538170) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.538579) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.538868) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.638298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.638596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.748528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.748843) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.806384) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.806659) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.807004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:24.807300) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 12:30:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.8M=0s 2015-12-09 12:30:26 (63.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.016167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.016507) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020204 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.073111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.073477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 455af65081f54070206a8e38a512033311205282 --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 455af65081f54070206a8e38a512033311205282 --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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 12:30:26,361 truncating revision to first 12 chars 2015-12-09 12:30:26,361 Setting DEBUG logging. 2015-12-09 12:30:26,361 attempt 1/10 2015-12-09 12:30:26,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/455af65081f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 12:30:26,621 unpacking tar archive at: fx-team-455af65081f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.634121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.634400) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.656552) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.656846) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 12:30:25.657253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-09 12:30:25.657691) ========= /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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:27 INFO - MultiFileLogger online at 20151209 12:30:27 in /builds/slave/test 12:30:27 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 12:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:27 INFO - {'append_to_log': False, 12:30:27 INFO - 'base_work_dir': '/builds/slave/test', 12:30:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:27 INFO - 'branch': 'Fx-Team-Non-PGO', 12:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:27 INFO - 'config_files': ('talos/linux_config.py',), 12:30:27 INFO - 'default_actions': ('clobber', 12:30:27 INFO - 'read-buildbot-config', 12:30:27 INFO - 'download-and-extract', 12:30:27 INFO - 'populate-webroot', 12:30:27 INFO - 'create-virtualenv', 12:30:27 INFO - 'install', 12:30:27 INFO - 'run-tests'), 12:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:27 INFO - 'download_minidump_stackwalk': True, 12:30:27 INFO - 'download_symbols': 'ondemand', 12:30:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:27 INFO - 'installer_path': 'installer.exe', 12:30:27 INFO - 'log_level': 'info', 12:30:27 INFO - 'log_name': 'talos', 12:30:27 INFO - 'log_to_console': True, 12:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:27 INFO - 'opt_config_files': (), 12:30:27 INFO - 'pip_index': False, 12:30:27 INFO - 'sps_profile': False, 12:30:27 INFO - 'sps_profile_interval': 0, 12:30:27 INFO - 'suite': 'dromaeojs', 12:30:27 INFO - 'system_bits': '64', 12:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:27 INFO - 'title': 'talos-linux64-ix-066', 12:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:27 INFO - 'use_talos_json': True, 12:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:27 INFO - 'work_dir': 'build'} 12:30:27 INFO - ##### 12:30:27 INFO - ##### Running clobber step. 12:30:27 INFO - ##### 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: clobber 12:30:27 INFO - rmtree: /builds/slave/test/build 12:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:27 INFO - Running post-action listener: _resource_record_post_action 12:30:27 INFO - ##### 12:30:27 INFO - ##### Running read-buildbot-config step. 12:30:27 INFO - ##### 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: read_buildbot_config 12:30:27 INFO - Using buildbot properties: 12:30:27 INFO - { 12:30:27 INFO - "properties": { 12:30:27 INFO - "buildnumber": 1186, 12:30:27 INFO - "product": "firefox", 12:30:27 INFO - "script_repo_revision": "production", 12:30:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:30:27 INFO - "repository": "", 12:30:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:30:27 INFO - "buildid": "20151209115739", 12:30:27 INFO - "slavename": "talos-linux64-ix-066", 12:30:27 INFO - "pgo_build": "False", 12:30:27 INFO - "basedir": "/builds/slave/test", 12:30:27 INFO - "project": "", 12:30:27 INFO - "platform": "ubuntu64_hw", 12:30:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:30:27 INFO - "slavebuilddir": "test", 12:30:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:30:27 INFO - "branch": "fx-team", 12:30:27 INFO - "repo_path": "integration/fx-team", 12:30:27 INFO - "stage_platform": "linux64", 12:30:27 INFO - "builduid": "94e1297d49474a9a8b6ff1fb9136d56f", 12:30:27 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:27 INFO - }, 12:30:27 INFO - "sourcestamp": { 12:30:27 INFO - "repository": "", 12:30:27 INFO - "hasPatch": false, 12:30:27 INFO - "project": "", 12:30:27 INFO - "branch": "fx-team-linux64-talos", 12:30:27 INFO - "changes": [ 12:30:27 INFO - { 12:30:27 INFO - "category": null, 12:30:27 INFO - "files": [ 12:30:27 INFO - { 12:30:27 INFO - "url": null, 12:30:27 INFO - "name": "https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:30:27 INFO - } 12:30:27 INFO - ], 12:30:27 INFO - "repository": "", 12:30:27 INFO - "rev": "455af65081f54070206a8e38a512033311205282", 12:30:27 INFO - "who": "edilee@gmail.com", 12:30:27 INFO - "when": 1449692961, 12:30:27 INFO - "number": 7175472, 12:30:27 INFO - "comments": "Bug 1213844 - Update Loop's user journey strings with final versions [r=mikedeboer]", 12:30:27 INFO - "project": "", 12:30:27 INFO - "at": "Wed 09 Dec 2015 12:29:21", 12:30:27 INFO - "branch": "fx-team-linux64-talos", 12:30:27 INFO - "revlink": "", 12:30:27 INFO - "properties": [ 12:30:27 INFO - [ 12:30:27 INFO - "buildid", 12:30:27 INFO - "20151209115739", 12:30:27 INFO - "Change" 12:30:27 INFO - ], 12:30:27 INFO - [ 12:30:27 INFO - "builduid", 12:30:27 INFO - "94e1297d49474a9a8b6ff1fb9136d56f", 12:30:27 INFO - "Change" 12:30:27 INFO - ], 12:30:27 INFO - [ 12:30:27 INFO - "pgo_build", 12:30:27 INFO - "False", 12:30:27 INFO - "Change" 12:30:27 INFO - ] 12:30:27 INFO - ], 12:30:27 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:27 INFO - } 12:30:27 INFO - ], 12:30:27 INFO - "revision": "455af65081f54070206a8e38a512033311205282" 12:30:27 INFO - } 12:30:27 INFO - } 12:30:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:30:27 INFO - Running post-action listener: _resource_record_post_action 12:30:27 INFO - ##### 12:30:27 INFO - ##### Running download-and-extract step. 12:30:27 INFO - ##### 12:30:27 INFO - Running pre-action listener: _resource_record_pre_action 12:30:27 INFO - Running main action method: download_and_extract 12:30:27 INFO - mkdir: /builds/slave/test/build/tests 12:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:27 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json 12:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json 12:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:30:37 INFO - Downloaded 1302 bytes. 12:30:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:30:37 INFO - Using the following test package requirements: 12:30:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'jsshell-linux-x86_64.zip'], 12:30:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:37 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:30:43 INFO - Downloaded 21860154 bytes. 12:30:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:30:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:30:44 INFO - Return code: 0 12:30:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:44 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:30:46 INFO - Downloaded 21860154 bytes. 12:30:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:30:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:30:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:30:47 INFO - Return code: 0 12:30: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')]} 12:30:47 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:30:48 INFO - Downloaded 11132038 bytes. 12:30:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:30:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:30:48 INFO - Return code: 0 12:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:48 INFO - https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:30:49 INFO - Downloaded 57735325 bytes. 12:30:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:49 INFO - mkdir: /builds/slave/test/properties 12:30:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:49 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:49 INFO - Contents: 12:30:49 INFO - build_url:https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:30:49 INFO - Running post-action listener: _resource_record_post_action 12:30:49 INFO - Running post-action listener: set_extra_try_arguments 12:30:49 INFO - ##### 12:30:49 INFO - ##### Running populate-webroot step. 12:30:49 INFO - ##### 12:30:49 INFO - Running pre-action listener: _resource_record_pre_action 12:30:49 INFO - Running main action method: populate_webroot 12:30:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:49 INFO - '--tppagecycles', 12:30:49 INFO - '7'], 12:30:49 INFO - 'tests': ['tsvgm']}}, 12:30:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:30:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:30:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:30:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['damp', 'tps']}, 12:30:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['damp', 'tps']}, 12:30:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:30:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:49 INFO - 'other': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'other_l64': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'other_nol64': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore']}, 12:30:49 INFO - 'svgr': {'tests': ['tsvgx', 12:30:49 INFO - 'tsvgr_opacity', 12:30:49 INFO - 'tart', 12:30:49 INFO - 'tscrollx', 12:30:49 INFO - 'cart']}, 12:30:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['tsvgx', 12:30:49 INFO - 'tsvgr_opacity', 12:30:49 INFO - 'tart', 12:30:49 INFO - 'tscrollx', 12:30:49 INFO - 'cart']}, 12:30:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['tp5o']}, 12:30:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--e10s'], 12:30:49 INFO - 'tests': ['tp5o']}, 12:30:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--xperf_path', 12:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:49 INFO - 'tests': ['tp5n']}, 12:30:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--e10s', 12:30:49 INFO - '--xperf_path', 12:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:49 INFO - 'tests': ['tp5n']}}, 12:30:49 INFO - 'talos.zip': {'path': '', 12:30:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:49 INFO - Running post-action listener: _resource_record_post_action 12:30:49 INFO - ##### 12:30:49 INFO - ##### Running create-virtualenv step. 12:30:49 INFO - ##### 12:30:49 INFO - Running pre-action listener: _resource_record_pre_action 12:30:49 INFO - Running main action method: create_virtualenv 12:30:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:30:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:49 INFO - Using real prefix '/usr' 12:30:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:30:52 INFO - Installing pip.................done. 12:30:52 INFO - Return code: 0 12:30:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:30:52 INFO - Using env: {'DISPLAY': ':0', 12:30:52 INFO - 'HOME': '/home/cltbld', 12:30:52 INFO - 'LANG': 'en_US.UTF-8', 12:30:52 INFO - 'LANGUAGE': 'en_US:en', 12:30:52 INFO - 'LOGNAME': 'cltbld', 12:30:52 INFO - 'MAIL': '/var/mail/cltbld', 12:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:52 INFO - 'MOZ_NO_REMOTE': '1', 12:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:52 INFO - 'NO_EM_RESTART': '1', 12:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:52 INFO - 'PWD': '/builds/slave/test', 12:30:52 INFO - 'SHELL': '/bin/bash', 12:30:52 INFO - 'SHLVL': '1', 12:30:52 INFO - 'TERM': 'linux', 12:30:52 INFO - 'TMOUT': '86400', 12:30:52 INFO - 'USER': 'cltbld', 12:30:52 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:52 INFO - '_': '/tools/buildbot/bin/python'} 12:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:30:52 INFO - Cleaning up... 12:30:52 INFO - Return code: 0 12:30:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:30:52 INFO - Using env: {'DISPLAY': ':0', 12:30:52 INFO - 'HOME': '/home/cltbld', 12:30:52 INFO - 'LANG': 'en_US.UTF-8', 12:30:52 INFO - 'LANGUAGE': 'en_US:en', 12:30:52 INFO - 'LOGNAME': 'cltbld', 12:30:52 INFO - 'MAIL': '/var/mail/cltbld', 12:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:52 INFO - 'MOZ_NO_REMOTE': '1', 12:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:52 INFO - 'NO_EM_RESTART': '1', 12:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:52 INFO - 'PWD': '/builds/slave/test', 12:30:52 INFO - 'SHELL': '/bin/bash', 12:30:52 INFO - 'SHLVL': '1', 12:30:52 INFO - 'TERM': 'linux', 12:30:52 INFO - 'TMOUT': '86400', 12:30:52 INFO - 'USER': 'cltbld', 12:30:52 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:52 INFO - '_': '/tools/buildbot/bin/python'} 12:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:52 INFO - Downloading/unpacking psutil>=0.7.1 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:30:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:54 INFO - Installing collected packages: psutil 12:30:54 INFO - Running setup.py install for psutil 12:30:54 INFO - building 'psutil._psutil_linux' extension 12:30:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:30: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:30:54 INFO - building 'psutil._psutil_posix' extension 12:30: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 12:30: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 12:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:54 INFO - Successfully installed psutil 12:30:54 INFO - Cleaning up... 12:30:55 INFO - Return code: 0 12:30:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:55 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:30:55 INFO - Using env: {'DISPLAY': ':0', 12:30:55 INFO - 'HOME': '/home/cltbld', 12:30:55 INFO - 'LANG': 'en_US.UTF-8', 12:30:55 INFO - 'LANGUAGE': 'en_US:en', 12:30:55 INFO - 'LOGNAME': 'cltbld', 12:30:55 INFO - 'MAIL': '/var/mail/cltbld', 12:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:55 INFO - 'MOZ_NO_REMOTE': '1', 12:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:55 INFO - 'NO_EM_RESTART': '1', 12:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:55 INFO - 'PWD': '/builds/slave/test', 12:30:55 INFO - 'SHELL': '/bin/bash', 12:30:55 INFO - 'SHLVL': '1', 12:30:55 INFO - 'TERM': 'linux', 12:30:55 INFO - 'TMOUT': '86400', 12:30:55 INFO - 'USER': 'cltbld', 12:30:55 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:55 INFO - '_': '/tools/buildbot/bin/python'} 12:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:30:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:30: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) 12:30:56 INFO - Installing collected packages: mozsystemmonitor 12:30:56 INFO - Running setup.py install for mozsystemmonitor 12:30:57 INFO - Successfully installed mozsystemmonitor 12:30:57 INFO - Cleaning up... 12:30:57 INFO - Return code: 0 12:30:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:57 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:30:57 INFO - Using env: {'DISPLAY': ':0', 12:30:57 INFO - 'HOME': '/home/cltbld', 12:30:57 INFO - 'LANG': 'en_US.UTF-8', 12:30:57 INFO - 'LANGUAGE': 'en_US:en', 12:30:57 INFO - 'LOGNAME': 'cltbld', 12:30:57 INFO - 'MAIL': '/var/mail/cltbld', 12:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:57 INFO - 'MOZ_NO_REMOTE': '1', 12:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:57 INFO - 'NO_EM_RESTART': '1', 12:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:57 INFO - 'PWD': '/builds/slave/test', 12:30:57 INFO - 'SHELL': '/bin/bash', 12:30:57 INFO - 'SHLVL': '1', 12:30:57 INFO - 'TERM': 'linux', 12:30:57 INFO - 'TMOUT': '86400', 12:30:57 INFO - 'USER': 'cltbld', 12:30:57 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:57 INFO - '_': '/tools/buildbot/bin/python'} 12:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:30:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:30:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:59 INFO - Downloading docopt-0.6.1.tar.gz 12:30:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:30:59 INFO - Running setup.py install for blobuploader 12:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:30:59 INFO - Running setup.py install for requests 12:31:00 INFO - Running setup.py install for docopt 12:31:00 INFO - Successfully installed blobuploader requests docopt 12:31:00 INFO - Cleaning up... 12:31:00 INFO - Return code: 0 12:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:00 INFO - Using env: {'DISPLAY': ':0', 12:31:00 INFO - 'HOME': '/home/cltbld', 12:31:00 INFO - 'LANG': 'en_US.UTF-8', 12:31:00 INFO - 'LANGUAGE': 'en_US:en', 12:31:00 INFO - 'LOGNAME': 'cltbld', 12:31:00 INFO - 'MAIL': '/var/mail/cltbld', 12:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:00 INFO - 'MOZ_NO_REMOTE': '1', 12:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:00 INFO - 'NO_EM_RESTART': '1', 12:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:00 INFO - 'PWD': '/builds/slave/test', 12:31:00 INFO - 'SHELL': '/bin/bash', 12:31:00 INFO - 'SHLVL': '1', 12:31:00 INFO - 'TERM': 'linux', 12:31:00 INFO - 'TMOUT': '86400', 12:31:00 INFO - 'USER': 'cltbld', 12:31:00 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:00 INFO - '_': '/tools/buildbot/bin/python'} 12:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:00 INFO - Running setup.py (path:/tmp/pip-ixxN_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:00 INFO - Running setup.py (path:/tmp/pip-SGbiBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:00 INFO - Running setup.py (path:/tmp/pip-2OJ0ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Running setup.py (path:/tmp/pip-Tl3aV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:00 INFO - Running setup.py (path:/tmp/pip-hEJNa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:00 INFO - Running setup.py (path:/tmp/pip-U9HH22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:00 INFO - Running setup.py (path:/tmp/pip-rRIV7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:01 INFO - Running setup.py (path:/tmp/pip-64Fy41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:01 INFO - Running setup.py (path:/tmp/pip-Fjkf2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:01 INFO - Running setup.py (path:/tmp/pip-Y9Hnlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:01 INFO - Running setup.py (path:/tmp/pip-PTb6rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:01 INFO - Running setup.py (path:/tmp/pip-T29jDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:01 INFO - Running setup.py (path:/tmp/pip-I2aHyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:01 INFO - Running setup.py (path:/tmp/pip-nUc5jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:01 INFO - Running setup.py (path:/tmp/pip-uQo6xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:01 INFO - Running setup.py (path:/tmp/pip-ONzd1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:01 INFO - Running setup.py (path:/tmp/pip-oNdVNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:01 INFO - Running setup.py install for manifestparser 12:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:01 INFO - Running setup.py install for mozcrash 12:31:01 INFO - Running setup.py install for mozdebug 12:31:02 INFO - Running setup.py install for mozdevice 12:31:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozfile 12:31:02 INFO - Running setup.py install for mozhttpd 12:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozinfo 12:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozInstall 12:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozleak 12:31:02 INFO - Running setup.py install for mozlog 12:31:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for moznetwork 12:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozprocess 12:31:03 INFO - Running setup.py install for mozprofile 12:31:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Running setup.py install for mozrunner 12:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Running setup.py install for mozscreenshot 12:31:03 INFO - Running setup.py install for moztest 12:31:03 INFO - Running setup.py install for mozversion 12:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:03 INFO - Using env: {'DISPLAY': ':0', 12:31:03 INFO - 'HOME': '/home/cltbld', 12:31:03 INFO - 'LANG': 'en_US.UTF-8', 12:31:03 INFO - 'LANGUAGE': 'en_US:en', 12:31:03 INFO - 'LOGNAME': 'cltbld', 12:31:03 INFO - 'MAIL': '/var/mail/cltbld', 12:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:03 INFO - 'MOZ_NO_REMOTE': '1', 12:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:03 INFO - 'NO_EM_RESTART': '1', 12:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:03 INFO - 'PWD': '/builds/slave/test', 12:31:03 INFO - 'SHELL': '/bin/bash', 12:31:03 INFO - 'SHLVL': '1', 12:31:03 INFO - 'TERM': 'linux', 12:31:03 INFO - 'TMOUT': '86400', 12:31:03 INFO - 'USER': 'cltbld', 12:31:03 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:03 INFO - '_': '/tools/buildbot/bin/python'} 12:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:03 INFO - Running setup.py (path:/tmp/pip-lZ4zeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31: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)) 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:03 INFO - Running setup.py (path:/tmp/pip-dGbQRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31: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)) 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:03 INFO - Running setup.py (path:/tmp/pip-FMpFhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31: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)) 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:03 INFO - Running setup.py (path:/tmp/pip-x1MmnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:04 INFO - Running setup.py (path:/tmp/pip-Te8OjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 INFO - Running setup.py (path:/tmp/pip-rSOdl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 INFO - Running setup.py (path:/tmp/pip-ZNhNCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 INFO - Running setup.py (path:/tmp/pip-W9A138-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:04 INFO - Running setup.py (path:/tmp/pip-gjarZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Running setup.py (path:/tmp/pip-uJ8ne3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:04 INFO - Running setup.py (path:/tmp/pip-32CYhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:04 INFO - Running setup.py (path:/tmp/pip-pVy9CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:04 INFO - Running setup.py (path:/tmp/pip-J7i5lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:04 INFO - Running setup.py (path:/tmp/pip-0WWifR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:04 INFO - Running setup.py (path:/tmp/pip-9IZVuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:04 INFO - Running setup.py (path:/tmp/pip-gF5gr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31: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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:04 INFO - Running setup.py (path:/tmp/pip-1yeBWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31: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)) 12:31: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)) 12:31: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)) 12:31: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)) 12:31: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)) 12:31: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)) 12:31:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:06 INFO - Downloading blessings-1.5.1.tar.gz 12:31: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 12:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:06 INFO - Installing collected packages: blessings 12:31:06 INFO - Running setup.py install for blessings 12:31:06 INFO - Successfully installed blessings 12:31:06 INFO - Cleaning up... 12:31:06 INFO - Return code: 0 12:31:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:07 INFO - Reading from file tmpfile_stdout 12:31:07 INFO - Current package versions: 12:31:07 INFO - argparse == 1.2.1 12:31:07 INFO - blessings == 1.5.1 12:31:07 INFO - blobuploader == 1.2.4 12:31:07 INFO - docopt == 0.6.1 12:31:07 INFO - manifestparser == 1.1 12:31:07 INFO - mozInstall == 1.12 12:31:07 INFO - mozcrash == 0.16 12:31:07 INFO - mozdebug == 0.1 12:31:07 INFO - mozdevice == 0.47 12:31:07 INFO - mozfile == 1.2 12:31:07 INFO - mozhttpd == 0.7 12:31:07 INFO - mozinfo == 0.9 12:31:07 INFO - mozleak == 0.1 12:31:07 INFO - mozlog == 3.1 12:31:07 INFO - moznetwork == 0.27 12:31:07 INFO - mozprocess == 0.22 12:31:07 INFO - mozprofile == 0.27 12:31:07 INFO - mozrunner == 6.11 12:31:07 INFO - mozscreenshot == 0.1 12:31:07 INFO - mozsystemmonitor == 0.0 12:31:07 INFO - moztest == 0.7 12:31:07 INFO - mozversion == 1.4 12:31:07 INFO - psutil == 3.1.1 12:31:07 INFO - requests == 1.2.3 12:31:07 INFO - wsgiref == 0.1.2 12:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:31:07 INFO - Using env: {'DISPLAY': ':0', 12:31:07 INFO - 'HOME': '/home/cltbld', 12:31:07 INFO - 'LANG': 'en_US.UTF-8', 12:31:07 INFO - 'LANGUAGE': 'en_US:en', 12:31:07 INFO - 'LOGNAME': 'cltbld', 12:31:07 INFO - 'MAIL': '/var/mail/cltbld', 12:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:07 INFO - 'MOZ_NO_REMOTE': '1', 12:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:07 INFO - 'NO_EM_RESTART': '1', 12:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:07 INFO - 'PWD': '/builds/slave/test', 12:31:07 INFO - 'SHELL': '/bin/bash', 12:31:07 INFO - 'SHLVL': '1', 12:31:07 INFO - 'TERM': 'linux', 12:31:07 INFO - 'TMOUT': '86400', 12:31:07 INFO - 'USER': 'cltbld', 12:31:07 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:07 INFO - '_': '/tools/buildbot/bin/python'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:31:07 INFO - Cleaning up... 12:31:07 INFO - Return code: 0 12:31:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:31:07 INFO - Using env: {'DISPLAY': ':0', 12:31:07 INFO - 'HOME': '/home/cltbld', 12:31:07 INFO - 'LANG': 'en_US.UTF-8', 12:31:07 INFO - 'LANGUAGE': 'en_US:en', 12:31:07 INFO - 'LOGNAME': 'cltbld', 12:31:07 INFO - 'MAIL': '/var/mail/cltbld', 12:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:07 INFO - 'MOZ_NO_REMOTE': '1', 12:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:07 INFO - 'NO_EM_RESTART': '1', 12:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:07 INFO - 'PWD': '/builds/slave/test', 12:31:07 INFO - 'SHELL': '/bin/bash', 12:31:07 INFO - 'SHLVL': '1', 12:31:07 INFO - 'TERM': 'linux', 12:31:07 INFO - 'TMOUT': '86400', 12:31:07 INFO - 'USER': 'cltbld', 12:31:07 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:07 INFO - '_': '/tools/buildbot/bin/python'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 INFO - Downloading/unpacking jsonschema 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 12:31:09 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:09 INFO - warning: no files found matching '*.txt' 12:31:09 INFO - no previously-included directories found matching 'build' 12:31:09 INFO - no previously-included directories found matching 'dist' 12:31:09 INFO - no previously-included directories found matching '.git*' 12:31:09 INFO - Installing collected packages: jsonschema, functools32 12:31:09 INFO - Running setup.py install for functools32 12:31:09 INFO - warning: no files found matching '*.txt' 12:31:09 INFO - no previously-included directories found matching 'build' 12:31:09 INFO - no previously-included directories found matching 'dist' 12:31:09 INFO - no previously-included directories found matching '.git*' 12:31:09 INFO - Successfully installed jsonschema functools32 12:31:09 INFO - Cleaning up... 12:31:09 INFO - Return code: 0 12:31:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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 0x7f5f13bcaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c31240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, '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': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:31: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 12:31: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 12:31:09 INFO - Using env: {'DISPLAY': ':0', 12:31:09 INFO - 'HOME': '/home/cltbld', 12:31:09 INFO - 'LANG': 'en_US.UTF-8', 12:31:09 INFO - 'LANGUAGE': 'en_US:en', 12:31:09 INFO - 'LOGNAME': 'cltbld', 12:31:09 INFO - 'MAIL': '/var/mail/cltbld', 12:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:09 INFO - 'MOZ_NO_REMOTE': '1', 12:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:09 INFO - 'NO_EM_RESTART': '1', 12:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:09 INFO - 'PWD': '/builds/slave/test', 12:31:09 INFO - 'SHELL': '/bin/bash', 12:31:09 INFO - 'SHLVL': '1', 12:31:09 INFO - 'TERM': 'linux', 12:31:09 INFO - 'TMOUT': '86400', 12:31:09 INFO - 'USER': 'cltbld', 12:31:09 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:09 INFO - '_': '/tools/buildbot/bin/python'} 12:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:09 INFO - Downloading/unpacking flake8 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31: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 12:31:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31: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 12:31:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:31:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:12 INFO - no previously-included directories found matching 'docs/_build' 12:31:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:12 INFO - Running setup.py install for pep8 12:31:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:12 INFO - no previously-included directories found matching 'docs/_build' 12:31:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:31:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:12 INFO - Cleaning up... 12:31:12 INFO - Return code: 0 12:31:12 INFO - Running post-action listener: _resource_record_post_action 12:31:12 INFO - Running post-action listener: _start_resource_monitoring 12:31:12 INFO - Starting resource monitoring. 12:31:12 INFO - ##### 12:31:12 INFO - ##### Running install step. 12:31:12 INFO - ##### 12:31:12 INFO - Running pre-action listener: _resource_record_pre_action 12:31:12 INFO - Running main action method: install 12:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:12 INFO - Reading from file tmpfile_stdout 12:31:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:12 INFO - Reading from file tmpfile_stdout 12:31:12 INFO - Output received: 12:31:12 INFO - Usage: mozinstall [options] installer 12:31:12 INFO - Options: 12:31:12 INFO - -h, --help show this help message and exit 12:31:12 INFO - -d DEST, --destination=DEST 12:31:12 INFO - Directory to install application into. [default: 12:31:12 INFO - "/builds/slave/test"] 12:31:12 INFO - --app=APP Application being installed. [default: firefox] 12:31:12 INFO - mkdir: /builds/slave/test/build/application 12:31: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'] 12:31: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 12:31:27 INFO - Reading from file tmpfile_stdout 12:31:27 INFO - Output received: 12:31:27 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:27 INFO - Running post-action listener: _resource_record_post_action 12:31:27 INFO - ##### 12:31:27 INFO - ##### Running run-tests step. 12:31:27 INFO - ##### 12:31:27 INFO - Running pre-action listener: _resource_record_pre_action 12:31:27 INFO - Running main action method: run_tests 12:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:27 INFO - Python 2.7.3 12:31:27 INFO - Return code: 0 12:31:27 INFO - grabbing minidump binary from tooltool 12:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:27 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 0x1cc00b0>, '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 0x1cc0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:31:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:31:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:27 INFO - Return code: 0 12:31:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:31:28 INFO - Return code: 0 12:31:28 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/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test/build 12:31:28 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/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 12:31:28 INFO - Using env: {'DISPLAY': ':0', 12:31:28 INFO - 'HOME': '/home/cltbld', 12:31:28 INFO - 'LANG': 'en_US.UTF-8', 12:31:28 INFO - 'LANGUAGE': 'en_US:en', 12:31:28 INFO - 'LOGNAME': 'cltbld', 12:31:28 INFO - 'MAIL': '/var/mail/cltbld', 12:31:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:28 INFO - 'MOZ_NO_REMOTE': '1', 12:31:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:28 INFO - 'NO_EM_RESTART': '1', 12:31:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:28 INFO - 'PWD': '/builds/slave/test', 12:31:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:28 INFO - 'SHELL': '/bin/bash', 12:31:28 INFO - 'SHLVL': '1', 12:31:28 INFO - 'TERM': 'linux', 12:31:28 INFO - 'TMOUT': '86400', 12:31:28 INFO - 'USER': 'cltbld', 12:31:28 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502', 12:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:28 INFO - '_': '/tools/buildbot/bin/python'} 12:31:28 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/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 12:31:28 INFO - mozversion INFO | application_buildid: 20151209115739 12:31:28 INFO - mozversion INFO | application_changeset: 455af65081f54070206a8e38a512033311205282 12:31:28 INFO - mozversion INFO | application_display_name: Nightly 12:31:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:28 INFO - mozversion INFO | application_name: Firefox 12:31:28 INFO - mozversion INFO | application_remotingname: firefox 12:31:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:31:28 INFO - mozversion INFO | application_vendor: Mozilla 12:31:28 INFO - mozversion INFO | application_version: 45.0a1 12:31:28 INFO - mozversion INFO | platform_buildid: 20151209115739 12:31:28 INFO - mozversion INFO | platform_changeset: 455af65081f54070206a8e38a512033311205282 12:31:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:28 INFO - mozversion INFO | platform_version: 45.0a1 12:31:28 INFO - 2015-12-09 12:31:28,585 DEBUG : using testdate: 1449693088 12:31:28 INFO - 2015-12-09 12:31:28,585 DEBUG : actual date: 1449693088 12:31:28 INFO - 2015-12-09 12:31:28,606 INFO : starting webserver on 'localhost:60623' 12:31:28 INFO - 2015-12-09 12:31:28,607 INFO : Starting test suite talos-linux64-ix-066 12:31:28 INFO - 2015-12-09 12:31:28,607 INFO : Starting test dromaeo_css 12:31:28 INFO - 2015-12-09 12:31:28,608 DEBUG : operating with platform_type : linux_ 12:31:28 INFO - 2015-12-09 12:31:28,608 INFO : Initialising browser for dromaeo_css test... 12:31:28 INFO - 2015-12-09 12:31:28,621 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KBlDd/profile http://localhost:60623/getInfo.html 12:31:32 INFO - 2015-12-09 12:31:32,826 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:31:32 INFO - 2015-12-09 12:31:32,826 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:31:32 INFO - 2015-12-09 12:31:32,826 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:31:32 INFO - 2015-12-09 12:31:32,826 DEBUG : BROWSER_OUTPUT: __metrics 12:31:32 INFO - 2015-12-09 12:31:32,907 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:31:32 INFO - 2015-12-09 12:31:32,983 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] 12:31:34 INFO - 2015-12-09 12:31:34,291 INFO : Browser initialized. 12:31:34 INFO - 2015-12-09 12:31:34,292 INFO : Running cycle 1/1 for dromaeo_css test... 12:31:34 INFO - 2015-12-09 12:31:34,292 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KBlDd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:31:46 INFO - 2015-12-09 12:31:46,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 142508032 12:31:46 INFO - 2015-12-09 12:31:46,235 DEBUG : BROWSER_OUTPUT: 12:32:37 INFO - 2015-12-09 12:32:37,576 DEBUG : BROWSER_OUTPUT: 1449693157575 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:34:49 INFO - 2015-12-09 12:34:49,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60623/tests/dromaeo/cssquery-ext.html) 12:34:50 INFO - 2015-12-09 12:34:50,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 239456256 12:34:50 INFO - 2015-12-09 12:34:50,731 DEBUG : BROWSER_OUTPUT: 12:37:53 INFO - 2015-12-09 12:37:53,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-ext.html (next: http://localhost:60623/tests/dromaeo/cssquery-jquery.html) 12:37:53 INFO - 2015-12-09 12:37:53,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 221310976 12:37:53 INFO - 2015-12-09 12:37:53,813 DEBUG : BROWSER_OUTPUT: 12:40:55 INFO - 2015-12-09 12:40:55,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60623/tests/dromaeo/cssquery-mootools.html) 12:40:56 INFO - 2015-12-09 12:40:56,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 215977984 12:40:56 INFO - 2015-12-09 12:40:56,521 DEBUG : BROWSER_OUTPUT: 12:43:58 INFO - 2015-12-09 12:43:58,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60623/tests/dromaeo/cssquery-prototype.html) 12:43:58 INFO - 2015-12-09 12:43:58,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 200712192 12:43:58 INFO - 2015-12-09 12:43:58,988 DEBUG : BROWSER_OUTPUT: 12:47:01 INFO - 2015-12-09 12:47:01,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60623/tests/dromaeo/cssquery-yui.html) 12:47:02 INFO - 2015-12-09 12:47:02,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 207323136 12:47:02 INFO - 2015-12-09 12:47:02,323 DEBUG : BROWSER_OUTPUT: 12:50:04 INFO - 2015-12-09 12:50:04,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/dromaeo/cssquery-yui.html (next: http://localhost:60623/tests/dromaeo/cssquery-dojo.html) 12:50:05 INFO - 2015-12-09 12:50:05,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 234520576 12:50:05 INFO - 2015-12-09 12:50:05,217 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,218 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:50:05 INFO - 2015-12-09 12:50:05,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:50:05 INFO - 2015-12-09 12:50:05,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:50:05 INFO - 2015-12-09 12:50:05,219 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:50:05 INFO - 2015-12-09 12:50:05,220 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.7770639495643;2727.63176971109;2737.7672897803686;2747.9725202747977;2752.944941101178;4515.7516336601475;4631.629469642429;4702.435707715074;4720.598749106326;4740.952590474094;4627.8380256691025;4643.373144625474;4727.550882666142;4737.076270127326;4759.4764575896625;4207.200631879933;4301.655597699261;4312.956870431287;4333.631641310492;4481.910361792762;4463.933041004388;4480.148771733377;4484.013517026249;4502.16709908668;4525.683202175849;4130.669546436308;4223.239816832969;4237.957620423787;4338.089001309729;4423.049044455457;4383.473983122014;4393.1872603568445;4393.978030109861;4414.624756895668;4425.181341451842;4319.244132276839;4342.435483387171;4358.738475691469;4385.451818522684;4388.078503514266;4333.328334108187;4424.823007079713;4451.221036318631;4685.367475390813;4696.794283204922;5023.899522009576;5083.440821509631;5089.465606111342;5094.923576146361;5132.640715149941;5146.228065790124;5148.974255128738;5153.896922061575;5154.664946778447;5157.252198431206;4567.794449249792;4762.476127625959;4765.285207218945;4767.356406885026;4809.062232864593;4993.525615066563;5015.072211640858;5168.224766285088;5293.470652934676;5296.311479507639;4929.901401971941;4935.333729946483;4947.975260123676;4951.9752401237765;4969.925451118236;4821.4696383397795;5036.597072234213;5049.192129259301;5053.0904437200925;5065.696058236444;4840.370751802314;4863.635227357962;4946.505349465025;5023.924641130313;5046.419661738873;5009.949900500948;5011.123053465629;5014.373203349582;5020.1214787412055;5050.090983622909;4082.4896887889013;4197.370394440858;4209.052963083343;4209.810558524874;4214.557471465513;3589.3000864831106;3604.621514740967;3605.8016809075752;3686.6866316362875;3711.7030637548933;4341.479022517318;4350.73895566267;4354.847580334673;4370.715903466328;4398.670099742468;4781.641376896747;5134.743262836843;5141.280220769096;5146.330976973044;5151.021305951857;4237.089025859394;4249.3413520904305;4259.339802330644;4306.354046892929;4348.565143485626;4491.079328737601;4501.212287849613;4502.57225563571;4520.299353600197;4529.818807247673;4631.698939568917;4832.057748738962;4835.057163853015;4836.371271734652;4874.975625121851;4997.350344455343;5010.574101201439;5073.061483625541;5190.09173394662;5207.1668533034535;4853.708777473363;4868.829590964299;4876.731779752147;4877.414710234794;4918.458969513279;5069.797208111781;5090.694558326512;5099.949000510096;5108.182690769459;5151.072806894795;4792.2332426811545;4891.413030436228;4891.657583969088;4997.900041999067;5147.253648221062;4839.201531747222;4930.6055515557955;4976.278439626306;4987.301777751045;5025.974870125626;4956.653034287565;4975.402951645826;4977.850664480072;4982.825601103944;5034.798608055637;4607.884802879955;4693.155232058262;4738.170820106398;4741.857744267678;4843.4430040545785;4985.8005679772405;5013.39839219296;5015.272785446163;5032.924506132338;5055.266986287042;4889.633277504273;4901.681390709592;4905.754712264444;4906.582940450102;4941.135301322182 12:50:05 INFO - 2015-12-09 12:50:05,222 DEBUG : BROWSER_OUTPUT: |1;ext.html;507.2796628787122;515.2683189870384;517.7359546631217;535.2880668710612;542.3898114621052;26683.733162668366;27928.581071283923;35312.82343588278;36037.819810900975;36084;40064.39903401451;40732;40799;40815.18369632606;40839.38740918889;6911.827204319907;7955.482893611926;8118.918810811875;8119.756407307761;8127.065387480427;7140.7857764267155;7240;7245.6377181141;7251.238619944883;10142.188624910026;10091.69724908254;10188.541515631778;10190.388576685385;10194.898051019469;10196.796064078713;10061.597536098547;10147.391156530557;10152.187824973984;10154.695359139238;10162;6942.271061538516;7100.680469378839;7108.537945033608;7109.537880037781;7113.0397396351345;40646.796766016276;41455.58544414547;41692.166156677;41729.79135104336;41744.582554174674;2948.86730097144;2971.9554206686703;3442.3115376924716;3483.3904066788464;3603.0992251937014;28506.144815655356;28779.856100719364;28985.42029159405;29014.12957611275;29025.709742902513;3268.3790079884748;3534.717222622184;3576.213233088716;3577.123604716861;3606.3328284267495;215184;216481;216876.99999999843;217354;217450.99999999843;54958.72520637371;55282.72358638261;55308;55373.169402458996;55432.44567554273;59473.40526594765;59526;59777.70111149416;59794;59842.70078649666;13968.790468142986;14352.49766258176;14353.497627582985;14369.928150359181;14383.352749126314;11015.724606884893;11171;11207.775844483227;11226.101911847032;11240.606578769704;19352.8064719351;19774.90112549428;19788.604227915363;19789.703154452694;19822.70265946012;7601.277878601634;7827.25641064098;7882.211778822072;7917.366610671133;7918.366530677532;848.6902280667636;884.827458645558;912.3020889019905;959.3524371049514;971.4220039076738;26712;26842.194734158005;26869.731302686723;27078.187654370402;27145.59281610738;887.6493784954906;932.4125800745487;969.7139343893568;1046.7016900183412;1066.1470823341451;12331.630051098482;15287;15611.921940390226;16235.025898445894;16582.917085414494;312562;319367;319511;319548;319935;48396.7580162104;48658.513414865396;48772;48803;48915.02169956581;1199.964001079969;1209.9879001209874;1217.78688729472;1228.969275768113;1230.8953738932291;27419.588706169823;28246.43507129887;28349.14952551427;28714.282142946595;28805.135845924655;39971.200575987736;40317;40438.19123617452;40576;40582.188356232116;247416;249168;249191;249238;249393;24882.875585621958;25745.356366090997;28589.857050714614;28721;28746.712532874404;33130.5030424539;33740.83129584337;33815.492767609;34164.82917585396;34622.480662789574;30605.387892241586;31352.843235783675;37637.2472550542;39874;40042.599574003885;31120;34026.489602656475;37318.440223397214;39435.80282098686;40645.390319144644;33694.15764605806;38287.42568861414;39314;39407.2118557633;39536.2092758149;27555.862220688767;30343.90691001805;30808;33201.66798331986;36121.81939090288;24043.75956240485;24122.75877241205;24171;24346.634800477652;24372.756272437047 12:50:05 INFO - 2015-12-09 12:50:05,225 DEBUG : BROWSER_OUTPUT: |2;jquery.html;263.4717391629782;269.71679736276906;271.2635195444368;272.66326087282215;276.1508361787504;11668.533258669664;14821.92589037056;14957.401703931844;15424.61438464039;15454.227288635566;15291.158986255752;15336.233188340566;15560.610984725388;15563.299651515681;15586.376544938188;5543.1408131739645;5698.629589076697;5713;5718.370979192286;5723.284589426322;4113.136241389312;4199.3281075028;5595.63628364155;6375.936240637604;6609.702563384635;6385.776497822577;6543.1821022372205;6548.1814773153355;6582.045603387506;6588.341165883421;6458.580192287486;6486.383793539606;6492.772752953648;6503.479721622259;6506.3818937200895;6105.481034112106;6140.815775526741;6209.813705588839;6212.534059945522;6275.560710750249;19619.117139728747;19941.80058199414;19971.700424493643;20491.28280510175;20698.275560355465;1726.5769886377793;1789.096506264341;1884.5006073390562;1889.263187356932;1944.8152425519554;8765.561721913942;8958.104189581056;9957.90042099577;10296.845547316796;13250.933745331307;1688.763573099767;1731.5497970527626;1776.600264940391;1790.1675720789765;1791.8566514678794;50080.99838003256;51859.22211166836;52133.478665213624;52182.47817521852;53344.73327633337;9009.504477253682;9336.57985390659;9621.759456013515;9717.854232186522;9724.319297649097;12092.758144837055;12094.939525302494;12098;12103.334316612494;12123.393830308449;6638.568493048033;6684.665766711645;6693.464522838161;6695.230048544479;6794.388505034571;6202.100695399142;6230.6573138476915;6255;6264;6279.905801412982;4109.794510274474;4135.379693046068;4150.086980864205;4168.062186008185;4190.497140343117;1567.2007276288946;1573.7482002879485;1588.6902054099571;1637.8853480256505;1639.5573195237218;812.4028838803474;908.2960705453327;989.1394486796534;1004.9547770350351;1007.2495990487134;13363.997700172526;14924.477643282433;15581;16117.516474505783;16481.752773708406;836.861917783571;839.9370047246359;910.8269428808505;942.5758408716105;959.8752162218867;8499.405041647025;8654.22112009922;8694.13058694138;8779.101650132136;8893.955530222436;435673.89750179136;442464;446234;496351;499661;58253.417465825645;61905.69047154736;63599.682001589696;63997.680011600576;65292;1027.6557353286732;1043.6451606453843;1057.0539367266254;1061.7345663584103;1061.803566340214;14358.138511689333;14454.638634034232;14596.416143354147;14727.705445890808;15192.620184495476;32601.510977335834;32758.836205818818;33427.665723342456;33459;33600.15999600029;42423.787881060394;43183;44618.776906115265;44990;46198.53801461942;8422.873656895274;8547.145285471403;8553.016403113721;8576.699815506427;8607.8708819369;15592.220388980733;16203.675926481168;16243.350265989227;16349.673006539564;16947.491575252763;14237.857621423653;14344.56966291013;14455.13269203851;14578.927105364406;14638.414463421344;13552.728945421233;14050.241343754138;14114.659107384781;14139.505117320845;14527.055741376776;14177.787333189804;14665.193414362313;14671.193084380035;14912.701745964803;15087.321070551632;8613.26787223093;8789.824203515765;8848.867266991128;8980.595873185854;8992.86510702353;14066.296685165906;14134.78797818013;14158.433662653379;14397.712045758817;14469.059511131743 12:50:05 INFO - 2015-12-09 12:50:05,226 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1396.9022168448212;1626.6665333606609;1676.9161541922902;1700.4388551777915;1739.878208525403;5711.343195532515;7007.824804379887;7228.02421673074;7229;7229.277072292768;6943.1668199816095;7128.251533588977;7131.072960515139;7135.072440582717;7143.428525717943;1943.5918457124021;1983.7718662353798;1992.3126521350184;1996.4509759816094;1999.270266352778;2032.9491762705902;2044.897755112246;2057.77364489906;2101.2750601042617;2104.295061154515;2000.8499362547793;2018.899055047249;2050.7231523744326;2051.200031987526;2052.48687828043;2018.7173795668546;2045.6420126477956;2047.805458481442;2048.866823656465;2049.8155166035053;1982.9405117846488;2012.5572374077678;2040.5918816236813;2041.795820417961;2045.4988527810633;6971.372576468091;7089.4682898782285;7099.396551293146;7113.217546069928;7118.466115041392;4148.43996060534;4214.283571792803;4228.640565551932;4235.91528169438;4244.427002354673;2728.2088194423595;2757.2968892932377;2783.151138902634;2784.3874347643687;2816.310004049001;852.799592095857;856.4347530629817;861.8190180062195;877.7673916412156;880.7401816464159;9605.135537801561;9605.807883842353;9605.90394096057;9611.183049440737;9627.374220675634;3794.354959656865;3809.371453710107;3813.504244448204;3817.10298079951;3879.4568760373572;8393.664253429917;8398.118197589287;8401.873971890427;8407.663693452316;8410.201030902055;4184.205001049791;4203.789810509524;4210.957890421118;4212.53662097169;4213.241616509058;3254.902352929416;3342.4484959981332;3725.0873535983314;3870.4968354113785;3875.379939209713;3320.5849268841393;3397.1676939150066;3406.267652454734;3421.3841508528208;3433.1588760753275;1054.6941386997837;1062.102523367753;1065.3128731967838;1066;1068.4924660786064;1174.6593487888588;1177.8772517515104;1199.736058067224;1201.0451690905752;1214.4413569757833;6653.833654158588;6694.631795251211;6736.93263067363;6756.594604323756;6776.424003959719;400.63542176619717;412.83692941288024;414.3039693315199;414.9149424367997;415.0391842883715;5308.601854860901;5345.9465405345445;5352.116900711417;5352.571794256528;5355.758990845421;8244.587770611446;8451.492910425393;8587;8599.52702601363;8607.268382187583;8488.74533763988;8555.786105347415;8580.742577722678;8582.914170858336;8594.484330940164;6675.365840245169;6735.494837887178;6791.898121528181;6798.116244888133;6863.416609588241;6519.7392104315295;6530.08578798978;6539.11721917535;6545;6546.574472659262;7548.358389536951;7677.884831727417;7698.422618303538;7701.4608977371045;7756.1468238494845;7641.617919103911;7919.16848730875;8011.399145064027;8027.719029833927;8033.277005069572;5104.897902042013;5315.2292917525965;6172.321044685171;6253.1245625613365;6277.717502712298;5521.282233309644;5624.46567576096;6788.626625535643;6829.965850170717;6851.725930962705;6369.77705780314;6510.902336465051;6540.672966351759;6592.901106483502;6723.562968407038;6359.650219237987;6372.840678983062;6393.392627700361;6432.935670643234;6516.315786842313;6380.968095159495;6394.392532709385;6396.360363963567;6410.455111315404;6413.743450261937;5915.792947246826;6045.183900173421;6072.240969878765;6094.939050609437;6098.969505152446;6151.507879369729;6200.596961197508;6201.379862013762;6201.906971395342;6204.689765511616 12:50:05 INFO - 2015-12-09 12:50:05,229 DEBUG : BROWSER_OUTPUT: |4;prototype.html;245.08460898543947;246.91358024691354;247.71265332214634;249.45618551557598;253.56387014335343;5285.550728188104;5286.7356632168385;5335.626506144571;5349.411564727881;5359.062164121283;5023.015908716064;5079.771410286537;5158.045761534119;5266.973665131679;5267.86830329241;3998.6801055915457;4007.4589930359466;4008.218397412491;4016.8150395633284;4025.1547175093265;3791.4691943127846;3999.9400008999887;4009.077912080223;4016.2770701273757;4016.518017837849;3823.254465379252;3841.0973421246126;3908.2965066288198;3909.589493103226;3918.8628398006076;3901.1222474943193;3919.7060220483577;3922.5881282465357;3940.1725637616137;3967.1668949520636;3404.9489257661153;3407.1141503209096;3409.062507810372;3409.8465569049454;3422.743294252941;5055.317532133152;5071.036503064406;5075.314832497603;5083.288339632454;5088.389393272794;4447.666425018137;4531.45622525299;4546.0680560485025;4546.272596384596;4558.407407037097;5533.667979921177;5537.889242215173;5540.778368865241;5544.556435485192;5546.195801608785;3714.9628503715157;3719.75821571597;3721.702263818915;3722.0694826293425;3726;5760.6255593386295;5841.85395365115;5847.941520584783;5849.298084229919;5869.383714709937;3602.6397360264286;3726.087108658396;3730.7948062856262;3794.0704527390412;3817.351050321452;3761.3793724035777;3762.247550489913;3762.398016317376;3767.4348847672522;3774.7735135891935;4446.199684056836;4449.2658711312915;4452.5547445255215;4455.242608756519;4461.665375096881;5554.972225138929;5563.582731295169;5563.693996830132;5564.721763911869;5580.386157522669;1308.234682710606;1335.9265240411871;1336.1582203211915;1337.5519201067557;1339.2366351179928;847.2459511035183;858.7810108422312;861.0227391910227;861.1560670542904;862.5428522882883;4705.6470764692785;4724.4094488188975;4775.092732380836;4785.994941062347;4803.711777293373;5713.485786279171;5720.885582288414;5726.484616384545;5730.799422020209;5732.369439361667;4639.234526303189;4726.550977657117;4734.763261836894;4743.430788305425;4769.952300476951;3095.6440009399207;3125.687431256856;3134.686531346847;3136.9372612547622;3141.4816555268126;5498.752556134984;5501.642393244426;5502.58730595207;5503.174523821379;5510.8071217507995;5976.462118409277;5983.730732117066;5989.730462129215;5990.191324171268;5990.73041713124;5361.195820626937;5477.20580515823;5509.5041446270025;5544.251526043932;5550.306211723615;5779.104238842986;5805.419458054161;5838.532917366516;5841.4450627190345;5850.765969361178;5669.801556945487;5700.25896633435;5708;5720.6853623049465;5734;5339.3859706132735;5502.669839809624;5512.91730624033;5513.8345849624575;5526.502614764529;3788.962110378861;3837.2325534892575;3838.846446142123;3840.0591854994586;3840.71194660396;5763.9135412968;5765.3946335634155;5781.046127388934;5791.652500849962;5800.796972105956;5560.110382338807;5564.942660894417;5567.498925096761;5578.163275508706;5579.3304803422225;5442.482964118402;5585.525230355465;5600.327960644749;5608.411116832837;5613.46672066153;5503.2020357048805;5511.421300763523;5511.751971161227;5513.365962914316;5515.503604675599;5639.943600563942;5643.7742490299925;5652.123920792284;5653.321601407857;5661.85845353853;5410.107332290128;5519.917201241904;5523.005858945428;5528.640638358494;5531.704342697896 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.7648822911981;689.741346994877;764.1708746010578;782.5304817109738;816.1634324817059;11366.261193022458;11597.594084207054;11604.65186044419;11623.605167379905;13472.124311919719;13392.129511581741;13477.595672129828;13478;13494.662633434169;13496.257705826176;633.4647223096499;637.2607774981022;768.1473564343574;778.5717855179657;793.2424534569486;782.3076577229136;792.2117493094379;792.7265093542748;797.6011994002998;801.2268161224417;814.4095530740195;815.7267315449332;817.2685446525356;821.9219174178444;833.9374546908975;656.1797752808989;663.1346093348179;666.1173944523525;666.4601672645173;833.5373867503533;489.605867276842;603.6227357901312;604.3774911840811;611.2237458427771;612.4426771637789;12292.631221063382;12440.56458023974;12447.75104497914;12453.1905426147;12465.002799775995;10596.364218146859;11049.889501104966;11078.446077696164;11152.219344645879;11437.542498300058;8567.528785916773;8712.346574006975;8796.824063518694;8804.339674524372;9077.909220907772;3072.109088364394;3100.7445150758163;3112.2219445138717;3174.793638413496;3212.0042786735953;41155.1768964622;41612.58387416148;41650.58349416528;41677.79161104175;41834.581654183676;8957.776055598662;9065.864012039825;9088.909110908806;9141.177294043435;9171.541422928827;15128.167950762814;15138;15161;15199.088054716753;15222.162781046927;5954.910676339859;5974.40255974399;6015.939840601538;6092.543059270483;6167.229096362955;3480.738944579167;3615.7468977171347;3621.764585301947;3626.8367923443507;3671.834767435472;2603.7266087060584;2652.8540930248637;2660.7472290132405;2664;2665.400284935874;452.5542340794315;456.8834947088538;465.37407187332985;471.09314569453664;472.61718008412606;462.94213223347083;529.5842763430688;549.6097770582851;561.612487383704;571.4314157860443;7245.89131163033;7319.5242309249725;7352.852942941218;7395;7547.245275472409;414.3784323514728;543.7444401131462;557.7490129441686;600.1088383750127;619.5941658213877;3393.5418718473184;3407.6421975692692;3435.3644575753565;3464.367081018394;4044.2922488564973;48446.515534844904;48465.273020904715;49787.75106124446;51051.23423148656;53562;46421.535784641725;46892.2966155508;47085.52914470811;47533.762331188125;47676.284855727194;43669;43976.78011609922;43994;44237.557624423986;45016.77491612521;8052.87920681202;8221.79445513867;8248.505089694638;8540.231379175904;8556.74329770108;30639.387212256075;30991;31038.68961310358;31239.53140702846;31405.371892562478;36033.63966360407;38752.2249555013;39035.6096439032;39356.80321598374;39441.21117577575;10393.792124157324;10463.581456741646;10495.842562361724;10556.366488923239;10722.785544289227;11041.39272340029;11124.221304508606;11250.043746281657;11343.943280283545;11469.08247340194;10814.134869210602;10901.182411319025;11047.944760276147;11208.439578021229;11239.438028098399;9976.950115249378;10215.591376344863;10302.690919272434;10385.480725963822;10659.733506662396;10271.845922311022;10814.783704326026;10905.291156074829;10995.230333876552;11024.50389732448;8859.601317940836;9002.099790020946;9065.184133428023;9292.442453452815;9314;8442.831143377221;8614.698485552975;8625.741227763177;9378.718638440858;9421.246300296098 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,868 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694205217__endTimestamp 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,231 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4665.22 Median:4821.47 stddev:497.12 (10.3%) stddev-sans-first:472.12 12:50:05 INFO - 2015-12-09 12:50:05,232 DEBUG : BROWSER_OUTPUT: Values: 2622.8 2727.6 2737.8 2748.0 2752.9 4515.8 4631.6 4702.4 4720.6 4741.0 4627.8 4643.4 4727.6 4737.1 4759.5 4207.2 4301.7 4313.0 4333.6 4481.9 4463.9 4480.1 4484.0 4502.2 4525.7 4130.7 4223.2 4238.0 4338.1 4423.0 4383.5 4393.2 4394.0 4414.6 4425.2 4319.2 4342.4 4358.7 4385.5 4388.1 4333.3 4424.8 4451.2 4685.4 4696.8 5023.9 5083.4 5089.5 5094.9 5132.6 5146.2 5149.0 5153.9 5154.7 5157.3 4567.8 4762.5 4765.3 4767.4 4809.1 4993.5 5015.1 5168.2 5293.5 5296.3 4929.9 4935.3 4948.0 4952.0 4969.9 4821.5 5036.6 5049.2 5053.1 5065.7 4840.4 4863.6 4946.5 5023.9 5046.4 5009.9 5011.1 5014.4 5020.1 5050.1 4082.5 4197.4 4209.1 4209.8 4214.6 3589.3 3604.6 3605.8 3686.7 3711.7 4341.5 4350.7 4354.8 4370.7 4398.7 4781.6 5134.7 5141.3 5146.3 5151.0 4237.1 4249.3 4259.3 4306.4 4348.6 4491.1 4501.2 4502.6 4520.3 4529.8 4631.7 4832.1 4835.1 4836.4 4875.0 4997.4 5010.6 5073.1 5190.1 5207.2 4853.7 4868.8 4876.7 4877.4 4918.5 5069.8 5090.7 5099.9 5108.2 5151.1 4792.2 4891.4 4891.7 4997.9 5147.3 4839.2 4930.6 4976.3 4987.3 5026.0 4956.7 4975.4 4977.9 4982.8 5034.8 4607.9 4693.2 4738.2 4741.9 4843.4 4985.8 5013.4 5015.3 5032.9 5055.3 4889.6 4901.7 4905.8 4906.6 4941.1 12:50:05 INFO - 2015-12-09 12:50:05,232 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,232 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42654.76 Median:33447.91 stddev:69127.28 (206.7%) stddev-sans-first:69248.77 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: Values: 507.3 515.3 517.7 535.3 542.4 26683.7 27928.6 35312.8 36037.8 36084.0 40064.4 40732.0 40799.0 40815.2 40839.4 6911.8 7955.5 8118.9 8119.8 8127.1 7140.8 7240.0 7245.6 7251.2 10142.2 10091.7 10188.5 10190.4 10194.9 10196.8 10061.6 10147.4 10152.2 10154.7 10162.0 6942.3 7100.7 7108.5 7109.5 7113.0 40646.8 41455.6 41692.2 41729.8 41744.6 2948.9 2972.0 3442.3 3483.4 3603.1 28506.1 28779.9 28985.4 29014.1 29025.7 3268.4 3534.7 3576.2 3577.1 3606.3 215184.0 216481.0 216877.0 217354.0 217451.0 54958.7 55282.7 55308.0 55373.2 55432.4 59473.4 59526.0 59777.7 59794.0 59842.7 13968.8 14352.5 14353.5 14369.9 14383.4 11015.7 11171.0 11207.8 11226.1 11240.6 19352.8 19774.9 19788.6 19789.7 19822.7 7601.3 7827.3 7882.2 7917.4 7918.4 848.7 884.8 912.3 959.4 971.4 26712.0 26842.2 26869.7 27078.2 27145.6 887.6 932.4 969.7 1046.7 1066.1 12331.6 15287.0 15611.9 16235.0 16582.9 312562.0 319367.0 319511.0 319548.0 319935.0 48396.8 48658.5 48772.0 48803.0 48915.0 1200.0 1210.0 1217.8 1229.0 1230.9 27419.6 28246.4 28349.1 28714.3 28805.1 39971.2 40317.0 40438.2 40576.0 40582.2 247416.0 249168.0 249191.0 249238.0 249393.0 24882.9 25745.4 28589.9 28721.0 28746.7 33130.5 33740.8 33815.5 34164.8 34622.5 30605.4 31352.8 37637.2 39874.0 40042.6 31120.0 34026.5 37318.4 39435.8 40645.4 33694.2 38287.4 39314.0 39407.2 39536.2 27555.9 30343.9 30808.0 33201.7 36121.8 24043.8 24122.8 24171.0 24346.6 24372.8 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25652.55 Median:4124.26 stddev:75747.77 (1836.6%) stddev-sans-first:75936.28 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: Values: 263.5 269.7 271.3 272.7 276.2 11668.5 14821.9 14957.4 15424.6 15454.2 15291.2 15336.2 15560.6 15563.3 15586.4 5543.1 5698.6 5713.0 5718.4 5723.3 4113.1 4199.3 5595.6 6375.9 6609.7 6385.8 6543.2 6548.2 6582.0 6588.3 6458.6 6486.4 6492.8 6503.5 6506.4 6105.5 6140.8 6209.8 6212.5 6275.6 19619.1 19941.8 19971.7 20491.3 20698.3 1726.6 1789.1 1884.5 1889.3 1944.8 8765.6 8958.1 9957.9 10296.8 13250.9 1688.8 1731.5 1776.6 1790.2 1791.9 50081.0 51859.2 52133.5 52182.5 53344.7 9009.5 9336.6 9621.8 9717.9 9724.3 12092.8 12094.9 12098.0 12103.3 12123.4 6638.6 6684.7 6693.5 6695.2 6794.4 6202.1 6230.7 6255.0 6264.0 6279.9 4109.8 4135.4 4150.1 4168.1 4190.5 1567.2 1573.7 1588.7 1637.9 1639.6 812.4 908.3 989.1 1005.0 1007.2 13364.0 14924.5 15581.0 16117.5 16481.8 836.9 839.9 910.8 942.6 959.9 8499.4 8654.2 8694.1 8779.1 8894.0 435673.9 442464.0 446234.0 496351.0 499661.0 58253.4 61905.7 63599.7 63997.7 65292.0 1027.7 1043.6 1057.1 1061.7 1061.8 14358.1 14454.6 14596.4 14727.7 15192.6 32601.5 32758.8 33427.7 33459.0 33600.2 42423.8 43183.0 44618.8 44990.0 46198.5 8422.9 8547.1 8553.0 8576.7 8607.9 15592.2 16203.7 16243.4 16349.7 16947.5 14237.9 14344.6 14455.1 14578.9 14638.4 13552.7 14050.2 14114.7 14139.5 14527.1 14177.8 14665.2 14671.2 14912.7 15087.3 8613.3 8789.8 8848.9 8980.6 8992.9 14066.3 14134.8 14158.4 14397.7 14469.1 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4949.84 Median:6161.91 stddev:2601.94 (42.2%) stddev-sans-first:2595.54 12:50:05 INFO - 2015-12-09 12:50:05,233 DEBUG : BROWSER_OUTPUT: Values: 1396.9 1626.7 1676.9 1700.4 1739.9 5711.3 7007.8 7228.0 7229.0 7229.3 6943.2 7128.3 7131.1 7135.1 7143.4 1943.6 1983.8 1992.3 1996.5 1999.3 2032.9 2044.9 2057.8 2101.3 2104.3 2000.8 2018.9 2050.7 2051.2 2052.5 2018.7 2045.6 2047.8 2048.9 2049.8 1982.9 2012.6 2040.6 2041.8 2045.5 6971.4 7089.5 7099.4 7113.2 7118.5 4148.4 4214.3 4228.6 4235.9 4244.4 2728.2 2757.3 2783.2 2784.4 2816.3 852.8 856.4 861.8 877.8 880.7 9605.1 9605.8 9605.9 9611.2 9627.4 3794.4 3809.4 3813.5 3817.1 3879.5 8393.7 8398.1 8401.9 8407.7 8410.2 4184.2 4203.8 4211.0 4212.5 4213.2 3254.9 3342.4 3725.1 3870.5 3875.4 3320.6 3397.2 3406.3 3421.4 3433.2 1054.7 1062.1 1065.3 1066.0 1068.5 1174.7 1177.9 1199.7 1201.0 1214.4 6653.8 6694.6 6736.9 6756.6 6776.4 400.6 412.8 414.3 414.9 415.0 5308.6 5345.9 5352.1 5352.6 5355.8 8244.6 8451.5 8587.0 8599.5 8607.3 8488.7 8555.8 8580.7 8582.9 8594.5 6675.4 6735.5 6791.9 6798.1 6863.4 6519.7 6530.1 6539.1 6545.0 6546.6 7548.4 7677.9 7698.4 7701.5 7756.1 7641.6 7919.2 8011.4 8027.7 8033.3 5104.9 5315.2 6172.3 6253.1 6277.7 5521.3 5624.5 6788.6 6830.0 6851.7 6369.8 6510.9 6540.7 6592.9 6723.6 6359.7 6372.8 6393.4 6432.9 6516.3 6381.0 6394.4 6396.4 6410.5 6413.7 5915.8 6045.2 6072.2 6094.9 6099.0 6151.5 6200.6 6201.4 6201.9 6204.7 12:50:05 INFO - 2015-12-09 12:50:05,234 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,234 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4557.44 Median:5286.14 stddev:1403.25 (26.5%) stddev-sans-first:1369.35 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: Values: 245.1 246.9 247.7 249.5 253.6 5285.6 5286.7 5335.6 5349.4 5359.1 5023.0 5079.8 5158.0 5267.0 5267.9 3998.7 4007.5 4008.2 4016.8 4025.2 3791.5 3999.9 4009.1 4016.3 4016.5 3823.3 3841.1 3908.3 3909.6 3918.9 3901.1 3919.7 3922.6 3940.2 3967.2 3404.9 3407.1 3409.1 3409.8 3422.7 5055.3 5071.0 5075.3 5083.3 5088.4 4447.7 4531.5 4546.1 4546.3 4558.4 5533.7 5537.9 5540.8 5544.6 5546.2 3715.0 3719.8 3721.7 3722.1 3726.0 5760.6 5841.9 5847.9 5849.3 5869.4 3602.6 3726.1 3730.8 3794.1 3817.4 3761.4 3762.2 3762.4 3767.4 3774.8 4446.2 4449.3 4452.6 4455.2 4461.7 5555.0 5563.6 5563.7 5564.7 5580.4 1308.2 1335.9 1336.2 1337.6 1339.2 847.2 858.8 861.0 861.2 862.5 4705.6 4724.4 4775.1 4786.0 4803.7 5713.5 5720.9 5726.5 5730.8 5732.4 4639.2 4726.6 4734.8 4743.4 4770.0 3095.6 3125.7 3134.7 3136.9 3141.5 5498.8 5501.6 5502.6 5503.2 5510.8 5976.5 5983.7 5989.7 5990.2 5990.7 5361.2 5477.2 5509.5 5544.3 5550.3 5779.1 5805.4 5838.5 5841.4 5850.8 5669.8 5700.3 5708.0 5720.7 5734.0 5339.4 5502.7 5512.9 5513.8 5526.5 3789.0 3837.2 3838.8 3840.1 3840.7 5763.9 5765.4 5781.0 5791.7 5800.8 5560.1 5564.9 5567.5 5578.2 5579.3 5442.5 5585.5 5600.3 5608.4 5613.5 5503.2 5511.4 5511.8 5513.4 5515.5 5639.9 5643.8 5652.1 5653.3 5661.9 5410.1 5519.9 5523.0 5528.6 5531.7 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12421.54 Median:454.72 stddev:14250.90 (3134.0%) stddev-sans-first:14263.56 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: Values: 671.8 689.7 764.2 782.5 816.2 11366.3 11597.6 11604.7 11623.6 13472.1 13392.1 13477.6 13478.0 13494.7 13496.3 633.5 637.3 768.1 778.6 793.2 782.3 792.2 792.7 797.6 801.2 814.4 815.7 817.3 821.9 833.9 656.2 663.1 666.1 666.5 833.5 489.6 603.6 604.4 611.2 612.4 12292.6 12440.6 12447.8 12453.2 12465.0 10596.4 11049.9 11078.4 11152.2 11437.5 8567.5 8712.3 8796.8 8804.3 9077.9 3072.1 3100.7 3112.2 3174.8 3212.0 41155.2 41612.6 41650.6 41677.8 41834.6 8957.8 9065.9 9088.9 9141.2 9171.5 15128.2 15138.0 15161.0 15199.1 15222.2 5954.9 5974.4 6015.9 6092.5 6167.2 3480.7 3615.7 3621.8 3626.8 3671.8 2603.7 2652.9 2660.7 2664.0 2665.4 452.6 456.9 465.4 471.1 472.6 462.9 529.6 549.6 561.6 571.4 7245.9 7319.5 7352.9 7395.0 7547.2 414.4 543.7 557.7 600.1 619.6 3393.5 3407.6 3435.4 3464.4 4044.3 48446.5 48465.3 49787.8 51051.2 53562.0 46421.5 46892.3 47085.5 47533.8 47676.3 43669.0 43976.8 43994.0 44237.6 45016.8 8052.9 8221.8 8248.5 8540.2 8556.7 30639.4 30991.0 31038.7 31239.5 31405.4 36033.6 38752.2 39035.6 39356.8 39441.2 10393.8 10463.6 10495.8 10556.4 10722.8 11041.4 11124.2 11250.0 11343.9 11469.1 10814.1 10901.2 11047.9 11208.4 11239.4 9977.0 10215.6 10302.7 10385.5 10659.7 10271.8 10814.8 10905.3 10995.2 11024.5 8859.6 9002.1 9065.2 9292.4 9314.0 8442.8 8614.7 8625.7 9378.7 9421.2 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:50:05 INFO - 2015-12-09 12:50:05,235 DEBUG : BROWSER_OUTPUT: 12:50:05 INFO - 2015-12-09 12:50:05,971 INFO : Browser exited with error code: 0 12:50:05 INFO - 2015-12-09 12:50:05,992 INFO : Completed test dromaeo_css (00:18:37) 12:50:05 INFO - 2015-12-09 12:50:05,993 INFO : Starting test kraken 12:50:05 INFO - 2015-12-09 12:50:05,993 DEBUG : operating with platform_type : linux_ 12:50:05 INFO - 2015-12-09 12:50:05,993 INFO : Initialising browser for kraken test... 12:50:05 INFO - 2015-12-09 12:50:05,999 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0UNK6/profile http://localhost:60623/getInfo.html 12:50:10 INFO - 2015-12-09 12:50:10,254 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:50:10 INFO - 2015-12-09 12:50:10,254 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:50:10 INFO - 2015-12-09 12:50:10,254 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:50:10 INFO - 2015-12-09 12:50:10,254 DEBUG : BROWSER_OUTPUT: __metrics 12:50:10 INFO - 2015-12-09 12:50:10,355 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:50:10 INFO - 2015-12-09 12:50:10,436 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] 12:50:11 INFO - 2015-12-09 12:50:11,619 INFO : Browser initialized. 12:50:11 INFO - 2015-12-09 12:50:11,620 INFO : Running cycle 1/1 for kraken test... 12:50:11 INFO - 2015-12-09 12:50:11,620 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0UNK6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:50:23 INFO - 2015-12-09 12:50:23,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 143257600 12:50:23 INFO - 2015-12-09 12:50:23,661 DEBUG : BROWSER_OUTPUT: 12:50:26 INFO - 2015-12-09 12:50:26,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60623/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:26 INFO - 2015-12-09 12:50:26,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 178987008 12:50:26 INFO - 2015-12-09 12:50:26,854 DEBUG : BROWSER_OUTPUT: 12:50:29 INFO - 2015-12-09 12:50:29,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60623/tests/kraken/driver.html?testName=audio-dft) 12:50:30 INFO - 2015-12-09 12:50:30,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 166715392 12:50:30 INFO - 2015-12-09 12:50:30,163 DEBUG : BROWSER_OUTPUT: 12:50:33 INFO - 2015-12-09 12:50:33,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60623/tests/kraken/driver.html?testName=audio-fft) 12:50:33 INFO - 2015-12-09 12:50:33,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 154128384 12:50:33 INFO - 2015-12-09 12:50:33,720 DEBUG : BROWSER_OUTPUT: 12:50:35 INFO - 2015-12-09 12:50:35,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60623/tests/kraken/driver.html?testName=audio-oscillator) 12:50:36 INFO - 2015-12-09 12:50:36,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 156663808 12:50:36 INFO - 2015-12-09 12:50:36,367 DEBUG : BROWSER_OUTPUT: 12:50:38 INFO - 2015-12-09 12:50:38,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:39 INFO - 2015-12-09 12:50:39,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 158191616 12:50:39 INFO - 2015-12-09 12:50:39,180 DEBUG : BROWSER_OUTPUT: 12:50:42 INFO - 2015-12-09 12:50:42,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60623/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:42 INFO - 2015-12-09 12:50:42,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 158527488 12:50:42 INFO - 2015-12-09 12:50:42,782 DEBUG : BROWSER_OUTPUT: 12:50:46 INFO - 2015-12-09 12:50:46,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60623/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:46 INFO - 2015-12-09 12:50:46,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 157577216 12:50:46 INFO - 2015-12-09 12:50:46,830 DEBUG : BROWSER_OUTPUT: 12:50:49 INFO - 2015-12-09 12:50:49,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60623/tests/kraken/driver.html?testName=json-parse-financial) 12:50:50 INFO - 2015-12-09 12:50:50,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 158126080 12:50:50 INFO - 2015-12-09 12:50:50,234 DEBUG : BROWSER_OUTPUT: 12:50:52 INFO - 2015-12-09 12:50:52,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:52 INFO - 2015-12-09 12:50:52,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 169701376 12:50:52 INFO - 2015-12-09 12:50:52,579 DEBUG : BROWSER_OUTPUT: 12:50:54 INFO - 2015-12-09 12:50:54,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:55 INFO - 2015-12-09 12:50:55,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 166461440 12:50:55 INFO - 2015-12-09 12:50:55,067 DEBUG : BROWSER_OUTPUT: 12:50:57 INFO - 2015-12-09 12:50:57,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:50:57 INFO - 2015-12-09 12:50:57,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 178573312 12:50:57 INFO - 2015-12-09 12:50:57,801 DEBUG : BROWSER_OUTPUT: 12:51:00 INFO - 2015-12-09 12:51:00,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:00 INFO - 2015-12-09 12:51:00,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 182513664 12:51:00 INFO - 2015-12-09 12:51:00,906 DEBUG : BROWSER_OUTPUT: 12:51:03 INFO - 2015-12-09 12:51:03,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:04 INFO - 2015-12-09 12:51:04,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 181108736 12:51:04 INFO - 2015-12-09 12:51:04,074 DEBUG : BROWSER_OUTPUT: 12:51:05 INFO - 2015-12-09 12:51:05,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60623/tests/kraken/driver.html?testName=ai-astar) 12:51:06 INFO - 2015-12-09 12:51:06,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 238936064 12:51:06 INFO - 2015-12-09 12:51:06,073 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,077 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:51:06 INFO - 2015-12-09 12:51:06,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:51:06 INFO - 2015-12-09 12:51:06,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:51:06 INFO - 2015-12-09 12:51:06,077 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:51:06 INFO - 2015-12-09 12:51:06,077 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;108;113;113;114;103;116;114;105 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;131;153;162;131;157;156;130;167;130 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;159;162;160;161;162;161;161 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;81;100;72;72;74;118;92;72 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;94;96;95;128;95;95;130 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;109;110;109;109 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;147;147;146;214;146;146 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;94;96;95;96;94;95;95 12:51:06 INFO - 2015-12-09 12:51:06,078 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;73;72;74;74;74;73;72;71 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;68;68;69;68;68;68;68 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;84;85;84;92;84;86;84;85;85 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;130;133;116;123;119;131;121;125;119 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;147;148;149;137;135;148;156;147;139 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;68;72;70;68;69;68;70 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:51:06 INFO - 2015-12-09 12:51:06,079 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:51:06 INFO - 2015-12-09 12:51:06,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1012 12:51:06 INFO - 2015-12-09 12:51:06,080 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:51:06 INFO - 2015-12-09 12:51:06,080 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694266075__endTimestamp 12:51:06 INFO - 2015-12-09 12:51:06,080 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,083 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:113.50 stddev:4.33 (3.8%) stddev-sans-first:4.59 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 108.0 113.0 113.0 114.0 103.0 116.0 114.0 105.0 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.50 stddev:15.26 (9.8%) stddev-sans-first:15.52 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: Values: 160.0 131.0 153.0 162.0 131.0 157.0 156.0 130.0 167.0 130.0 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 159.0 162.0 160.0 161.0 162.0 161.0 161.0 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,084 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:72.00 stddev:15.93 (22.1%) stddev-sans-first:16.43 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 81.0 100.0 72.0 72.0 74.0 118.0 92.0 72.0 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:95.00 stddev:17.12 (18.0%) stddev-sans-first:17.72 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 94.0 96.0 95.0 128.0 95.0 95.0 130.0 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.30 Median:147.00 stddev:21.33 (14.5%) stddev-sans-first:22.51 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 147.0 147.0 146.0 214.0 146.0 146.0 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,085 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 94.0 96.0 95.0 96.0 94.0 95.0 95.0 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.50 stddev:1.20 (1.6%) stddev-sans-first:1.05 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 73.0 72.0 74.0 74.0 74.0 73.0 72.0 71.0 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:2.98 (3.5%) stddev-sans-first:2.55 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: Values: 91.0 84.0 85.0 84.0 92.0 84.0 86.0 84.0 85.0 85.0 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,086 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.00 stddev:5.69 (4.6%) stddev-sans-first:6.03 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: Values: 125.0 130.0 133.0 116.0 123.0 119.0 131.0 121.0 125.0 119.0 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:147.50 stddev:6.85 (4.6%) stddev-sans-first:6.74 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: Values: 137.0 147.0 148.0 149.0 137.0 135.0 148.0 156.0 147.0 139.0 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 68.0 72.0 70.0 68.0 69.0 68.0 70.0 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:51:06 INFO - 2015-12-09 12:51:06,087 DEBUG : BROWSER_OUTPUT: 12:51:06 INFO - 2015-12-09 12:51:06,935 INFO : Browser exited with error code: 0 12:51:06 INFO - 2015-12-09 12:51:06,986 INFO : Completed test kraken (00:01:00) 12:51:06 INFO - 2015-12-09 12:51:06,986 INFO : Starting test v8_7 12:51:06 INFO - 2015-12-09 12:51:06,987 DEBUG : operating with platform_type : linux_ 12:51:06 INFO - 2015-12-09 12:51:06,987 INFO : Initialising browser for v8_7 test... 12:51:06 INFO - 2015-12-09 12:51:06,993 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4FXAA/profile http://localhost:60623/getInfo.html 12:51:11 INFO - 2015-12-09 12:51:11,178 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:51:11 INFO - 2015-12-09 12:51:11,179 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:51:11 INFO - 2015-12-09 12:51:11,179 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:51:11 INFO - 2015-12-09 12:51:11,179 DEBUG : BROWSER_OUTPUT: __metrics 12:51:11 INFO - 2015-12-09 12:51:11,260 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:51:11 INFO - 2015-12-09 12:51:11,320 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] 12:51:12 INFO - 2015-12-09 12:51:12,563 INFO : Browser initialized. 12:51:12 INFO - 2015-12-09 12:51:12,564 INFO : Running cycle 1/1 for v8_7 test... 12:51:12 INFO - 2015-12-09 12:51:12,564 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4FXAA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:51:24 INFO - 2015-12-09 12:51:24,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 142090240 12:51:24 INFO - 2015-12-09 12:51:24,586 DEBUG : BROWSER_OUTPUT: 12:51:45 INFO - 2015-12-09 12:51:45,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60623/tests/v8_7/run.html (next: http://localhost:60623/tests/v8_7/run.html) 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 444182528 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |0;Richards;167.47613465081227 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.77624206200971 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 12:51:46 INFO - 2015-12-09 12:51:46,237 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: |6;Boyer;12304.878048780487 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: |7;RegExp;27324.324324324323 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: |8;Splay;603.864734299517 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: __startTimestamp1449694306236__endTimestamp 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,238 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,239 DEBUG : BROWSER_OUTPUT: Values: 167.5 12:51:46 INFO - 2015-12-09 12:51:46,239 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,239 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.78 Median:186.78 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,239 DEBUG : BROWSER_OUTPUT: Values: 186.8 12:51:46 INFO - 2015-12-09 12:51:46,240 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: Values: 278.6 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: Values: 5133.3 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,241 DEBUG : BROWSER_OUTPUT: Values: 1998.0 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: Values: 793.0 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: Values: 12304.9 12:51:46 INFO - 2015-12-09 12:51:46,242 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27324.32 Median:27324.32 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: Values: 27324.3 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.86 Median:603.86 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: Values: 603.9 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: 12:51:46 INFO - 2015-12-09 12:51:46,243 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 12:51:46 INFO - 2015-12-09 12:51:46,244 DEBUG : BROWSER_OUTPUT: Values: 4840.6 12:51:46 INFO - 2015-12-09 12:51:46,244 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:51:46 INFO - 2015-12-09 12:51:46,244 DEBUG : BROWSER_OUTPUT: 12:51:47 INFO - 2015-12-09 12:51:47,191 INFO : Browser exited with error code: 0 12:51:47 INFO - 2015-12-09 12:51:47,208 INFO : Completed test v8_7 (00:00:40) 12:51:47 INFO - 2015-12-09 12:51:47,269 INFO : Completed test suite (00:20:18) 12:51:47 INFO - 2015-12-09 12:51:47,269 DEBUG : Working with test: dromaeo_css 12:51:47 INFO - 2015-12-09 12:51:47,269 DEBUG : Generating results file: dromaeo_css 12:51:47 INFO - 2015-12-09 12:51:47,270 DEBUG : Working with test: kraken 12:51:47 INFO - 2015-12-09 12:51:47,270 DEBUG : Generating results file: kraken 12:51:47 INFO - 2015-12-09 12:51:47,270 INFO : javascript benchmark 12:51:47 INFO - 2015-12-09 12:51:47,271 DEBUG : Working with test: v8_7 12:51:47 INFO - 2015-12-09 12:51:47,271 DEBUG : Generating results file: v8_7 12:51:47 INFO - 2015-12-09 12:51:47,271 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:47 INFO - 2015-12-09 12:51:47,327 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:51:47 INFO - 2015-12-09 12:51:47,327 DEBUG : process_Request line: dromaeo_css 6305.72 graph.html#tests=[[72,132,35]] 12:51:47 INFO - 2015-12-09 12:51:47,327 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:47 INFO - 2015-12-09 12:51:47,439 DEBUG : process_Request line: kraken 1531.00 graph.html#tests=[[232,132,35]] 12:51:47 INFO - 2015-12-09 12:51:47,440 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:51:47 INFO - 2015-12-09 12:51:47,544 DEBUG : process_Request line: v8_7 19731.24 graph.html#tests=[[230,132,35]] 12:51:47 INFO - 2015-12-09 12:51:47,545 INFO : javascript benchmark 12:51:47 INFO - 2015-12-09 12:51:47,549 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.7770639495643, 2727.63176971109, 2737.7672897803686, 2747.9725202747977, 2752.944941101178, 4515.7516336601475, 4631.629469642429, 4702.435707715074, 4720.598749106326, 4740.952590474094, 4627.8380256691025, 4643.373144625474, 4727.550882666142, 4737.076270127326, 4759.4764575896625, 4207.200631879933, 4301.655597699261, 4312.956870431287, 4333.631641310492, 4481.910361792762, 4463.933041004388, 4480.148771733377, 4484.013517026249, 4502.16709908668, 4525.683202175849, 4130.669546436308, 4223.239816832969, 4237.957620423787, 4338.089001309729, 4423.049044455457, 4383.473983122014, 4393.1872603568445, 4393.978030109861, 4414.624756895668, 4425.181341451842, 4319.244132276839, 4342.435483387171, 4358.738475691469, 4385.451818522684, 4388.078503514266, 4333.328334108187, 4424.823007079713, 4451.221036318631, 4685.367475390813, 4696.794283204922, 5023.899522009576, 5083.440821509631, 5089.465606111342, 5094.923576146361, 5132.640715149941, 5146.228065790124, 5148.974255128738, 5153.896922061575, 5154.664946778447, 5157.252198431206, 4567.794449249792, 4762.476127625959, 4765.285207218945, 4767.356406885026, 4809.062232864593, 4993.525615066563, 5015.072211640858, 5168.224766285088, 5293.470652934676, 5296.311479507639, 4929.901401971941, 4935.333729946483, 4947.975260123676, 4951.9752401237765, 4969.925451118236, 4821.4696383397795, 5036.597072234213, 5049.192129259301, 5053.0904437200925, 5065.696058236444, 4840.370751802314, 4863.635227357962, 4946.505349465025, 5023.924641130313, 5046.419661738873, 5009.949900500948, 5011.123053465629, 5014.373203349582, 5020.1214787412055, 5050.090983622909, 4082.4896887889013, 4197.370394440858, 4209.052963083343, 4209.810558524874, 4214.557471465513, 3589.3000864831106, 3604.621514740967, 3605.8016809075752, 3686.6866316362875, 3711.7030637548933, 4341.479022517318, 4350.73895566267, 4354.847580334673, 4370.715903466328, 4398.670099742468, 4781.641376896747, 5134.743262836843, 5141.280220769096, 5146.330976973044, 5151.021305951857, 4237.089025859394, 4249.3413520904305, 4259.339802330644, 4306.354046892929, 4348.565143485626, 4491.079328737601, 4501.212287849613, 4502.57225563571, 4520.299353600197, 4529.818807247673, 4631.698939568917, 4832.057748738962, 4835.057163853015, 4836.371271734652, 4874.975625121851, 4997.350344455343, 5010.574101201439, 5073.061483625541, 5190.09173394662, 5207.1668533034535, 4853.708777473363, 4868.829590964299, 4876.731779752147, 4877.414710234794, 4918.458969513279, 5069.797208111781, 5090.694558326512, 5099.949000510096, 5108.182690769459, 5151.072806894795, 4792.2332426811545, 4891.413030436228, 4891.657583969088, 4997.900041999067, 5147.253648221062, 4839.201531747222, 4930.6055515557955, 4976.278439626306, 4987.301777751045, 5025.974870125626, 4956.653034287565, 4975.402951645826, 4977.850664480072, 4982.825601103944, 5034.798608055637, 4607.884802879955, 4693.155232058262, 4738.170820106398, 4741.857744267678, 4843.4430040545785, 4985.8005679772405, 5013.39839219296, 5015.272785446163, 5032.924506132338, 5055.266986287042, 4889.633277504273, 4901.681390709592, 4905.754712264444, 4906.582940450102, 4941.135301322182], "unit": "ms", "name": "dojo.html", "value": 4634.062129416113}, {"lowerIsBetter": false, "replicates": [507.2796628787122, 515.2683189870384, 517.7359546631217, 535.2880668710612, 542.3898114621052, 26683.733162668366, 27928.581071283923, 35312.82343588278, 36037.819810900975, 36084.0, 40064.39903401451, 40732.0, 40799.0, 40815.18369632606, 40839.38740918889, 6911.827204319907, 7955.482893611926, 8118.918810811875, 8119.756407307761, 8127.065387480427, 7140.7857764267155, 7240.0, 7245.6377181141, 7251.238619944883, 10142.188624910026, 10091.69724908254, 10188.541515631778, 10190.388576685385, 10194.898051019469, 10196.796064078713, 10061.597536098547, 10147.391156530557, 10152.187824973984, 10154.695359139238, 10162.0, 6942.271061538516, 7100.680469378839, 7108.537945033608, 7109.537880037781, 7113.0397396351345, 40646.796766016276, 41455.58544414547, 41692.166156677, 41729.79135104336, 41744.582554174674, 2948.86730097144, 2971.9554206686703, 3442.3115376924716, 3483.3904066788464, 3603.0992251937014, 28506.144815655356, 28779.856100719364, 28985.42029159405, 29014.12957611275, 29025.709742902513, 3268.3790079884748, 3534.717222622184, 3576.213233088716, 3577.123604716861, 3606.3328284267495, 215184.0, 216481.0, 216876.99999999843, 217354.0, 217450.99999999843, 54958.72520637371, 55282.72358638261, 55308.0, 55373.169402458996, 55432.44567554273, 59473.40526594765, 59526.0, 59777.70111149416, 59794.0, 59842.70078649666, 13968.790468142986, 14352.49766258176, 14353.497627582985, 14369.928150359181, 14383.352749126314, 11015.724606884893, 11171.0, 11207.775844483227, 11226.101911847032, 11240.606578769704, 19352.8064719351, 19774.90112549428, 19788.604227915363, 19789.703154452694, 19822.70265946012, 7601.277878601634, 7827.25641064098, 7882.211778822072, 7917.366610671133, 7918.366530677532, 848.6902280667636, 884.827458645558, 912.3020889019905, 959.3524371049514, 971.4220039076738, 26712.0, 26842.194734158005, 26869.731302686723, 27078.187654370402, 27145.59281610738, 887.6493784954906, 932.4125800745487, 969.7139343893568, 1046.7016900183412, 1066.1470823341451, 12331.630051098482, 15287.0, 15611.921940390226, 16235.025898445894, 16582.917085414494, 312562.0, 319367.0, 319511.0, 319548.0, 319935.0, 48396.7580162104, 48658.513414865396, 48772.0, 48803.0, 48915.02169956581, 1199.964001079969, 1209.9879001209874, 1217.78688729472, 1228.969275768113, 1230.8953738932291, 27419.588706169823, 28246.43507129887, 28349.14952551427, 28714.282142946595, 28805.135845924655, 39971.200575987736, 40317.0, 40438.19123617452, 40576.0, 40582.188356232116, 247416.0, 249168.0, 249191.0, 249238.0, 249393.0, 24882.875585621958, 25745.356366090997, 28589.857050714614, 28721.0, 28746.712532874404, 33130.5030424539, 33740.83129584337, 33815.492767609, 34164.82917585396, 34622.480662789574, 30605.387892241586, 31352.843235783675, 37637.2472550542, 39874.0, 40042.599574003885, 31120.0, 34026.489602656475, 37318.440223397214, 39435.80282098686, 40645.390319144644, 33694.15764605806, 38287.42568861414, 39314.0, 39407.2118557633, 39536.2092758149, 27555.862220688767, 30343.90691001805, 30808.0, 33201.66798331986, 36121.81939090288, 24043.75956240485, 24122.75877241205, 24171.0, 24346.634800477652, 24372.756272437047], "unit": "ms", "name": "ext.html", "value": 17467.967453129786}, {"lowerIsBetter": false, "replicates": [263.4717391629782, 269.71679736276906, 271.2635195444368, 272.66326087282215, 276.1508361787504, 11668.533258669664, 14821.92589037056, 14957.401703931844, 15424.61438464039, 15454.227288635566, 15291.158986255752, 15336.233188340566, 15560.610984725388, 15563.299651515681, 15586.376544938188, 5543.1408131739645, 5698.629589076697, 5713.0, 5718.370979192286, 5723.284589426322, 4113.136241389312, 4199.3281075028, 5595.63628364155, 6375.936240637604, 6609.702563384635, 6385.776497822577, 6543.1821022372205, 6548.1814773153355, 6582.045603387506, 6588.341165883421, 6458.580192287486, 6486.383793539606, 6492.772752953648, 6503.479721622259, 6506.3818937200895, 6105.481034112106, 6140.815775526741, 6209.813705588839, 6212.534059945522, 6275.560710750249, 19619.117139728747, 19941.80058199414, 19971.700424493643, 20491.28280510175, 20698.275560355465, 1726.5769886377793, 1789.096506264341, 1884.5006073390562, 1889.263187356932, 1944.8152425519554, 8765.561721913942, 8958.104189581056, 9957.90042099577, 10296.845547316796, 13250.933745331307, 1688.763573099767, 1731.5497970527626, 1776.600264940391, 1790.1675720789765, 1791.8566514678794, 50080.99838003256, 51859.22211166836, 52133.478665213624, 52182.47817521852, 53344.73327633337, 9009.504477253682, 9336.57985390659, 9621.759456013515, 9717.854232186522, 9724.319297649097, 12092.758144837055, 12094.939525302494, 12098.0, 12103.334316612494, 12123.393830308449, 6638.568493048033, 6684.665766711645, 6693.464522838161, 6695.230048544479, 6794.388505034571, 6202.100695399142, 6230.6573138476915, 6255.0, 6264.0, 6279.905801412982, 4109.794510274474, 4135.379693046068, 4150.086980864205, 4168.062186008185, 4190.497140343117, 1567.2007276288946, 1573.7482002879485, 1588.6902054099571, 1637.8853480256505, 1639.5573195237218, 812.4028838803474, 908.2960705453327, 989.1394486796534, 1004.9547770350351, 1007.2495990487134, 13363.997700172526, 14924.477643282433, 15581.0, 16117.516474505783, 16481.752773708406, 836.861917783571, 839.9370047246359, 910.8269428808505, 942.5758408716105, 959.8752162218867, 8499.405041647025, 8654.22112009922, 8694.13058694138, 8779.101650132136, 8893.955530222436, 435673.89750179136, 442464.0, 446234.0, 496351.0, 499661.0, 58253.417465825645, 61905.69047154736, 63599.682001589696, 63997.680011600576, 65292.0, 1027.6557353286732, 1043.6451606453843, 1057.0539367266254, 1061.7345663584103, 1061.803566340214, 14358.138511689333, 14454.638634034232, 14596.416143354147, 14727.705445890808, 15192.620184495476, 32601.510977335834, 32758.836205818818, 33427.665723342456, 33459.0, 33600.15999600029, 42423.787881060394, 43183.0, 44618.776906115265, 44990.0, 46198.53801461942, 8422.873656895274, 8547.145285471403, 8553.016403113721, 8576.699815506427, 8607.8708819369, 15592.220388980733, 16203.675926481168, 16243.350265989227, 16349.673006539564, 16947.491575252763, 14237.857621423653, 14344.56966291013, 14455.13269203851, 14578.927105364406, 14638.414463421344, 13552.728945421233, 14050.241343754138, 14114.659107384781, 14139.505117320845, 14527.055741376776, 14177.787333189804, 14665.193414362313, 14671.193084380035, 14912.701745964803, 15087.321070551632, 8613.26787223093, 8789.824203515765, 8848.867266991128, 8980.595873185854, 8992.86510702353, 14066.296685165906, 14134.78797818013, 14158.433662653379, 14397.712045758817, 14469.059511131743], "unit": "ms", "name": "jquery.html", "value": 8426.660054652657}, {"lowerIsBetter": false, "replicates": [1396.9022168448212, 1626.6665333606609, 1676.9161541922902, 1700.4388551777915, 1739.878208525403, 5711.343195532515, 7007.824804379887, 7228.02421673074, 7229.0, 7229.277072292768, 6943.1668199816095, 7128.251533588977, 7131.072960515139, 7135.072440582717, 7143.428525717943, 1943.5918457124021, 1983.7718662353798, 1992.3126521350184, 1996.4509759816094, 1999.270266352778, 2032.9491762705902, 2044.897755112246, 2057.77364489906, 2101.2750601042617, 2104.295061154515, 2000.8499362547793, 2018.899055047249, 2050.7231523744326, 2051.200031987526, 2052.48687828043, 2018.7173795668546, 2045.6420126477956, 2047.805458481442, 2048.866823656465, 2049.8155166035053, 1982.9405117846488, 2012.5572374077678, 2040.5918816236813, 2041.795820417961, 2045.4988527810633, 6971.372576468091, 7089.4682898782285, 7099.396551293146, 7113.217546069928, 7118.466115041392, 4148.43996060534, 4214.283571792803, 4228.640565551932, 4235.91528169438, 4244.427002354673, 2728.2088194423595, 2757.2968892932377, 2783.151138902634, 2784.3874347643687, 2816.310004049001, 852.799592095857, 856.4347530629817, 861.8190180062195, 877.7673916412156, 880.7401816464159, 9605.135537801561, 9605.807883842353, 9605.90394096057, 9611.183049440737, 9627.374220675634, 3794.354959656865, 3809.371453710107, 3813.504244448204, 3817.10298079951, 3879.4568760373572, 8393.664253429917, 8398.118197589287, 8401.873971890427, 8407.663693452316, 8410.201030902055, 4184.205001049791, 4203.789810509524, 4210.957890421118, 4212.53662097169, 4213.241616509058, 3254.902352929416, 3342.4484959981332, 3725.0873535983314, 3870.4968354113785, 3875.379939209713, 3320.5849268841393, 3397.1676939150066, 3406.267652454734, 3421.3841508528208, 3433.1588760753275, 1054.6941386997837, 1062.102523367753, 1065.3128731967838, 1066.0, 1068.4924660786064, 1174.6593487888588, 1177.8772517515104, 1199.736058067224, 1201.0451690905752, 1214.4413569757833, 6653.833654158588, 6694.631795251211, 6736.93263067363, 6756.594604323756, 6776.424003959719, 400.63542176619717, 412.83692941288024, 414.3039693315199, 414.9149424367997, 415.0391842883715, 5308.601854860901, 5345.9465405345445, 5352.116900711417, 5352.571794256528, 5355.758990845421, 8244.587770611446, 8451.492910425393, 8587.0, 8599.52702601363, 8607.268382187583, 8488.74533763988, 8555.786105347415, 8580.742577722678, 8582.914170858336, 8594.484330940164, 6675.365840245169, 6735.494837887178, 6791.898121528181, 6798.116244888133, 6863.416609588241, 6519.7392104315295, 6530.08578798978, 6539.11721917535, 6545.0, 6546.574472659262, 7548.358389536951, 7677.884831727417, 7698.422618303538, 7701.4608977371045, 7756.1468238494845, 7641.617919103911, 7919.16848730875, 8011.399145064027, 8027.719029833927, 8033.277005069572, 5104.897902042013, 5315.2292917525965, 6172.321044685171, 6253.1245625613365, 6277.717502712298, 5521.282233309644, 5624.46567576096, 6788.626625535643, 6829.965850170717, 6851.725930962705, 6369.77705780314, 6510.902336465051, 6540.672966351759, 6592.901106483502, 6723.562968407038, 6359.650219237987, 6372.840678983062, 6393.392627700361, 6432.935670643234, 6516.315786842313, 6380.968095159495, 6394.392532709385, 6396.360363963567, 6410.455111315404, 6413.743450261937, 5915.792947246826, 6045.183900173421, 6072.240969878765, 6094.939050609437, 6098.969505152446, 6151.507879369729, 6200.596961197508, 6201.379862013762, 6201.906971395342, 6204.689765511616], "unit": "ms", "name": "mootools.html", "value": 3989.1718245490283}, {"lowerIsBetter": false, "replicates": [245.08460898543947, 246.91358024691354, 247.71265332214634, 249.45618551557598, 253.56387014335343, 5285.550728188104, 5286.7356632168385, 5335.626506144571, 5349.411564727881, 5359.062164121283, 5023.015908716064, 5079.771410286537, 5158.045761534119, 5266.973665131679, 5267.86830329241, 3998.6801055915457, 4007.4589930359466, 4008.218397412491, 4016.8150395633284, 4025.1547175093265, 3791.4691943127846, 3999.9400008999887, 4009.077912080223, 4016.2770701273757, 4016.518017837849, 3823.254465379252, 3841.0973421246126, 3908.2965066288198, 3909.589493103226, 3918.8628398006076, 3901.1222474943193, 3919.7060220483577, 3922.5881282465357, 3940.1725637616137, 3967.1668949520636, 3404.9489257661153, 3407.1141503209096, 3409.062507810372, 3409.8465569049454, 3422.743294252941, 5055.317532133152, 5071.036503064406, 5075.314832497603, 5083.288339632454, 5088.389393272794, 4447.666425018137, 4531.45622525299, 4546.0680560485025, 4546.272596384596, 4558.407407037097, 5533.667979921177, 5537.889242215173, 5540.778368865241, 5544.556435485192, 5546.195801608785, 3714.9628503715157, 3719.75821571597, 3721.702263818915, 3722.0694826293425, 3726.0, 5760.6255593386295, 5841.85395365115, 5847.941520584783, 5849.298084229919, 5869.383714709937, 3602.6397360264286, 3726.087108658396, 3730.7948062856262, 3794.0704527390412, 3817.351050321452, 3761.3793724035777, 3762.247550489913, 3762.398016317376, 3767.4348847672522, 3774.7735135891935, 4446.199684056836, 4449.2658711312915, 4452.5547445255215, 4455.242608756519, 4461.665375096881, 5554.972225138929, 5563.582731295169, 5563.693996830132, 5564.721763911869, 5580.386157522669, 1308.234682710606, 1335.9265240411871, 1336.1582203211915, 1337.5519201067557, 1339.2366351179928, 847.2459511035183, 858.7810108422312, 861.0227391910227, 861.1560670542904, 862.5428522882883, 4705.6470764692785, 4724.4094488188975, 4775.092732380836, 4785.994941062347, 4803.711777293373, 5713.485786279171, 5720.885582288414, 5726.484616384545, 5730.799422020209, 5732.369439361667, 4639.234526303189, 4726.550977657117, 4734.763261836894, 4743.430788305425, 4769.952300476951, 3095.6440009399207, 3125.687431256856, 3134.686531346847, 3136.9372612547622, 3141.4816555268126, 5498.752556134984, 5501.642393244426, 5502.58730595207, 5503.174523821379, 5510.8071217507995, 5976.462118409277, 5983.730732117066, 5989.730462129215, 5990.191324171268, 5990.73041713124, 5361.195820626937, 5477.20580515823, 5509.5041446270025, 5544.251526043932, 5550.306211723615, 5779.104238842986, 5805.419458054161, 5838.532917366516, 5841.4450627190345, 5850.765969361178, 5669.801556945487, 5700.25896633435, 5708.0, 5720.6853623049465, 5734.0, 5339.3859706132735, 5502.669839809624, 5512.91730624033, 5513.8345849624575, 5526.502614764529, 3788.962110378861, 3837.2325534892575, 3838.846446142123, 3840.0591854994586, 3840.71194660396, 5763.9135412968, 5765.3946335634155, 5781.046127388934, 5791.652500849962, 5800.796972105956, 5560.110382338807, 5564.942660894417, 5567.498925096761, 5578.163275508706, 5579.3304803422225, 5442.482964118402, 5585.525230355465, 5600.327960644749, 5608.411116832837, 5613.46672066153, 5503.2020357048805, 5511.421300763523, 5511.751971161227, 5513.365962914316, 5515.503604675599, 5639.943600563942, 5643.7742490299925, 5652.123920792284, 5653.321601407857, 5661.85845353853, 5410.107332290128, 5519.917201241904, 5523.005858945428, 5528.640638358494, 5531.704342697896], "unit": "ms", "name": "prototype.html", "value": 4081.0560705371877}, {"lowerIsBetter": false, "replicates": [671.7648822911981, 689.741346994877, 764.1708746010578, 782.5304817109738, 816.1634324817059, 11366.261193022458, 11597.594084207054, 11604.65186044419, 11623.605167379905, 13472.124311919719, 13392.129511581741, 13477.595672129828, 13478.0, 13494.662633434169, 13496.257705826176, 633.4647223096499, 637.2607774981022, 768.1473564343574, 778.5717855179657, 793.2424534569486, 782.3076577229136, 792.2117493094379, 792.7265093542748, 797.6011994002998, 801.2268161224417, 814.4095530740195, 815.7267315449332, 817.2685446525356, 821.9219174178444, 833.9374546908975, 656.1797752808989, 663.1346093348179, 666.1173944523525, 666.4601672645173, 833.5373867503533, 489.605867276842, 603.6227357901312, 604.3774911840811, 611.2237458427771, 612.4426771637789, 12292.631221063382, 12440.56458023974, 12447.75104497914, 12453.1905426147, 12465.002799775995, 10596.364218146859, 11049.889501104966, 11078.446077696164, 11152.219344645879, 11437.542498300058, 8567.528785916773, 8712.346574006975, 8796.824063518694, 8804.339674524372, 9077.909220907772, 3072.109088364394, 3100.7445150758163, 3112.2219445138717, 3174.793638413496, 3212.0042786735953, 41155.1768964622, 41612.58387416148, 41650.58349416528, 41677.79161104175, 41834.581654183676, 8957.776055598662, 9065.864012039825, 9088.909110908806, 9141.177294043435, 9171.541422928827, 15128.167950762814, 15138.0, 15161.0, 15199.088054716753, 15222.162781046927, 5954.910676339859, 5974.40255974399, 6015.939840601538, 6092.543059270483, 6167.229096362955, 3480.738944579167, 3615.7468977171347, 3621.764585301947, 3626.8367923443507, 3671.834767435472, 2603.7266087060584, 2652.8540930248637, 2660.7472290132405, 2664.0, 2665.400284935874, 452.5542340794315, 456.8834947088538, 465.37407187332985, 471.09314569453664, 472.61718008412606, 462.94213223347083, 529.5842763430688, 549.6097770582851, 561.612487383704, 571.4314157860443, 7245.89131163033, 7319.5242309249725, 7352.852942941218, 7395.0, 7547.245275472409, 414.3784323514728, 543.7444401131462, 557.7490129441686, 600.1088383750127, 619.5941658213877, 3393.5418718473184, 3407.6421975692692, 3435.3644575753565, 3464.367081018394, 4044.2922488564973, 48446.515534844904, 48465.273020904715, 49787.75106124446, 51051.23423148656, 53562.0, 46421.535784641725, 46892.2966155508, 47085.52914470811, 47533.762331188125, 47676.284855727194, 43669.0, 43976.78011609922, 43994.0, 44237.557624423986, 45016.77491612521, 8052.87920681202, 8221.79445513867, 8248.505089694638, 8540.231379175904, 8556.74329770108, 30639.387212256075, 30991.0, 31038.68961310358, 31239.53140702846, 31405.371892562478, 36033.63966360407, 38752.2249555013, 39035.6096439032, 39356.80321598374, 39441.21117577575, 10393.792124157324, 10463.581456741646, 10495.842562361724, 10556.366488923239, 10722.785544289227, 11041.39272340029, 11124.221304508606, 11250.043746281657, 11343.943280283545, 11469.08247340194, 10814.134869210602, 10901.182411319025, 11047.944760276147, 11208.439578021229, 11239.438028098399, 9976.950115249378, 10215.591376344863, 10302.690919272434, 10385.480725963822, 10659.733506662396, 10271.845922311022, 10814.783704326026, 10905.291156074829, 10995.230333876552, 11024.50389732448, 8859.601317940836, 9002.099790020946, 9065.184133428023, 9292.442453452815, 9314.0, 8442.831143377221, 8614.698485552975, 8625.741227763177, 9378.718638440858, 9421.246300296098], "unit": "ms", "name": "yui.html", "value": 5660.352227716484}], "name": "dromaeo_css", "value": 6305.718170454403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 108.0, 113.0, 113.0, 114.0, 103.0, 116.0, 114.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [160.0, 131.0, 153.0, 162.0, 131.0, 157.0, 156.0, 130.0, 167.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 159.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 100.0, 72.0, 72.0, 74.0, 118.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 94.0, 96.0, 95.0, 128.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 214.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 153.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 94.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 72.0, 74.0, 74.0, 74.0, 73.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 85.0, 84.0, 92.0, 84.0, 86.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [125.0, 130.0, 133.0, 116.0, 123.0, 119.0, 131.0, 121.0, 125.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [137.0, 147.0, 148.0, 149.0, 137.0, 135.0, 148.0, 156.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 68.0, 72.0, 70.0, 68.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1531.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [186.77624206200971], "unit": "score", "name": "DeltaBlue", "value": 353.9957719999998}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [27324.324324324323], "unit": "score", "name": "RegExp", "value": 33.33970820969339}, {"lowerIsBetter": false, "replicates": [603.864734299517], "unit": "score", "name": "Splay", "value": 134.94909600000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19731.242663690526}]} 12:51:47 INFO - RETURN: dromaeo_css: 6305.72 12:51:47 INFO - RETURN: kraken: 1531.00 12:51:47 INFO - RETURN: v8_7: 19731.24 12:51:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19731.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6305.72"}}} 12:51:47 INFO - Return code: 0 12:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:51:47 INFO - # TBPL SUCCESS # 12:51:47 INFO - Running post-action listener: _resource_record_post_action 12:51:47 INFO - Running post-run listener: _resource_record_post_run 12:51:48 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505872384; Read time: 156; Write time: 596528 12:51:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 231342080; Read time: 152; Write time: 395984 12:51:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274530304; Read time: 4; Write time: 200544 12:51:48 INFO - Running post-run listener: _upload_blobber_files 12:51:48 INFO - Blob upload gear active. 12:51:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:51:48 INFO - Copying logs to upload dir... 12:51:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.888433 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-09 12:51:47.554394) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:47.558011) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010002 build_url: 'https://queue.taskcluster.net/v1/task/wRw_jiEKQDG--YhyybSzqQ/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-09 12:51:47.613595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:47.614292) ========= 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=004b26eee9c3b360c8654f40000001e1-1449687961.810922-479162502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 12:51:47.669367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 12:51:47.670099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 12:51:47.670858) ========= ========= Total master_lag: 0.32 =========