builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1449264164.0 results: success (0) buildid: 20151204125655 builduid: c54cd895ec074cd09db4ba4848f09bb9 revision: e78763a5c2c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:43.996966) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:43.997983) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:43.998760) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004623 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.018742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.019177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.033622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.034034) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.086147) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.086951) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.087950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.088685) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 13:22:44-- 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% 54.4M=0s 2015-12-04 13:22:44 (54.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.282353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.283173) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017143 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.337557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.338398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e78763a5c2c3 --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 e78763a5c2c3 --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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 13:22:44,883 Setting DEBUG logging. 2015-12-04 13:22:44,883 attempt 1/10 2015-12-04 13:22:44,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e78763a5c2c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 13:22:45,135 unpacking tar archive at: fx-team-e78763a5c2c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.911338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.912134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.923576) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.923861) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:22:44.924296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-04 13:22:44.924654) ========= /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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:45 INFO - MultiFileLogger online at 20151204 13:22:45 in /builds/slave/test 13:22:45 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 13:22:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:45 INFO - {'append_to_log': False, 13:22:45 INFO - 'base_work_dir': '/builds/slave/test', 13:22:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:22:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:45 INFO - 'branch': 'Fx-Team-Non-PGO', 13:22:45 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:45 INFO - 'config_files': ('talos/linux_config.py',), 13:22:45 INFO - 'default_actions': ('clobber', 13:22:45 INFO - 'read-buildbot-config', 13:22:45 INFO - 'download-and-extract', 13:22:45 INFO - 'populate-webroot', 13:22:45 INFO - 'create-virtualenv', 13:22:45 INFO - 'install', 13:22:45 INFO - 'run-tests'), 13:22:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:45 INFO - 'download_minidump_stackwalk': True, 13:22:45 INFO - 'download_symbols': 'ondemand', 13:22:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:45 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:45 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:45 INFO - 'installer_path': 'installer.exe', 13:22:45 INFO - 'log_level': 'info', 13:22:45 INFO - 'log_name': 'talos', 13:22:45 INFO - 'log_to_console': True, 13:22:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:45 INFO - 'opt_config_files': (), 13:22:45 INFO - 'pip_index': False, 13:22:45 INFO - 'sps_profile': False, 13:22:45 INFO - 'sps_profile_interval': 0, 13:22:45 INFO - 'suite': 'dromaeojs', 13:22:45 INFO - 'system_bits': '64', 13:22:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:45 INFO - 'title': 'talos-linux64-ix-041', 13:22:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:45 INFO - 'use_talos_json': True, 13:22:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:45 INFO - 'work_dir': 'build'} 13:22:45 INFO - ##### 13:22:45 INFO - ##### Running clobber step. 13:22:45 INFO - ##### 13:22:45 INFO - Running pre-action listener: _resource_record_pre_action 13:22:45 INFO - Running main action method: clobber 13:22:45 INFO - rmtree: /builds/slave/test/build 13:22:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:46 INFO - Running post-action listener: _resource_record_post_action 13:22:46 INFO - ##### 13:22:46 INFO - ##### Running read-buildbot-config step. 13:22:46 INFO - ##### 13:22:46 INFO - Running pre-action listener: _resource_record_pre_action 13:22:46 INFO - Running main action method: read_buildbot_config 13:22:46 INFO - Using buildbot properties: 13:22:46 INFO - { 13:22:46 INFO - "properties": { 13:22:46 INFO - "buildnumber": 1176, 13:22:46 INFO - "product": "firefox", 13:22:46 INFO - "script_repo_revision": "production", 13:22:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:22:46 INFO - "repository": "", 13:22:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:22:46 INFO - "buildid": "20151204125655", 13:22:46 INFO - "slavename": "talos-linux64-ix-041", 13:22:46 INFO - "pgo_build": "False", 13:22:46 INFO - "basedir": "/builds/slave/test", 13:22:46 INFO - "project": "", 13:22:46 INFO - "platform": "ubuntu64_hw", 13:22:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:22:46 INFO - "slavebuilddir": "test", 13:22:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:22:46 INFO - "branch": "fx-team", 13:22:46 INFO - "repo_path": "integration/fx-team", 13:22:46 INFO - "stage_platform": "linux64", 13:22:46 INFO - "builduid": "c54cd895ec074cd09db4ba4848f09bb9", 13:22:46 INFO - "revision": "e78763a5c2c3" 13:22:46 INFO - }, 13:22:46 INFO - "sourcestamp": { 13:22:46 INFO - "repository": "", 13:22:46 INFO - "hasPatch": false, 13:22:46 INFO - "project": "", 13:22:46 INFO - "branch": "fx-team-linux64-talos", 13:22:46 INFO - "changes": [ 13:22:46 INFO - { 13:22:46 INFO - "category": null, 13:22:46 INFO - "files": [ 13:22:46 INFO - { 13:22:46 INFO - "url": null, 13:22:46 INFO - "name": "https://queue.taskcluster.net/v1/task/_9I2niyFQDOwHnhLNU1lTA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:22:46 INFO - } 13:22:46 INFO - ], 13:22:46 INFO - "repository": "", 13:22:46 INFO - "rev": "378ef42875ed296adb790020ebeee26490c026d8", 13:22:46 INFO - "who": "dtownsend@mozilla.com", 13:22:46 INFO - "when": 1449260986, 13:22:46 INFO - "number": 6745819, 13:22:46 INFO - "comments": "Bug 1227981: Test that referencing a DTD from the inline options of an add-on works. r=rhelmer", 13:22:46 INFO - "project": "", 13:22:46 INFO - "at": "Fri 04 Dec 2015 12:29:46", 13:22:46 INFO - "branch": "fx-team-linux64-talos", 13:22:46 INFO - "revlink": "", 13:22:46 INFO - "properties": [ 13:22:46 INFO - [ 13:22:46 INFO - "buildid", 13:22:46 INFO - "20151204115212", 13:22:46 INFO - "Change" 13:22:46 INFO - ], 13:22:46 INFO - [ 13:22:46 INFO - "builduid", 13:22:46 INFO - "44fc70f56232404e95a37bbf72b93913", 13:22:46 INFO - "Change" 13:22:46 INFO - ], 13:22:46 INFO - [ 13:22:46 INFO - "pgo_build", 13:22:46 INFO - "False", 13:22:46 INFO - "Change" 13:22:46 INFO - ] 13:22:46 INFO - ], 13:22:46 INFO - "revision": "378ef42875ed296adb790020ebeee26490c026d8" 13:22:46 INFO - }, 13:22:46 INFO - { 13:22:46 INFO - "category": null, 13:22:46 INFO - "files": [ 13:22:46 INFO - { 13:22:46 INFO - "url": null, 13:22:46 INFO - "name": "https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:22:46 INFO - } 13:22:46 INFO - ], 13:22:46 INFO - "repository": "", 13:22:46 INFO - "rev": "e78763a5c2c3", 13:22:46 INFO - "who": "sendchange", 13:22:46 INFO - "when": 1449264065, 13:22:46 INFO - "number": 6745978, 13:22:46 INFO - "comments": "", 13:22:46 INFO - "project": "", 13:22:46 INFO - "at": "Fri 04 Dec 2015 13:21:05", 13:22:46 INFO - "branch": "fx-team-linux64-talos", 13:22:46 INFO - "revlink": "", 13:22:46 INFO - "properties": [ 13:22:46 INFO - [ 13:22:46 INFO - "buildid", 13:22:46 INFO - "20151204125655", 13:22:46 INFO - "Change" 13:22:46 INFO - ], 13:22:46 INFO - [ 13:22:46 INFO - "builduid", 13:22:46 INFO - "c54cd895ec074cd09db4ba4848f09bb9", 13:22:46 INFO - "Change" 13:22:46 INFO - ], 13:22:46 INFO - [ 13:22:46 INFO - "pgo_build", 13:22:46 INFO - "False", 13:22:46 INFO - "Change" 13:22:46 INFO - ] 13:22:46 INFO - ], 13:22:46 INFO - "revision": "e78763a5c2c3" 13:22:46 INFO - } 13:22:46 INFO - ], 13:22:46 INFO - "revision": "e78763a5c2c3" 13:22:46 INFO - } 13:22:46 INFO - } 13:22:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:22:46 INFO - Running post-action listener: _resource_record_post_action 13:22:46 INFO - ##### 13:22:46 INFO - ##### Running download-and-extract step. 13:22:46 INFO - ##### 13:22:46 INFO - Running pre-action listener: _resource_record_pre_action 13:22:46 INFO - Running main action method: download_and_extract 13:22:46 INFO - mkdir: /builds/slave/test/build/tests 13:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:46 INFO - https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/test_packages.json 13:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/test_packages.json 13:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:22:46 INFO - Downloaded 1302 bytes. 13:22:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:22:46 INFO - Using the following test package requirements: 13:22:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:22:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'jsshell-linux-x86_64.zip'], 13:22:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:22:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:22:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:22:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:22:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:22:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:46 INFO - https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:48 INFO - Downloaded 21775038 bytes. 13:22:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:22:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:22:49 INFO - Return code: 0 13:22:49 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 13:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:49 INFO - https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:50 INFO - Downloaded 21775038 bytes. 13:22:50 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 13:22:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:22:50 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 13:22:52 INFO - Return code: 0 13:22: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')]} 13:22:52 INFO - https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:53 INFO - Downloaded 11132001 bytes. 13:22:53 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 13:22:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:22:53 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 13:22:53 INFO - Return code: 0 13:22:53 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')]} 13:22:53 INFO - https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:22:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:22:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:22:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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 13:22:55 INFO - Downloaded 57695370 bytes. 13:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:22:55 INFO - mkdir: /builds/slave/test/properties 13:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:55 INFO - Contents: 13:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:22:55 INFO - Running post-action listener: _resource_record_post_action 13:22:55 INFO - Running post-action listener: set_extra_try_arguments 13:22:55 INFO - ##### 13:22:55 INFO - ##### Running populate-webroot step. 13:22:55 INFO - ##### 13:22:55 INFO - Running pre-action listener: _resource_record_pre_action 13:22:55 INFO - Running main action method: populate_webroot 13:22:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:22:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:22:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:22:55 INFO - '../fennec_ids.txt'], 13:22:55 INFO - 'tests': ['tcheck2']}, 13:22:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:22:55 INFO - '--tppagecycles', 13:22:55 INFO - '7'], 13:22:55 INFO - 'tests': ['tsvgm']}}, 13:22:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:22:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:22:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:22:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:22:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'tests': ['damp', 'tps']}, 13:22:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['damp', 'tps']}, 13:22:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:22:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:55 INFO - 'other': {'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'other_l64': {'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'other_nol64': {'tests': ['a11yr', 13:22:55 INFO - 'ts_paint', 13:22:55 INFO - 'tpaint', 13:22:55 INFO - 'sessionrestore', 13:22:55 INFO - 'sessionrestore_no_auto_restore']}, 13:22:55 INFO - 'svgr': {'tests': ['tsvgx', 13:22:55 INFO - 'tsvgr_opacity', 13:22:55 INFO - 'tart', 13:22:55 INFO - 'tscrollx', 13:22:55 INFO - 'cart']}, 13:22:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['tsvgx', 13:22:55 INFO - 'tsvgr_opacity', 13:22:55 INFO - 'tart', 13:22:55 INFO - 'tscrollx', 13:22:55 INFO - 'cart']}, 13:22:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'tests': ['tp5o']}, 13:22:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'talos_options': ['--e10s'], 13:22:55 INFO - 'tests': ['tp5o']}, 13:22:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'talos_options': ['--xperf_path', 13:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:55 INFO - 'tests': ['tp5n']}, 13:22:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:22:55 INFO - 'talos_options': ['--e10s', 13:22:55 INFO - '--xperf_path', 13:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:55 INFO - 'tests': ['tp5n']}}, 13:22:55 INFO - 'talos.zip': {'path': '', 13:22:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:22:55 INFO - Running post-action listener: _resource_record_post_action 13:22:55 INFO - ##### 13:22:55 INFO - ##### Running create-virtualenv step. 13:22:55 INFO - ##### 13:22:55 INFO - Running pre-action listener: _resource_record_pre_action 13:22:55 INFO - Running main action method: create_virtualenv 13:22:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:55 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 13:22:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:55 INFO - Using real prefix '/usr' 13:22:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:22:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:22:57 INFO - Installing pip.................done. 13:22:58 INFO - Return code: 0 13:22:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:22:58 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 13:22:58 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 13:22:58 INFO - Using env: {'DISPLAY': ':0', 13:22:58 INFO - 'HOME': '/home/cltbld', 13:22:58 INFO - 'LANG': 'en_US.UTF-8', 13:22:58 INFO - 'LANGUAGE': 'en_US:en', 13:22:58 INFO - 'LOGNAME': 'cltbld', 13:22:58 INFO - 'MAIL': '/var/mail/cltbld', 13:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:58 INFO - 'MOZ_NO_REMOTE': '1', 13:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:58 INFO - 'NO_EM_RESTART': '1', 13:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:58 INFO - 'PWD': '/builds/slave/test', 13:22:58 INFO - 'SHELL': '/bin/bash', 13:22:58 INFO - 'SHLVL': '1', 13:22:58 INFO - 'TERM': 'linux', 13:22:58 INFO - 'TMOUT': '86400', 13:22:58 INFO - 'USER': 'cltbld', 13:22:58 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:58 INFO - '_': '/tools/buildbot/bin/python'} 13:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:58 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 13:22:58 INFO - Cleaning up... 13:22:58 INFO - Return code: 0 13:22:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:22:58 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 13:22:58 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 13:22:58 INFO - Using env: {'DISPLAY': ':0', 13:22:58 INFO - 'HOME': '/home/cltbld', 13:22:58 INFO - 'LANG': 'en_US.UTF-8', 13:22:58 INFO - 'LANGUAGE': 'en_US:en', 13:22:58 INFO - 'LOGNAME': 'cltbld', 13:22:58 INFO - 'MAIL': '/var/mail/cltbld', 13:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:58 INFO - 'MOZ_NO_REMOTE': '1', 13:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:58 INFO - 'NO_EM_RESTART': '1', 13:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:58 INFO - 'PWD': '/builds/slave/test', 13:22:58 INFO - 'SHELL': '/bin/bash', 13:22:58 INFO - 'SHLVL': '1', 13:22:58 INFO - 'TERM': 'linux', 13:22:58 INFO - 'TMOUT': '86400', 13:22:58 INFO - 'USER': 'cltbld', 13:22:58 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:58 INFO - '_': '/tools/buildbot/bin/python'} 13:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:58 INFO - Downloading/unpacking psutil>=0.7.1 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:23:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:00 INFO - Installing collected packages: psutil 13:23:00 INFO - Running setup.py install for psutil 13:23:00 INFO - building 'psutil._psutil_linux' extension 13:23:00 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 13:23:00 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 13:23:00 INFO - building 'psutil._psutil_posix' extension 13:23:00 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 13:23:00 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 13:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:00 INFO - Successfully installed psutil 13:23:00 INFO - Cleaning up... 13:23:00 INFO - Return code: 0 13:23:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:23:00 INFO - Using env: {'DISPLAY': ':0', 13:23:00 INFO - 'HOME': '/home/cltbld', 13:23:00 INFO - 'LANG': 'en_US.UTF-8', 13:23:00 INFO - 'LANGUAGE': 'en_US:en', 13:23:00 INFO - 'LOGNAME': 'cltbld', 13:23:00 INFO - 'MAIL': '/var/mail/cltbld', 13:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:00 INFO - 'MOZ_NO_REMOTE': '1', 13:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:00 INFO - 'NO_EM_RESTART': '1', 13:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:00 INFO - 'PWD': '/builds/slave/test', 13:23:00 INFO - 'SHELL': '/bin/bash', 13:23:00 INFO - 'SHLVL': '1', 13:23:00 INFO - 'TERM': 'linux', 13:23:00 INFO - 'TMOUT': '86400', 13:23:00 INFO - 'USER': 'cltbld', 13:23:00 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:00 INFO - '_': '/tools/buildbot/bin/python'} 13:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:23:01 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 13:23:01 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 13:23:01 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 13:23:01 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 13:23:01 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 13:23:01 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 13:23:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:23:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:23:02 INFO - Installing collected packages: mozsystemmonitor 13:23:02 INFO - Running setup.py install for mozsystemmonitor 13:23:02 INFO - Successfully installed mozsystemmonitor 13:23:02 INFO - Cleaning up... 13:23:02 INFO - Return code: 0 13:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:23:02 INFO - Using env: {'DISPLAY': ':0', 13:23:02 INFO - 'HOME': '/home/cltbld', 13:23:02 INFO - 'LANG': 'en_US.UTF-8', 13:23:02 INFO - 'LANGUAGE': 'en_US:en', 13:23:02 INFO - 'LOGNAME': 'cltbld', 13:23:02 INFO - 'MAIL': '/var/mail/cltbld', 13:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:02 INFO - 'MOZ_NO_REMOTE': '1', 13:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:02 INFO - 'NO_EM_RESTART': '1', 13:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:02 INFO - 'PWD': '/builds/slave/test', 13:23:02 INFO - 'SHELL': '/bin/bash', 13:23:02 INFO - 'SHLVL': '1', 13:23:02 INFO - 'TERM': 'linux', 13:23:02 INFO - 'TMOUT': '86400', 13:23:02 INFO - 'USER': 'cltbld', 13:23:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:02 INFO - '_': '/tools/buildbot/bin/python'} 13:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:03 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 13:23:03 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 13:23:03 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 13:23:03 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 13:23:03 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 13:23:03 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 13:23:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:05 INFO - Downloading docopt-0.6.1.tar.gz 13:23:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:05 INFO - Running setup.py install for blobuploader 13:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:05 INFO - Running setup.py install for requests 13:23:05 INFO - Running setup.py install for docopt 13:23:06 INFO - Successfully installed blobuploader requests docopt 13:23:06 INFO - Cleaning up... 13:23:06 INFO - Return code: 0 13:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:06 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 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:06 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 13:23:06 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 13:23:06 INFO - Using env: {'DISPLAY': ':0', 13:23:06 INFO - 'HOME': '/home/cltbld', 13:23:06 INFO - 'LANG': 'en_US.UTF-8', 13:23:06 INFO - 'LANGUAGE': 'en_US:en', 13:23:06 INFO - 'LOGNAME': 'cltbld', 13:23:06 INFO - 'MAIL': '/var/mail/cltbld', 13:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:06 INFO - 'MOZ_NO_REMOTE': '1', 13:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:06 INFO - 'NO_EM_RESTART': '1', 13:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:06 INFO - 'PWD': '/builds/slave/test', 13:23:06 INFO - 'SHELL': '/bin/bash', 13:23:06 INFO - 'SHLVL': '1', 13:23:06 INFO - 'TERM': 'linux', 13:23:06 INFO - 'TMOUT': '86400', 13:23:06 INFO - 'USER': 'cltbld', 13:23:06 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:06 INFO - '_': '/tools/buildbot/bin/python'} 13:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:06 INFO - Running setup.py (path:/tmp/pip-vQB8_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:06 INFO - Running setup.py (path:/tmp/pip-JCVXaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:06 INFO - Running setup.py (path:/tmp/pip-RQZ4iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:06 INFO - Running setup.py (path:/tmp/pip-8pKNz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:06 INFO - Running setup.py (path:/tmp/pip-4DQO_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:06 INFO - Running setup.py (path:/tmp/pip-0aM75p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:06 INFO - Running setup.py (path:/tmp/pip-FRQuyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:06 INFO - Running setup.py (path:/tmp/pip-BvLVOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:06 INFO - Running setup.py (path:/tmp/pip-ji32mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:06 INFO - Running setup.py (path:/tmp/pip-zgAW24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:07 INFO - Running setup.py (path:/tmp/pip-FzAuWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:07 INFO - Running setup.py (path:/tmp/pip-M3Rjl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:07 INFO - Running setup.py (path:/tmp/pip-UWUQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:07 INFO - Running setup.py (path:/tmp/pip-9wcg6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:07 INFO - Running setup.py (path:/tmp/pip-vttMEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:07 INFO - Running setup.py (path:/tmp/pip-WMI3GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:07 INFO - Running setup.py (path:/tmp/pip-uZNMgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:07 INFO - Running setup.py install for manifestparser 13:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:07 INFO - Running setup.py install for mozcrash 13:23:07 INFO - Running setup.py install for mozdebug 13:23:07 INFO - Running setup.py install for mozdevice 13:23:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:07 INFO - Running setup.py install for mozfile 13:23:08 INFO - Running setup.py install for mozhttpd 13:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozinfo 13:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozInstall 13:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozleak 13:23:08 INFO - Running setup.py install for mozlog 13:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for moznetwork 13:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozprocess 13:23:08 INFO - Running setup.py install for mozprofile 13:23:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozrunner 13:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozscreenshot 13:23:09 INFO - Running setup.py install for moztest 13:23:09 INFO - Running setup.py install for mozversion 13:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:09 INFO - Cleaning up... 13:23:09 INFO - Return code: 0 13:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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', '-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 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:09 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 13:23:09 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 13:23:09 INFO - Using env: {'DISPLAY': ':0', 13:23:09 INFO - 'HOME': '/home/cltbld', 13:23:09 INFO - 'LANG': 'en_US.UTF-8', 13:23:09 INFO - 'LANGUAGE': 'en_US:en', 13:23:09 INFO - 'LOGNAME': 'cltbld', 13:23:09 INFO - 'MAIL': '/var/mail/cltbld', 13:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:09 INFO - 'MOZ_NO_REMOTE': '1', 13:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:09 INFO - 'NO_EM_RESTART': '1', 13:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:09 INFO - 'PWD': '/builds/slave/test', 13:23:09 INFO - 'SHELL': '/bin/bash', 13:23:09 INFO - 'SHLVL': '1', 13:23:09 INFO - 'TERM': 'linux', 13:23:09 INFO - 'TMOUT': '86400', 13:23:09 INFO - 'USER': 'cltbld', 13:23:09 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:09 INFO - '_': '/tools/buildbot/bin/python'} 13:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:09 INFO - Running setup.py (path:/tmp/pip-Rk1Q1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:09 INFO - Running setup.py (path:/tmp/pip-83o_4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:09 INFO - Running setup.py (path:/tmp/pip-sORDPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:09 INFO - Running setup.py (path:/tmp/pip-csKZz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:09 INFO - Running setup.py (path:/tmp/pip-G_wzkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:09 INFO - Running setup.py (path:/tmp/pip-QAb8xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:09 INFO - Running setup.py (path:/tmp/pip-ic1EDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:10 INFO - Running setup.py (path:/tmp/pip-OA_rHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:10 INFO - Running setup.py (path:/tmp/pip-yKSBtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:10 INFO - Running setup.py (path:/tmp/pip-JBxtZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:10 INFO - Running setup.py (path:/tmp/pip-WjL96W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:10 INFO - Running setup.py (path:/tmp/pip-sT43Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:10 INFO - Running setup.py (path:/tmp/pip-1HXffO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:10 INFO - Running setup.py (path:/tmp/pip-7nBlQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:10 INFO - Running setup.py (path:/tmp/pip-_QJmWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:10 INFO - Running setup.py (path:/tmp/pip-PRVPK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:10 INFO - Running setup.py (path:/tmp/pip-FsHnhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:12 INFO - Downloading blessings-1.5.1.tar.gz 13:23:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:12 INFO - Installing collected packages: blessings 13:23:12 INFO - Running setup.py install for blessings 13:23:12 INFO - Successfully installed blessings 13:23:12 INFO - Cleaning up... 13:23:12 INFO - Return code: 0 13:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:12 INFO - Reading from file tmpfile_stdout 13:23:12 INFO - Current package versions: 13:23:12 INFO - argparse == 1.2.1 13:23:12 INFO - blessings == 1.5.1 13:23:12 INFO - blobuploader == 1.2.4 13:23:12 INFO - docopt == 0.6.1 13:23:12 INFO - manifestparser == 1.1 13:23:12 INFO - mozInstall == 1.12 13:23:12 INFO - mozcrash == 0.16 13:23:12 INFO - mozdebug == 0.1 13:23:12 INFO - mozdevice == 0.47 13:23:12 INFO - mozfile == 1.2 13:23:12 INFO - mozhttpd == 0.7 13:23:12 INFO - mozinfo == 0.9 13:23:12 INFO - mozleak == 0.1 13:23:12 INFO - mozlog == 3.1 13:23:12 INFO - moznetwork == 0.27 13:23:12 INFO - mozprocess == 0.22 13:23:12 INFO - mozprofile == 0.27 13:23:12 INFO - mozrunner == 6.11 13:23:12 INFO - mozscreenshot == 0.1 13:23:12 INFO - mozsystemmonitor == 0.0 13:23:12 INFO - moztest == 0.7 13:23:12 INFO - mozversion == 1.4 13:23:12 INFO - psutil == 3.1.1 13:23:12 INFO - requests == 1.2.3 13:23:12 INFO - wsgiref == 0.1.2 13:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:23:12 INFO - Using env: {'DISPLAY': ':0', 13:23:12 INFO - 'HOME': '/home/cltbld', 13:23:12 INFO - 'LANG': 'en_US.UTF-8', 13:23:12 INFO - 'LANGUAGE': 'en_US:en', 13:23:12 INFO - 'LOGNAME': 'cltbld', 13:23:12 INFO - 'MAIL': '/var/mail/cltbld', 13:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:12 INFO - 'MOZ_NO_REMOTE': '1', 13:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:12 INFO - 'NO_EM_RESTART': '1', 13:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:12 INFO - 'PWD': '/builds/slave/test', 13:23:12 INFO - 'SHELL': '/bin/bash', 13:23:12 INFO - 'SHLVL': '1', 13:23:12 INFO - 'TERM': 'linux', 13:23:12 INFO - 'TMOUT': '86400', 13:23:12 INFO - 'USER': 'cltbld', 13:23:12 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:12 INFO - '_': '/tools/buildbot/bin/python'} 13:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 INFO - Cleaning up... 13:23:13 INFO - Return code: 0 13:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:13 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')]} 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:13 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')]} 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:13 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 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:13 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 13:23:13 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 13:23:13 INFO - Using env: {'DISPLAY': ':0', 13:23:13 INFO - 'HOME': '/home/cltbld', 13:23:13 INFO - 'LANG': 'en_US.UTF-8', 13:23:13 INFO - 'LANGUAGE': 'en_US:en', 13:23:13 INFO - 'LOGNAME': 'cltbld', 13:23:13 INFO - 'MAIL': '/var/mail/cltbld', 13:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:13 INFO - 'MOZ_NO_REMOTE': '1', 13:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:13 INFO - 'NO_EM_RESTART': '1', 13:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:13 INFO - 'PWD': '/builds/slave/test', 13:23:13 INFO - 'SHELL': '/bin/bash', 13:23:13 INFO - 'SHLVL': '1', 13:23:13 INFO - 'TERM': 'linux', 13:23:13 INFO - 'TMOUT': '86400', 13:23:13 INFO - 'USER': 'cltbld', 13:23:13 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:13 INFO - '_': '/tools/buildbot/bin/python'} 13:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:13 INFO - Downloading/unpacking jsonschema 13:23:13 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 13:23:13 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 13:23:13 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 13:23:13 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 13:23:13 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 13:23:13 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 13:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:15 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 13:23:15 INFO - Downloading/unpacking functools32 (from jsonschema) 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:15 INFO - warning: no files found matching '*.txt' 13:23:15 INFO - no previously-included directories found matching 'build' 13:23:15 INFO - no previously-included directories found matching 'dist' 13:23:15 INFO - no previously-included directories found matching '.git*' 13:23:15 INFO - Installing collected packages: jsonschema, functools32 13:23:15 INFO - Running setup.py install for functools32 13:23:15 INFO - warning: no files found matching '*.txt' 13:23:15 INFO - no previously-included directories found matching 'build' 13:23:15 INFO - no previously-included directories found matching 'dist' 13:23:15 INFO - no previously-included directories found matching '.git*' 13:23:15 INFO - Successfully installed jsonschema functools32 13:23:15 INFO - Cleaning up... 13:23:15 INFO - Return code: 0 13:23:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e5ae00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2520240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, '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': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', '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 13:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:23:15 INFO - Using env: {'DISPLAY': ':0', 13:23:15 INFO - 'HOME': '/home/cltbld', 13:23:15 INFO - 'LANG': 'en_US.UTF-8', 13:23:15 INFO - 'LANGUAGE': 'en_US:en', 13:23:15 INFO - 'LOGNAME': 'cltbld', 13:23:15 INFO - 'MAIL': '/var/mail/cltbld', 13:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:15 INFO - 'MOZ_NO_REMOTE': '1', 13:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:15 INFO - 'NO_EM_RESTART': '1', 13:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:15 INFO - 'PWD': '/builds/slave/test', 13:23:15 INFO - 'SHELL': '/bin/bash', 13:23:15 INFO - 'SHLVL': '1', 13:23:15 INFO - 'TERM': 'linux', 13:23:15 INFO - 'TMOUT': '86400', 13:23:15 INFO - 'USER': 'cltbld', 13:23:15 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:15 INFO - '_': '/tools/buildbot/bin/python'} 13:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:15 INFO - Downloading/unpacking flake8 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:17 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 13:23:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:23:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:23:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:18 INFO - no previously-included directories found matching 'docs/_build' 13:23:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:18 INFO - Running setup.py install for pep8 13:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:18 INFO - no previously-included directories found matching 'docs/_build' 13:23:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:18 INFO - Cleaning up... 13:23:18 INFO - Return code: 0 13:23:18 INFO - Running post-action listener: _resource_record_post_action 13:23:18 INFO - Running post-action listener: _start_resource_monitoring 13:23:18 INFO - Starting resource monitoring. 13:23:18 INFO - ##### 13:23:18 INFO - ##### Running install step. 13:23:18 INFO - ##### 13:23:18 INFO - Running pre-action listener: _resource_record_pre_action 13:23:18 INFO - Running main action method: install 13:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:18 INFO - Reading from file tmpfile_stdout 13:23:18 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:18 INFO - Reading from file tmpfile_stdout 13:23:18 INFO - Output received: 13:23:18 INFO - Usage: mozinstall [options] installer 13:23:18 INFO - Options: 13:23:18 INFO - -h, --help show this help message and exit 13:23:18 INFO - -d DEST, --destination=DEST 13:23:18 INFO - Directory to install application into. [default: 13:23:18 INFO - "/builds/slave/test"] 13:23:18 INFO - --app=APP Application being installed. [default: firefox] 13:23:18 INFO - mkdir: /builds/slave/test/build/application 13:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:23:33 INFO - Reading from file tmpfile_stdout 13:23:33 INFO - Output received: 13:23:33 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:33 INFO - Running post-action listener: _resource_record_post_action 13:23:33 INFO - ##### 13:23:33 INFO - ##### Running run-tests step. 13:23:33 INFO - ##### 13:23:33 INFO - Running pre-action listener: _resource_record_pre_action 13:23:33 INFO - Running main action method: run_tests 13:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:33 INFO - Python 2.7.3 13:23:33 INFO - Return code: 0 13:23:33 INFO - grabbing minidump binary from tooltool 13:23:33 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')]} 13:23:33 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 0x25af0b0>, '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 0x25affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:33 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 13:23:33 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 13:23:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:33 INFO - Return code: 0 13:23:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:23:34 INFO - Return code: 0 13:23:34 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/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test/build 13:23:34 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/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 13:23:34 INFO - Using env: {'DISPLAY': ':0', 13:23:34 INFO - 'HOME': '/home/cltbld', 13:23:34 INFO - 'LANG': 'en_US.UTF-8', 13:23:34 INFO - 'LANGUAGE': 'en_US:en', 13:23:34 INFO - 'LOGNAME': 'cltbld', 13:23:34 INFO - 'MAIL': '/var/mail/cltbld', 13:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:34 INFO - 'MOZ_NO_REMOTE': '1', 13:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:34 INFO - 'NO_EM_RESTART': '1', 13:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:34 INFO - 'PWD': '/builds/slave/test', 13:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:34 INFO - 'SHELL': '/bin/bash', 13:23:34 INFO - 'SHLVL': '1', 13:23:34 INFO - 'TERM': 'linux', 13:23:34 INFO - 'TMOUT': '86400', 13:23:34 INFO - 'USER': 'cltbld', 13:23:34 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654', 13:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:34 INFO - '_': '/tools/buildbot/bin/python'} 13:23:34 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/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 13:23:34 INFO - mozversion INFO | application_buildid: 20151204125655 13:23:34 INFO - mozversion INFO | application_changeset: e78763a5c2c3f790c164f5d0eec69d680e97d8ad 13:23:34 INFO - mozversion INFO | application_display_name: Nightly 13:23:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:34 INFO - mozversion INFO | application_name: Firefox 13:23:34 INFO - mozversion INFO | application_remotingname: firefox 13:23:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:23:34 INFO - mozversion INFO | application_vendor: Mozilla 13:23:34 INFO - mozversion INFO | application_version: 45.0a1 13:23:34 INFO - mozversion INFO | platform_buildid: 20151204125655 13:23:34 INFO - mozversion INFO | platform_changeset: e78763a5c2c3f790c164f5d0eec69d680e97d8ad 13:23:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:23:34 INFO - mozversion INFO | platform_version: 45.0a1 13:23:34 INFO - 2015-12-04 13:23:34,359 DEBUG : using testdate: 1449264214 13:23:34 INFO - 2015-12-04 13:23:34,359 DEBUG : actual date: 1449264214 13:23:34 INFO - 2015-12-04 13:23:34,368 INFO : starting webserver on 'localhost:40754' 13:23:34 INFO - 2015-12-04 13:23:34,369 INFO : Starting test suite talos-linux64-ix-041 13:23:34 INFO - 2015-12-04 13:23:34,369 INFO : Starting test dromaeo_css 13:23:34 INFO - 2015-12-04 13:23:34,369 DEBUG : operating with platform_type : linux_ 13:23:34 INFO - 2015-12-04 13:23:34,370 INFO : Initialising browser for dromaeo_css test... 13:23:34 INFO - 2015-12-04 13:23:34,386 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpap6Hgv/profile http://localhost:40754/getInfo.html 13:23:39 INFO - 2015-12-04 13:23:39,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:23:39 INFO - 2015-12-04 13:23:39,292 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:23:39 INFO - 2015-12-04 13:23:39,292 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:23:39 INFO - 2015-12-04 13:23:39,292 DEBUG : BROWSER_OUTPUT: __metrics 13:23:39 INFO - 2015-12-04 13:23:39,401 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] 13:23:39 INFO - 2015-12-04 13:23:39,401 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] 13:23:40 INFO - 2015-12-04 13:23:40,422 INFO : Browser initialized. 13:23:40 INFO - 2015-12-04 13:23:40,422 INFO : Running cycle 1/1 for dromaeo_css test... 13:23:40 INFO - 2015-12-04 13:23:40,423 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpap6Hgv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:23:52 INFO - 2015-12-04 13:23:52,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 142868480 13:23:52 INFO - 2015-12-04 13:23:52,428 DEBUG : BROWSER_OUTPUT: 13:24:43 INFO - 2015-12-04 13:24:43,660 DEBUG : BROWSER_OUTPUT: 1449264283656 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] 13:26:55 INFO - 2015-12-04 13:26:55,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40754/tests/dromaeo/cssquery-ext.html) 13:26:56 INFO - 2015-12-04 13:26:56,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 227868672 13:26:56 INFO - 2015-12-04 13:26:56,862 DEBUG : BROWSER_OUTPUT: 13:29:59 INFO - 2015-12-04 13:29:59,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-ext.html (next: http://localhost:40754/tests/dromaeo/cssquery-jquery.html) 13:29:59 INFO - 2015-12-04 13:29:59,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 222916608 13:29:59 INFO - 2015-12-04 13:29:59,955 DEBUG : BROWSER_OUTPUT: 13:33:02 INFO - 2015-12-04 13:33:02,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40754/tests/dromaeo/cssquery-mootools.html) 13:33:02 INFO - 2015-12-04 13:33:02,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 209436672 13:33:02 INFO - 2015-12-04 13:33:02,675 DEBUG : BROWSER_OUTPUT: 13:36:04 INFO - 2015-12-04 13:36:04,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40754/tests/dromaeo/cssquery-prototype.html) 13:36:05 INFO - 2015-12-04 13:36:05,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 203698176 13:36:05 INFO - 2015-12-04 13:36:05,196 DEBUG : BROWSER_OUTPUT: 13:39:08 INFO - 2015-12-04 13:39:08,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40754/tests/dromaeo/cssquery-yui.html) 13:39:08 INFO - 2015-12-04 13:39:08,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 210296832 13:39:08 INFO - 2015-12-04 13:39:08,650 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/dromaeo/cssquery-yui.html (next: http://localhost:40754/tests/dromaeo/cssquery-dojo.html) 13:42:11 INFO - 2015-12-04 13:42:11,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 234901504 13:42:11 INFO - 2015-12-04 13:42:11,714 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,715 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:42:11 INFO - 2015-12-04 13:42:11,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:42:11 INFO - 2015-12-04 13:42:11,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:42:11 INFO - 2015-12-04 13:42:11,716 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:42:11 INFO - 2015-12-04 13:42:11,717 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2600.505903878263;2720.4695084458526;2731;2737.4661940921515;2740.191643465178;4578.633709303256;4681.7659117044095;4709.952900470998;4713.34013238147;4745.8813529661775;4629.583337499625;4679.321498382733;4724.574788269055;4726.0784147091335;4806.182948898687;4322.805473753673;4337.478964820216;4352.303631418974;4356.3465480178065;4431.446069241345;4201.936970945439;4415.050764085721;4425.24770788965;4467.17357288901;4489.034857505636;4218.0720241546815;4315.525292217853;4326.134773045388;4326.134773045404;4347.891302717458;4310.331898555697;4357.956420435787;4361.127774445124;4362.127574485084;4405.515393306734;4334.11150714106;4334.804933777988;4341.3487976803735;4365.956340436618;4382.452193475816;4388.473383194005;4509.323601459774;4517.096580683843;4519.7740112994215;4530.977345113286;4858.441279252896;4981.12830254704;4989.077020751172;4993.425756038029;5015.4733752956145;5081.466446023152;5094.821681241138;5095.515925987025;5136.897262054776;5142.948570514322;4595.126925884071;4697.976510117462;4710.0344429392235;4712.128256272601;4719.598834099072;5136.640435169502;5228.215767634885;5242.16125419931;5259;5262.868428289246;4972.950270497248;5007.4491805901325;5012.298278241049;5015.24771284303;5057.772400241998;4866.197077482176;4976.104301225741;4977.1538838397555;5094.872628184325;5109.310243117206;4850.296706977469;4878.365812444359;4896.094222568836;5023.372078490189;5033.974830125826;4976.850694479099;5001.224810154432;5001.8499445016705;5006.4743201964;5044.672096313728;4205.894852628709;4206.26390381682;4207.1375368050085;4207.957920420818;4253.21315556623;3581.516495273157;3609.5488063992;3695.297893400299;3698.334299826003;3714;4360.716553424018;4373.081652852873;4391.055922976511;4411.205982923105;4422.137683151755;5066.898662026812;5069.771860266297;5069.8732531687;5077.593792496591;5118.10433174193;4206.074663574009;4293.742375457483;4300.118475712471;4318.848840290575;4364.934525982113;4383.60547550722;4421.889452763707;4448.822047118144;4487.125010622897;4493.078918821634;4751.524847515221;4789.808407663654;4809.038192361471;4809.062232864558;4870.537298956593;4771.260454629538;4945.233488809096;5041.117804384291;5046.6719663221775;5057.988402319477;4707.952920470889;4775.044991001883;4784.354112194809;4789.329493870791;4829.251466022632;4979.153543897473;4999.150144475375;5015.573676237561;5018.172001619692;5062.038212739568;4818.566329030404;4917.311576379238;5096.923546146885;5108.131617624938;5135.87160320995;4748.453927798348;4806.8798280043275;4827.806887724451;4840.975795121143;4868.610511159028;4905.877353066202;4926.965337279212;4935.4570997190995;4941.160002799461;4967.05625931072;4673.322368256516;4794.496577859414;4842.685225460334;4843.878903027453;4893.559579637849;4878.341423907727;4897.240927656219;4961.131801934719;4973;5027.949720502748;4819.373481447529;4820.084184005028;4824.782884770124;4827.058723548875;4866.391701037371 13:42:11 INFO - 2015-12-04 13:42:11,720 DEBUG : BROWSER_OUTPUT: |1;ext.html;586.6040422714666;589.828949604615;592.4223881715327;597.3011576455547;599.3736545310151;27158.5926211107;34493.82753086234;35743.285134297366;35749.46375804359;35784.64215357849;39040.80479597605;39636;39649.801750991275;39686;39737;6940.30596940307;7056.717731290768;7811.179826118261;7972.043354797433;7974.880376794353;9787.755306117333;10043;10046;10047.849282260771;10063;9681.12869841714;9751.90248097517;9753.366031207985;9796.608135674565;9798.216142708567;7147;7330.230325815766;7343.265673432614;7351.191368949411;9515.90484095157;10091.394516329045;10360.792784144274;10364.429956352473;10368.585256589728;10384.584616615326;37037.44443833345;37384.38309318349;37460;37481.812590937145;37574.81212593919;2688.8924443022256;2730.84980326082;2736.2201772494745;2803.7756979441597;2818.7744980401517;27087;27437.58843617347;27604.723952760418;27632.309192270353;28244.85877570599;3208.711215990572;3222.5166225066428;3236.773425860191;3248.3665685191395;3314.7016768490953;216603;216674;217037;217791;217846;49771.50228497741;50670.74664626727;53105.46894531082;53399;53977.73011134998;47266.29100563494;47461.050778984914;47655.52344476511;47676.523234767905;47696.7615161922;14133.929330353489;14212.218327991854;14308;14322.355494002586;14345.067570607876;10865.83701244482;10971.83542246867;10973.231873768918;10993.780124397466;10994.230403871812;18152.273909043754;18241.36155234587;18374.35689750879;18416.539586510444;18539.629207415775;7234.24040475753;7518.3609393201095;7578.355839753683;7596.164421913585;7607.125180604301;960.9663661771805;985.2019863910256;1007.7178390050798;1010.7978404319166;1042.4475028235047;25933.870330648228;25957.22128336153;25981;26211.34471638186;26315.473690526083;978.515634760798;978.7797745507346;980.26969907418;1000.6547741029333;1070.1438848920832;13515.864841351657;13784.724305513833;13916.652083697989;13933.442662293597;13965.511207107702;269574;274584;274691;274747;275005;45371.319430208576;45582;45635.08729825385;45740.771296143306;45828.31257531073;1040.942748148859;1222.0895432902366;1226.7178548933796;1227.2145826670937;1241.7764802335485;20090.69863952071;24807;25158.993640254186;25180.845160548306;26768.33079173036;36582.63417365792;36855.44716829303;36872;36912.81543592265;36922.33849476834;217637;221179;221480;223066;337105;28372.85813570919;28550.42899142047;28591.85704071466;28793.7120628791;28974.130776076752;38087.238255235294;39004.80497597494;39707.60292397039;39708.043793431214;39858.800705996284;31119.844400777853;32805.671943280264;33160.834195828866;33501.49747753737;35087;31532;31842.522362164123;31844;32002.35995280128;32115.83942080368;32057;32602.51096233606;32821;32902.01293961185;33032.50451243281;28506.287342816595;29192.708072919;31292.530612041293;32592.948093045616;32698.182545436553;23033.769662303162;23136.190233341753;23242;23388.76611233934;23495.295141145794 13:42:11 INFO - 2015-12-04 13:42:11,721 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.5739275031585;334.31632311922124;334.5182936571337;335.92503987240804;336.77604393078605;12603;13007.089503734742;14974.475893343735;15363.692726145484;15852.524424267262;8722.91277087229;9311.348205625609;9665.66170184042;9685.467299298536;9945.701628951125;4406.823727050914;4514.322851572258;4514.435695538058;4531.841385551506;4533.0253995390985;3317.303366293081;3402.982985085071;4515.345274935149;5061;5214.165733482643;5161.535461808437;5193.013327467788;5193.63644544882;5199.14214154664;5215.374155101393;5167.044096842077;5409.26974858393;5775.711214439261;5787.942120578825;5790.594658373915;5094.974525127388;5108.284840122349;5116.053530096944;5123.359580052494;5128.640995130342;18247.270109195615;18518.259269629198;18616.441506754818;18670.25318987239;19409.320673776492;1719.3982106262833;1782.6523827853573;1834.4038187588953;1852.1757817770963;1882.3129557711475;10477.423741694203;12497.625071247878;12516.436760345716;12832.550860719923;12916.935415322958;1690.5689049292475;1721.070621864192;1725.8878172918846;1779.973300400495;1782.9375971841052;54731.452685473036;55913.16130258049;57572.13641795376;58049.709751451395;58884;9329.580168892417;9534.427934323963;9718.222542196607;9734.36726612768;9798.755031124136;12455.377231138587;12470.625881223577;12471;12493.18794278369;12494.187877787916;6707.228668703162;6934.826629334307;6948.6178260196175;7019.92980070203;7036.824079398056;6695.531312808057;6707.765228216989;6730.02414649873;6734.292899245509;6762.628055456997;4125;4136.751794892316;4161.10536234705;4177.540470548237;4194.622483976456;1544.2047345617016;1603.8155612104758;1635.8936669116708;1649.3567508671629;1696;827.0695467598952;843.1231519219942;864.6152462154407;869.365363284793;940.9294302927308;13421.328933553283;13867.306634668226;15653.843461565466;15949.760753588705;16187.352505899633;838.0906716212977;873.0963452826421;883.9469631822111;909.9727008189765;913.7304495173939;9007.909920900838;9186.770330741785;9191.126842949909;9197.402168859002;9318.580663870142;471584;474721;480177;488364;488910;65082.67458662677;66366.33633663699;68164;71089.2891071093;77898.2210177891;414.14065813437236;436.1059827353912;437.5515097025511;438.2855944810003;439.2949316347281;9064.592093355683;9181.49501777382;9355.25157987373;9651.083147101295;9655.517224138905;32330;32728.50907236441;32802.67197327996;33113.33773324568;34130.65869341275;39579.60420395759;39635.80182099071;39767.2046559073;41229.1754164909;41269.793651031556;8589.355798315026;8716.477011379338;8794.29645628361;8951.239144672516;8978.147076027766;10435.843462348223;10557.683269501927;16061.11663858499;16532.917335413247;16719.665606688042;8185.222403871623;13744.312784360942;14071.648208794863;14203.360848761624;14278.500252491112;8343.457675251331;8397.118302578141;8619.956900215459;8630.56847157627;8932.330075244252;7672.80817979555;8010.359171266401;8653.264472519906;8925.910740892508;8969.192772650493;13994.16035037901;14349.497767578085;14511.709765804413;14583.489577864724;14639.48761793332;14004.649883752987;14227.857721422653;14364.85635143677;14847.480338188112;14935.954483186508 13:42:11 INFO - 2015-12-04 13:42:11,724 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1393.2058726525881;1409.2037998530823;1429.3425024488736;1453.3024148408763;1465.8314293856204;6156.938430615693;6761.56049856759;7131.536450130738;7143.285671432861;7160.10498687664;7034.542754720939;7117.644117794102;7169.46229032822;7176.138863336394;7180.210176880539;1751.8598512119063;1793.7757780277466;1980.87124336918;2004.9398518044482;2011.2256781139295;2054.8972551372444;2062.865913715611;2066.731324927757;2066.7623223329283;2068.927587534429;1957.6476234277825;1972.6646470100045;2001.7497812773404;2006.107282259395;2007.8393728501758;2017.9293724719712;2039.3474088291753;2041.0917141871873;2079.490524821421;2080.479880029985;2039.4901274681329;2063.504758857863;2063.9484012899647;2066.7519897612383;2067.7622073461594;6872.862542749167;6975.546589471719;6979.092717946685;7007.544509606859;7017.964910175417;4107.876763697094;4179.728317659373;4179.958200417987;4200.936985945214;4202.054537729017;2321.1527792355837;2608.739126087395;2741.821781584191;2749.42262124952;2760.530709779322;792.7661339904741;796.195842199377;803.5058439059936;804.0753133896008;850.9361797865123;9042.638294468214;9077.546122693839;9161.038091000415;9173.724788256362;9215.216706579882;3809.2381523694817;3816.542014958223;3880.7865567394065;3898.9610103899167;3903.590123037097;8104.756857294291;8128.268455839003;8139.877901831477;8140.023197216372;8148.959255203686;4178.895527611773;4189.120284740238;4199.2441360554785;4205.011822221775;4208.6633069354375;3833.6358045985585;3837.2325534893134;3842.346801043829;3845.8653947111716;3850.1914597934747;3310.7185889199686;3310.8013519188926;3324.1855745342546;3329.5505106810756;3346.748993825473;1057.8095942730383;1064.0423618743039;1070.6948519671855;1078.9838152427562;1079.7192729890285;1177.0230708511915;1183.2131632464486;1199.7060720123625;1200.6038007457519;1212.6907638552113;6696.129503164558;6777.186737591422;6786.626735529593;6797.966010169917;6798.320167983162;372.88440583419225;384.90762217067703;385.4796025365734;385.5046265548812;386.3412881037824;5274.894502109936;5310.468953104736;5326.840194794162;5341;5349.518543331119;8069.435139540175;8088.069871964682;8266.917330826735;8272.255497005299;8391.790205244917;8274.8345033099;8275.172482751797;8347.624356903954;8353.081161072278;8359.498430094214;6597.703103360361;6614.074029635759;6624.370684784938;6687.799366019027;6746.932530674729;6724.226713927766;6791.93208067913;6794.864102717819;6796.2524122347495;6799.864002720017;7584.241575842592;7683.231676832272;7719.343855772097;7749.186335434923;7828.060632724109;7865.646045927832;7885.250901164381;7916.84166316682;8027.478213916077;8041.597920104088;6460.838479038061;6533.118029066205;6544.280129185881;6545.37818907203;6560.343965603402;6679.165104361955;6889.793306200822;6902.723891044503;6914.239433662394;6920.8961865573065;6405.455536279468;6463.547551671338;6519.869602607826;6571.474282057519;6596.538242323183;6381;6405.135306733531;6486.643234621953;6494.577852439576;6556.573822701509;6299.244090708961;6391.456726178327;6393.1688880445245;6406.327335629878;6417.197850268716;6022.638641681513;6024.367441418588;6027.36712645166;6032.90950635732;6058.90911636317;5414.377346605191;5856;6036.185115009417;6036.63780173191;6115.938840611537 13:42:11 INFO - 2015-12-04 13:42:11,725 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.3924467485293;295.6924798209862;297.85702862625936;303.0756193609492;306;5270;5301.7879284828605;5317.069512835253;5324.600654950879;5350.35795704515;5027.572656324217;5085.923711144326;5172.431032586413;5190;5279.894402111965;4097.774622395767;4105.999999999993;4126.0510082681;4130.772807495587;4136.648384887273;4103.466549348595;4111.36273877548;4115.218108559364;4120.443740095094;4127.401526778615;3857.3635350167187;3959.960400395988;3969.2458432897656;4067.6542493888055;4083.8570650027254;4081.9183616327805;4084.101497670508;4098.774567398792;4099.508059032905;4100.0569868930315;3612.4581312803025;3613.5483064616924;3615.4576813477925;3621;3623.7644553103964;5020.648554601143;5039.44566097729;5047.116754567973;5049.64652474327;5052.57053150479;4499.280115181588;4587.816487340502;4589.472210695746;4703.412073490814;4709.952900470986;5515.255440515519;5523.6409633373705;5526.917096243559;5533.280673512458;5535.529479994206;3776.527934008249;3776.8866933992026;3781.9599610107166;3781.9810900945595;3786.318462676717;5724.112762521816;5799.420057994209;5804.013317735995;5813.128030795415;5814.360420353758;3828.8659896903473;3937.8818635440985;3947.624975627311;3970.1861118470642;3987.2623564640635;4020.336644453691;4032.2540330039037;4034.495688038995;4034.515858097047;4036.1524079942956;4596.37948876904;4612.7001744886475;4624.9768751156025;4640.628749700016;4644.256918892961;5537.861553461115;5543.916841247385;5550.639208451437;5551.056320425538;5553.444655534495;1337.77257866163;1366.8291463567055;1386.202933313349;1394.268009295108;1423.8860891128684;930.1442672741094;934.065934065934;947.5688561704408;949.6723630347519;958.434523631061;4819.277108433693;4856.3201151838775;4866.367372241586;4872.610191184696;4875.268709693574;5684.971575142098;5695.145728140812;5697.601167918288;5700.686462244534;5705.515031222392;4858.246971719389;4865.683730557503;4866.367372241657;4868.367112275381;4871.2206047032305;3003.339265361617;3026.379592183597;3066.5246886732593;3068.861901214451;3069.64699059611;5504.2018907258225;5528.778848846082;5551.583631227593;5554.250176226238;5557.194206839986;5955.255593050869;5956.880862382728;5968.46283834457;5971.313298970587;5974.103884417372;5521.033819081645;5541.5289700375915;5554.277943867352;5554.416786237468;5557.861053473695;5620.634658747168;5772.682502462405;5781.335146458211;5783.537317014713;5785.132230165341;5651.57613179005;5661.980843448054;5665.093585026376;5665.688387138582;5669.801556945487;5513.58648101402;5517.613767036269;5548.611597188158;5550;5551.7779288828;3899.434581985653;3938.9212215756097;3946.3488524393156;3947.131631041166;3957.3470377387407;5572.108462645957;5588.608797384307;5761.452661997104;5790.218320526844;5802.912956305743;5446.210299506629;5489.725513724377;5570.6657600544095;5579;5591.9720401397735;5547.944520554905;5565.1374037024325;5570.415106413769;5570.860728481658;5572.86067848307;5428.240046393587;5441.646292990943;5444.6188766785945;5452.781888724565;5454.836354909359;5478.479544443431;5604.8318550443555;5608.046632072639;5615.971920140373;5618.52242559387;5441.564674825925;5444.6188766785945;5452.645578037414;5455.236266922713;5457.536109430743 13:42:11 INFO - 2015-12-04 13:42:11,727 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.1643660480631;761.3680645064594;801.4389927051064;810.7000409848357;819.3854609043218;10889.401082940434;11070.28043177193;11076.446177691114;11089.112870970323;11103.333799971997;11881;11995.460204290806;12017;12060;12084.456199471022;615.3047056825781;627.9780207692731;787.299303619776;809.6113865344638;809.7085049382217;805.2189376304975;805.6334367862609;812.9268365847073;814.4176913506841;815.176671561721;636.0491065856551;825.0470706334164;829.6142293833366;836.0343802907621;836.3727204596553;635.9014352775328;818.2022528035147;842.4650347029681;845.1717317029315;845.3786466946789;610.7526451787033;617.2777849915565;617.6664601115392;617.8980468222738;618.1778234947509;11298.830517542161;11436.542538298458;11442.027427668658;11480.655580332603;11496.827547586792;11297.152713546435;11803.822942655866;11805.114616403804;11915.821262681067;12402.875971240263;8954.597043133075;9088.50013249271;9516.095970882756;9689.32174747768;9694.466804325759;3213.9875939079348;3226.3869864725625;3261.8205998670064;3297.3570153820015;3344.9832750836335;38597.80701096504;38766.61233387658;39011.219775604615;39126.217475650614;39239.8038009811;9299.302552308603;9396.01341859095;9433.151016408556;9617.374870633386;9681.70954871355;17161.056141912315;17183.65632687339;17191.828081719024;17198.226079826436;17210.31158753636;6283.403076707706;6435.227772667216;6462.612243265419;6569.080328753978;6593.241777195588;3545.37955857729;3596.82015899204;3648.4892115103908;3660.5973342932257;3693.316736403774;2760.8205466645004;2809.325761817149;2821.3510892494432;2821.4498172856506;2839.261791934112;504.76023888653333;518.7432221050605;521.3457111325263;522.0628970996994;527.1881302793655;557.5901712241499;581.6742624130501;588.5703436491385;595.1637948682109;599.5054080383701;7651.923480765233;7723.382129429745;7883.881741773878;8643.697470588499;8857.291416686778;437.9737215767064;467.63057184823606;545.9208414779914;593.092568370394;618.1685632823845;3581.659742324475;3597.8201089945396;3681.668649821529;3730.570984336836;3878.7672739635714;49314;49818.519962804065;50068.49931500711;50135;50239.74880125576;42853;42914.570854291684;43264.35103473451;43366.13267734628;45128.54871451309;40844.38733419001;40984.59015409927;41116.38325425121;41277.58722412797;41534.1693166135;8098;8115.797105072184;8229.25936665703;8346.374021948257;8359.916400835913;29865;30098.548521772627;30630;32213.194670133435;32588.83705581457;37460.81269593634;38453.230935381696;38706.225875482894;39014.6098539011;39359.80320098381;9984.251181161297;10406.1785751633;10537.736556586147;10582.470876455993;10691;10883.23817332779;10952.069074128789;11039.282446640942;12221.144519883523;12236.816447753468;10629;11117.666470005914;11174.608888688857;11652.242604230698;11702.122340824642;10820.296680715728;11169.050630696156;11292.378919159524;11471.541138354372;11498;8542.359323050672;9706.417614943126;10487;11290.15323850698;11360;8704.434211776213;8998.640054398013;9052.637894484411;9334.159925606727;9483.715488535356;8774.780630484289;9014.864777028219;9082.046385129466;9168.768756792317;9239.86140207884 13:42:11 INFO - 2015-12-04 13:42:11,727 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:42:11 INFO - 2015-12-04 13:42:11,727 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:42:11 INFO - 2015-12-04 13:42:11,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874 13:42:11 INFO - 2015-12-04 13:42:11,727 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:42:11 INFO - 2015-12-04 13:42:11,728 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265331714__endTimestamp 13:42:11 INFO - 2015-12-04 13:42:11,728 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,728 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:42:11 INFO - 2015-12-04 13:42:11,728 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:42:11 INFO - 2015-12-04 13:42:11,728 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,729 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4646.87 Median:4789.81 stddev:484.99 (10.1%) stddev-sans-first:459.14 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: Values: 2600.5 2720.5 2731.0 2737.5 2740.2 4578.6 4681.8 4710.0 4713.3 4745.9 4629.6 4679.3 4724.6 4726.1 4806.2 4322.8 4337.5 4352.3 4356.3 4431.4 4201.9 4415.1 4425.2 4467.2 4489.0 4218.1 4315.5 4326.1 4326.1 4347.9 4310.3 4358.0 4361.1 4362.1 4405.5 4334.1 4334.8 4341.3 4366.0 4382.5 4388.5 4509.3 4517.1 4519.8 4531.0 4858.4 4981.1 4989.1 4993.4 5015.5 5081.5 5094.8 5095.5 5136.9 5142.9 4595.1 4698.0 4710.0 4712.1 4719.6 5136.6 5228.2 5242.2 5259.0 5262.9 4973.0 5007.4 5012.3 5015.2 5057.8 4866.2 4976.1 4977.2 5094.9 5109.3 4850.3 4878.4 4896.1 5023.4 5034.0 4976.9 5001.2 5001.8 5006.5 5044.7 4205.9 4206.3 4207.1 4208.0 4253.2 3581.5 3609.5 3695.3 3698.3 3714.0 4360.7 4373.1 4391.1 4411.2 4422.1 5066.9 5069.8 5069.9 5077.6 5118.1 4206.1 4293.7 4300.1 4318.8 4364.9 4383.6 4421.9 4448.8 4487.1 4493.1 4751.5 4789.8 4809.0 4809.1 4870.5 4771.3 4945.2 5041.1 5046.7 5058.0 4708.0 4775.0 4784.4 4789.3 4829.3 4979.2 4999.2 5015.6 5018.2 5062.0 4818.6 4917.3 5096.9 5108.1 5135.9 4748.5 4806.9 4827.8 4841.0 4868.6 4905.9 4927.0 4935.5 4941.2 4967.1 4673.3 4794.5 4842.7 4843.9 4893.6 4878.3 4897.2 4961.1 4973.0 5027.9 4819.4 4820.1 4824.8 4827.1 4866.4 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40160.62 Median:31923.18 stddev:64461.42 (201.9%) stddev-sans-first:64573.77 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: Values: 586.6 589.8 592.4 597.3 599.4 27158.6 34493.8 35743.3 35749.5 35784.6 39040.8 39636.0 39649.8 39686.0 39737.0 6940.3 7056.7 7811.2 7972.0 7974.9 9787.8 10043.0 10046.0 10047.8 10063.0 9681.1 9751.9 9753.4 9796.6 9798.2 7147.0 7330.2 7343.3 7351.2 9515.9 10091.4 10360.8 10364.4 10368.6 10384.6 37037.4 37384.4 37460.0 37481.8 37574.8 2688.9 2730.8 2736.2 2803.8 2818.8 27087.0 27437.6 27604.7 27632.3 28244.9 3208.7 3222.5 3236.8 3248.4 3314.7 216603.0 216674.0 217037.0 217791.0 217846.0 49771.5 50670.7 53105.5 53399.0 53977.7 47266.3 47461.1 47655.5 47676.5 47696.8 14133.9 14212.2 14308.0 14322.4 14345.1 10865.8 10971.8 10973.2 10993.8 10994.2 18152.3 18241.4 18374.4 18416.5 18539.6 7234.2 7518.4 7578.4 7596.2 7607.1 961.0 985.2 1007.7 1010.8 1042.4 25933.9 25957.2 25981.0 26211.3 26315.5 978.5 978.8 980.3 1000.7 1070.1 13515.9 13784.7 13916.7 13933.4 13965.5 269574.0 274584.0 274691.0 274747.0 275005.0 45371.3 45582.0 45635.1 45740.8 45828.3 1040.9 1222.1 1226.7 1227.2 1241.8 20090.7 24807.0 25159.0 25180.8 26768.3 36582.6 36855.4 36872.0 36912.8 36922.3 217637.0 221179.0 221480.0 223066.0 337105.0 28372.9 28550.4 28591.9 28793.7 28974.1 38087.2 39004.8 39707.6 39708.0 39858.8 31119.8 32805.7 33160.8 33501.5 35087.0 31532.0 31842.5 31844.0 32002.4 32115.8 32057.0 32602.5 32821.0 32902.0 33032.5 28506.3 29192.7 31292.5 32592.9 32698.2 23033.8 23136.2 23242.0 23388.8 23495.3 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25643.35 Median:4532.43 stddev:78580.05 (1733.7%) stddev-sans-first:78777.50 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: Values: 331.6 334.3 334.5 335.9 336.8 12603.0 13007.1 14974.5 15363.7 15852.5 8722.9 9311.3 9665.7 9685.5 9945.7 4406.8 4514.3 4514.4 4531.8 4533.0 3317.3 3403.0 4515.3 5061.0 5214.2 5161.5 5193.0 5193.6 5199.1 5215.4 5167.0 5409.3 5775.7 5787.9 5790.6 5095.0 5108.3 5116.1 5123.4 5128.6 18247.3 18518.3 18616.4 18670.3 19409.3 1719.4 1782.7 1834.4 1852.2 1882.3 10477.4 12497.6 12516.4 12832.6 12916.9 1690.6 1721.1 1725.9 1780.0 1782.9 54731.5 55913.2 57572.1 58049.7 58884.0 9329.6 9534.4 9718.2 9734.4 9798.8 12455.4 12470.6 12471.0 12493.2 12494.2 6707.2 6934.8 6948.6 7019.9 7036.8 6695.5 6707.8 6730.0 6734.3 6762.6 4125.0 4136.8 4161.1 4177.5 4194.6 1544.2 1603.8 1635.9 1649.4 1696.0 827.1 843.1 864.6 869.4 940.9 13421.3 13867.3 15653.8 15949.8 16187.4 838.1 873.1 883.9 910.0 913.7 9007.9 9186.8 9191.1 9197.4 9318.6 471584.0 474721.0 480177.0 488364.0 488910.0 65082.7 66366.3 68164.0 71089.3 77898.2 414.1 436.1 437.6 438.3 439.3 9064.6 9181.5 9355.3 9651.1 9655.5 32330.0 32728.5 32802.7 33113.3 34130.7 39579.6 39635.8 39767.2 41229.2 41269.8 8589.4 8716.5 8794.3 8951.2 8978.1 10435.8 10557.7 16061.1 16532.9 16719.7 8185.2 13744.3 14071.6 14203.4 14278.5 8343.5 8397.1 8620.0 8630.6 8932.3 7672.8 8010.4 8653.3 8925.9 8969.2 13994.2 14349.5 14511.7 14583.5 14639.5 14004.6 14227.9 14364.9 14847.5 14936.0 13:42:11 INFO - 2015-12-04 13:42:11,730 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,731 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4934.43 Median:6228.09 stddev:2578.84 (41.4%) stddev-sans-first:2572.34 13:42:11 INFO - 2015-12-04 13:42:11,732 DEBUG : BROWSER_OUTPUT: Values: 1393.2 1409.2 1429.3 1453.3 1465.8 6156.9 6761.6 7131.5 7143.3 7160.1 7034.5 7117.6 7169.5 7176.1 7180.2 1751.9 1793.8 1980.9 2004.9 2011.2 2054.9 2062.9 2066.7 2066.8 2068.9 1957.6 1972.7 2001.7 2006.1 2007.8 2017.9 2039.3 2041.1 2079.5 2080.5 2039.5 2063.5 2063.9 2066.8 2067.8 6872.9 6975.5 6979.1 7007.5 7018.0 4107.9 4179.7 4180.0 4200.9 4202.1 2321.2 2608.7 2741.8 2749.4 2760.5 792.8 796.2 803.5 804.1 850.9 9042.6 9077.5 9161.0 9173.7 9215.2 3809.2 3816.5 3880.8 3899.0 3903.6 8104.8 8128.3 8139.9 8140.0 8149.0 4178.9 4189.1 4199.2 4205.0 4208.7 3833.6 3837.2 3842.3 3845.9 3850.2 3310.7 3310.8 3324.2 3329.6 3346.7 1057.8 1064.0 1070.7 1079.0 1079.7 1177.0 1183.2 1199.7 1200.6 1212.7 6696.1 6777.2 6786.6 6798.0 6798.3 372.9 384.9 385.5 385.5 386.3 5274.9 5310.5 5326.8 5341.0 5349.5 8069.4 8088.1 8266.9 8272.3 8391.8 8274.8 8275.2 8347.6 8353.1 8359.5 6597.7 6614.1 6624.4 6687.8 6746.9 6724.2 6791.9 6794.9 6796.3 6799.9 7584.2 7683.2 7719.3 7749.2 7828.1 7865.6 7885.3 7916.8 8027.5 8041.6 6460.8 6533.1 6544.3 6545.4 6560.3 6679.2 6889.8 6902.7 6914.2 6920.9 6405.5 6463.5 6519.9 6571.5 6596.5 6381.0 6405.1 6486.6 6494.6 6556.6 6299.2 6391.5 6393.2 6406.3 6417.2 6022.6 6024.4 6027.4 6032.9 6058.9 5414.4 5856.0 6036.2 6036.6 6115.9 13:42:11 INFO - 2015-12-04 13:42:11,732 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,732 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4600.12 Median:5290.84 stddev:1363.39 (25.8%) stddev-sans-first:1328.30 13:42:11 INFO - 2015-12-04 13:42:11,733 DEBUG : BROWSER_OUTPUT: Values: 291.4 295.7 297.9 303.1 306.0 5270.0 5301.8 5317.1 5324.6 5350.4 5027.6 5085.9 5172.4 5190.0 5279.9 4097.8 4106.0 4126.1 4130.8 4136.6 4103.5 4111.4 4115.2 4120.4 4127.4 3857.4 3960.0 3969.2 4067.7 4083.9 4081.9 4084.1 4098.8 4099.5 4100.1 3612.5 3613.5 3615.5 3621.0 3623.8 5020.6 5039.4 5047.1 5049.6 5052.6 4499.3 4587.8 4589.5 4703.4 4710.0 5515.3 5523.6 5526.9 5533.3 5535.5 3776.5 3776.9 3782.0 3782.0 3786.3 5724.1 5799.4 5804.0 5813.1 5814.4 3828.9 3937.9 3947.6 3970.2 3987.3 4020.3 4032.3 4034.5 4034.5 4036.2 4596.4 4612.7 4625.0 4640.6 4644.3 5537.9 5543.9 5550.6 5551.1 5553.4 1337.8 1366.8 1386.2 1394.3 1423.9 930.1 934.1 947.6 949.7 958.4 4819.3 4856.3 4866.4 4872.6 4875.3 5685.0 5695.1 5697.6 5700.7 5705.5 4858.2 4865.7 4866.4 4868.4 4871.2 3003.3 3026.4 3066.5 3068.9 3069.6 5504.2 5528.8 5551.6 5554.3 5557.2 5955.3 5956.9 5968.5 5971.3 5974.1 5521.0 5541.5 5554.3 5554.4 5557.9 5620.6 5772.7 5781.3 5783.5 5785.1 5651.6 5662.0 5665.1 5665.7 5669.8 5513.6 5517.6 5548.6 5550.0 5551.8 3899.4 3938.9 3946.3 3947.1 3957.3 5572.1 5588.6 5761.5 5790.2 5802.9 5446.2 5489.7 5570.7 5579.0 5592.0 5547.9 5565.1 5570.4 5570.9 5572.9 5428.2 5441.6 5444.6 5452.8 5454.8 5478.5 5604.8 5608.0 5616.0 5618.5 5441.6 5444.6 5452.6 5455.2 5457.5 13:42:11 INFO - 2015-12-04 13:42:11,733 DEBUG : BROWSER_OUTPUT: 13:42:11 INFO - 2015-12-04 13:42:11,734 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12246.30 Median:21902.05 stddev:13636.78 (62.3%) stddev-sans-first:13647.50 13:42:11 INFO - 2015-12-04 13:42:11,734 DEBUG : BROWSER_OUTPUT: Values: 708.2 761.4 801.4 810.7 819.4 10889.4 11070.3 11076.4 11089.1 11103.3 11881.0 11995.5 12017.0 12060.0 12084.5 615.3 628.0 787.3 809.6 809.7 805.2 805.6 812.9 814.4 815.2 636.0 825.0 829.6 836.0 836.4 635.9 818.2 842.5 845.2 845.4 610.8 617.3 617.7 617.9 618.2 11298.8 11436.5 11442.0 11480.7 11496.8 11297.2 11803.8 11805.1 11915.8 12402.9 8954.6 9088.5 9516.1 9689.3 9694.5 3214.0 3226.4 3261.8 3297.4 3345.0 38597.8 38766.6 39011.2 39126.2 39239.8 9299.3 9396.0 9433.2 9617.4 9681.7 17161.1 17183.7 17191.8 17198.2 17210.3 6283.4 6435.2 6462.6 6569.1 6593.2 3545.4 3596.8 3648.5 3660.6 3693.3 2760.8 2809.3 2821.4 2821.4 2839.3 504.8 518.7 521.3 522.1 527.2 557.6 581.7 588.6 595.2 599.5 7651.9 7723.4 7883.9 8643.7 8857.3 438.0 467.6 545.9 593.1 618.2 3581.7 3597.8 3681.7 3730.6 3878.8 49314.0 49818.5 50068.5 50135.0 50239.7 42853.0 42914.6 43264.4 43366.1 45128.5 40844.4 40984.6 41116.4 41277.6 41534.2 8098.0 8115.8 8229.3 8346.4 8359.9 29865.0 30098.5 30630.0 32213.2 32588.8 37460.8 38453.2 38706.2 39014.6 39359.8 9984.3 10406.2 10537.7 10582.5 10691.0 10883.2 10952.1 11039.3 12221.1 12236.8 10629.0 11117.7 11174.6 11652.2 11702.1 10820.3 11169.1 11292.4 11471.5 11498.0 8542.4 9706.4 10487.0 11290.2 11360.0 8704.4 8998.6 9052.6 9334.2 9483.7 8774.8 9014.9 9082.0 9168.8 9239.9 13:42:11 INFO - 2015-12-04 13:42:11,734 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:42:11 INFO - 2015-12-04 13:42:11,734 DEBUG : BROWSER_OUTPUT: 13:42:12 INFO - 2015-12-04 13:42:12,457 INFO : Browser exited with error code: 0 13:42:12 INFO - 2015-12-04 13:42:12,478 INFO : Completed test dromaeo_css (00:18:38) 13:42:12 INFO - 2015-12-04 13:42:12,478 INFO : Starting test kraken 13:42:12 INFO - 2015-12-04 13:42:12,478 DEBUG : operating with platform_type : linux_ 13:42:12 INFO - 2015-12-04 13:42:12,478 INFO : Initialising browser for kraken test... 13:42:12 INFO - 2015-12-04 13:42:12,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXupw8/profile http://localhost:40754/getInfo.html 13:42:17 INFO - 2015-12-04 13:42:17,192 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:42:17 INFO - 2015-12-04 13:42:17,192 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:42:17 INFO - 2015-12-04 13:42:17,192 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:42:17 INFO - 2015-12-04 13:42:17,192 DEBUG : BROWSER_OUTPUT: __metrics 13:42:17 INFO - 2015-12-04 13:42:17,329 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] 13:42:17 INFO - 2015-12-04 13:42:17,329 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] 13:42:18 INFO - 2015-12-04 13:42:18,305 INFO : Browser initialized. 13:42:18 INFO - 2015-12-04 13:42:18,306 INFO : Running cycle 1/1 for kraken test... 13:42:18 INFO - 2015-12-04 13:42:18,306 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXupw8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:42:30 INFO - 2015-12-04 13:42:30,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 142745600 13:42:30 INFO - 2015-12-04 13:42:30,348 DEBUG : BROWSER_OUTPUT: 13:42:32 INFO - 2015-12-04 13:42:32,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40754/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:33 INFO - 2015-12-04 13:42:33,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 182308864 13:42:33 INFO - 2015-12-04 13:42:33,521 DEBUG : BROWSER_OUTPUT: 13:42:36 INFO - 2015-12-04 13:42:36,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40754/tests/kraken/driver.html?testName=audio-dft) 13:42:36 INFO - 2015-12-04 13:42:36,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 171106304 13:42:36 INFO - 2015-12-04 13:42:36,840 DEBUG : BROWSER_OUTPUT: 13:42:39 INFO - 2015-12-04 13:42:39,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40754/tests/kraken/driver.html?testName=audio-fft) 13:42:40 INFO - 2015-12-04 13:42:40,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 153165824 13:42:40 INFO - 2015-12-04 13:42:40,436 DEBUG : BROWSER_OUTPUT: 13:42:42 INFO - 2015-12-04 13:42:42,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40754/tests/kraken/driver.html?testName=audio-oscillator) 13:42:43 INFO - 2015-12-04 13:42:43,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 156323840 13:42:43 INFO - 2015-12-04 13:42:43,046 DEBUG : BROWSER_OUTPUT: 13:42:45 INFO - 2015-12-04 13:42:45,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:45 INFO - 2015-12-04 13:42:45,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 157642752 13:42:45 INFO - 2015-12-04 13:42:45,890 DEBUG : BROWSER_OUTPUT: 13:42:48 INFO - 2015-12-04 13:42:48,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40754/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:49 INFO - 2015-12-04 13:42:49,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 156942336 13:42:49 INFO - 2015-12-04 13:42:49,462 DEBUG : BROWSER_OUTPUT: 13:42:52 INFO - 2015-12-04 13:42:52,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40754/tests/kraken/driver.html?testName=imaging-desaturate) 13:42:53 INFO - 2015-12-04 13:42:53,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 159133696 13:42:53 INFO - 2015-12-04 13:42:53,450 DEBUG : BROWSER_OUTPUT: 13:42:56 INFO - 2015-12-04 13:42:56,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40754/tests/kraken/driver.html?testName=json-parse-financial) 13:42:56 INFO - 2015-12-04 13:42:56,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 159465472 13:42:56 INFO - 2015-12-04 13:42:56,874 DEBUG : BROWSER_OUTPUT: 13:42:58 INFO - 2015-12-04 13:42:58,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:42:59 INFO - 2015-12-04 13:42:59,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 169148416 13:42:59 INFO - 2015-12-04 13:42:59,226 DEBUG : BROWSER_OUTPUT: 13:43:01 INFO - 2015-12-04 13:43:01,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:01 INFO - 2015-12-04 13:43:01,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 169349120 13:43:01 INFO - 2015-12-04 13:43:01,725 DEBUG : BROWSER_OUTPUT: 13:43:03 INFO - 2015-12-04 13:43:03,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:04 INFO - 2015-12-04 13:43:04,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 180957184 13:43:04 INFO - 2015-12-04 13:43:04,439 DEBUG : BROWSER_OUTPUT: 13:43:06 INFO - 2015-12-04 13:43:06,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:07 INFO - 2015-12-04 13:43:07,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 185778176 13:43:07 INFO - 2015-12-04 13:43:07,499 DEBUG : BROWSER_OUTPUT: 13:43:10 INFO - 2015-12-04 13:43:10,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:10 INFO - 2015-12-04 13:43:10,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 183848960 13:43:10 INFO - 2015-12-04 13:43:10,684 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40754/tests/kraken/driver.html?testName=ai-astar) 13:43:12 INFO - 2015-12-04 13:43:12,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 242331648 13:43:12 INFO - 2015-12-04 13:43:12,688 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;104;111;111;109;100;110;109;106 13:43:12 INFO - 2015-12-04 13:43:12,692 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;128;163;161;135;155;151;130;179;131 13:43:12 INFO - 2015-12-04 13:43:12,693 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;160;161;160;162;162;163;162 13:43:12 INFO - 2015-12-04 13:43:12,693 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;71;80;89;72;74;72;98;95;72 13:43:12 INFO - 2015-12-04 13:43:12,693 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;143;94;95;95;134;95;94;131 13:43:12 INFO - 2015-12-04 13:43:12,693 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;109;109;110;109;109 13:43:12 INFO - 2015-12-04 13:43:12,693 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;146;146;146;146;146 13:43:12 INFO - 2015-12-04 13:43:12,694 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 13:43:12 INFO - 2015-12-04 13:43:12,694 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;70;72;71;71;71;71;79;68;68 13:43:12 INFO - 2015-12-04 13:43:12,694 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;70;69;69;73;69 13:43:12 INFO - 2015-12-04 13:43:12,694 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;83;84;83;84;83;83;84;84 13:43:12 INFO - 2015-12-04 13:43:12,694 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;118;119;114;119;125;128;121;127;128 13:43:12 INFO - 2015-12-04 13:43:12,695 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;141;148;149;149;136;146;147;144;141 13:43:12 INFO - 2015-12-04 13:43:12,695 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;68;69;69;69;68;68;68;71 13:43:12 INFO - 2015-12-04 13:43:12,695 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:43:12 INFO - 2015-12-04 13:43:12,695 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:43:12 INFO - 2015-12-04 13:43:12,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1031 13:43:12 INFO - 2015-12-04 13:43:12,696 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:43:12 INFO - 2015-12-04 13:43:12,696 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265392690__endTimestamp 13:43:12 INFO - 2015-12-04 13:43:12,696 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:43:12 INFO - 2015-12-04 13:43:12,700 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:43:12 INFO - 2015-12-04 13:43:12,700 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,700 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.73 (3.4%) stddev-sans-first:3.94 13:43:12 INFO - 2015-12-04 13:43:12,700 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 104.0 111.0 111.0 109.0 100.0 110.0 109.0 106.0 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:17.02 (11.1%) stddev-sans-first:18.01 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: Values: 152.0 128.0 163.0 161.0 135.0 155.0 151.0 130.0 179.0 131.0 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 160.0 161.0 160.0 162.0 162.0 163.0 162.0 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:77.00 stddev:10.40 (13.5%) stddev-sans-first:10.83 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 80.0 89.0 72.0 74.0 72.0 98.0 95.0 72.0 13:43:12 INFO - 2015-12-04 13:43:12,701 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:95.00 stddev:20.16 (21.2%) stddev-sans-first:20.91 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 143.0 94.0 95.0 95.0 134.0 95.0 94.0 131.0 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,702 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 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:43:12 INFO - 2015-12-04 13:43:12,702 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:3.10 (4.4%) stddev-sans-first:3.23 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: Values: 73.0 70.0 72.0 71.0 71.0 71.0 71.0 79.0 68.0 68.0 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:1.42 (2.1%) stddev-sans-first:1.42 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 70.0 69.0 69.0 73.0 69.0 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:0.99 (1.2%) stddev-sans-first:0.97 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 83.0 84.0 83.0 84.0 83.0 83.0 84.0 84.0 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.00 stddev:4.82 (3.9%) stddev-sans-first:5.06 13:43:12 INFO - 2015-12-04 13:43:12,703 DEBUG : BROWSER_OUTPUT: Values: 120.0 118.0 119.0 114.0 119.0 125.0 128.0 121.0 127.0 128.0 13:43:12 INFO - 2015-12-04 13:43:12,704 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.50 stddev:4.42 (3.0%) stddev-sans-first:4.45 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: Values: 149.0 141.0 148.0 149.0 149.0 136.0 146.0 147.0 144.0 141.0 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 68.0 69.0 69.0 69.0 68.0 68.0 68.0 71.0 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:43:12 INFO - 2015-12-04 13:43:12,705 DEBUG : BROWSER_OUTPUT: 13:43:13 INFO - 2015-12-04 13:43:13,569 INFO : Browser exited with error code: 0 13:43:13 INFO - 2015-12-04 13:43:13,618 INFO : Completed test kraken (00:01:01) 13:43:13 INFO - 2015-12-04 13:43:13,619 INFO : Starting test v8_7 13:43:13 INFO - 2015-12-04 13:43:13,619 DEBUG : operating with platform_type : linux_ 13:43:13 INFO - 2015-12-04 13:43:13,619 INFO : Initialising browser for v8_7 test... 13:43:13 INFO - 2015-12-04 13:43:13,625 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8XFI5/profile http://localhost:40754/getInfo.html 13:43:18 INFO - 2015-12-04 13:43:18,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:43:18 INFO - 2015-12-04 13:43:18,584 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:43:18 INFO - 2015-12-04 13:43:18,584 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:43:18 INFO - 2015-12-04 13:43:18,584 DEBUG : BROWSER_OUTPUT: __metrics 13:43:18 INFO - 2015-12-04 13:43:18,701 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] 13:43:18 INFO - 2015-12-04 13:43:18,701 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] 13:43:19 INFO - 2015-12-04 13:43:19,844 INFO : Browser initialized. 13:43:19 INFO - 2015-12-04 13:43:19,844 INFO : Running cycle 1/1 for v8_7 test... 13:43:19 INFO - 2015-12-04 13:43:19,845 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8XFI5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:43:31 INFO - 2015-12-04 13:43:31,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 143204352 13:43:31 INFO - 2015-12-04 13:43:31,874 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40754/tests/v8_7/run.html (next: http://localhost:40754/tests/v8_7/run.html) 13:43:53 INFO - 2015-12-04 13:43:53,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 444485632 13:43:53 INFO - 2015-12-04 13:43:53,493 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,493 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:43:53 INFO - 2015-12-04 13:43:53,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:43:53 INFO - 2015-12-04 13:43:53,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |0;Richards;164.85328058028355 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.42555164101614 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2000 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |5;Earley;781.25 13:43:53 INFO - 2015-12-04 13:43:53,494 DEBUG : BROWSER_OUTPUT: |6;Boyer;11905.882352941177 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: |8;Splay;617.6652254478073 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: __startTimestamp1449265433486__endTimestamp 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,495 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.85 Median:164.85 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: Values: 164.9 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.43 Median:185.43 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: Values: 185.4 13:43:53 INFO - 2015-12-04 13:43:53,496 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: Values: 278.0 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: Values: 5175.3 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,497 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: Values: 2000.0 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.25 Median:781.25 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: Values: 781.3 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11905.88 Median:11905.88 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,498 DEBUG : BROWSER_OUTPUT: Values: 11905.9 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: Values: 26394.7 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.67 Median:617.67 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: Values: 617.7 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: 13:43:53 INFO - 2015-12-04 13:43:53,499 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 13:43:53 INFO - 2015-12-04 13:43:53,500 DEBUG : BROWSER_OUTPUT: Values: 4817.3 13:43:53 INFO - 2015-12-04 13:43:53,500 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:43:53 INFO - 2015-12-04 13:43:53,500 DEBUG : BROWSER_OUTPUT: 13:43:54 INFO - 2015-12-04 13:43:54,457 INFO : Browser exited with error code: 0 13:43:54 INFO - 2015-12-04 13:43:54,474 INFO : Completed test v8_7 (00:00:40) 13:43:54 INFO - 2015-12-04 13:43:54,545 INFO : Completed test suite (00:20:20) 13:43:54 INFO - 2015-12-04 13:43:54,545 DEBUG : Working with test: dromaeo_css 13:43:54 INFO - 2015-12-04 13:43:54,545 DEBUG : Generating results file: dromaeo_css 13:43:54 INFO - 2015-12-04 13:43:54,546 DEBUG : Working with test: kraken 13:43:54 INFO - 2015-12-04 13:43:54,547 DEBUG : Generating results file: kraken 13:43:54 INFO - 2015-12-04 13:43:54,547 INFO : javascript benchmark 13:43:54 INFO - 2015-12-04 13:43:54,547 DEBUG : Working with test: v8_7 13:43:54 INFO - 2015-12-04 13:43:54,547 DEBUG : Generating results file: v8_7 13:43:54 INFO - 2015-12-04 13:43:54,547 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:43:54 INFO - 2015-12-04 13:43:54,606 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 13:43:54 INFO - 2015-12-04 13:43:54,606 DEBUG : process_Request line: dromaeo_css 6206.92 graph.html#tests=[[72,132,35]] 13:43:54 INFO - 2015-12-04 13:43:54,606 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:43:54 INFO - 2015-12-04 13:43:54,645 DEBUG : process_Request line: kraken 1515.00 graph.html#tests=[[232,132,35]] 13:43:54 INFO - 2015-12-04 13:43:54,645 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:43:54 INFO - 2015-12-04 13:43:54,670 DEBUG : process_Request line: v8_7 19888.99 graph.html#tests=[[230,132,35]] 13:43:54 INFO - 2015-12-04 13:43:54,671 INFO : javascript benchmark 13:43:54 INFO - 2015-12-04 13:43:54,675 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2600.505903878263, 2720.4695084458526, 2731.0, 2737.4661940921515, 2740.191643465178, 4578.633709303256, 4681.7659117044095, 4709.952900470998, 4713.34013238147, 4745.8813529661775, 4629.583337499625, 4679.321498382733, 4724.574788269055, 4726.0784147091335, 4806.182948898687, 4322.805473753673, 4337.478964820216, 4352.303631418974, 4356.3465480178065, 4431.446069241345, 4201.936970945439, 4415.050764085721, 4425.24770788965, 4467.17357288901, 4489.034857505636, 4218.0720241546815, 4315.525292217853, 4326.134773045388, 4326.134773045404, 4347.891302717458, 4310.331898555697, 4357.956420435787, 4361.127774445124, 4362.127574485084, 4405.515393306734, 4334.11150714106, 4334.804933777988, 4341.3487976803735, 4365.956340436618, 4382.452193475816, 4388.473383194005, 4509.323601459774, 4517.096580683843, 4519.7740112994215, 4530.977345113286, 4858.441279252896, 4981.12830254704, 4989.077020751172, 4993.425756038029, 5015.4733752956145, 5081.466446023152, 5094.821681241138, 5095.515925987025, 5136.897262054776, 5142.948570514322, 4595.126925884071, 4697.976510117462, 4710.0344429392235, 4712.128256272601, 4719.598834099072, 5136.640435169502, 5228.215767634885, 5242.16125419931, 5259.0, 5262.868428289246, 4972.950270497248, 5007.4491805901325, 5012.298278241049, 5015.24771284303, 5057.772400241998, 4866.197077482176, 4976.104301225741, 4977.1538838397555, 5094.872628184325, 5109.310243117206, 4850.296706977469, 4878.365812444359, 4896.094222568836, 5023.372078490189, 5033.974830125826, 4976.850694479099, 5001.224810154432, 5001.8499445016705, 5006.4743201964, 5044.672096313728, 4205.894852628709, 4206.26390381682, 4207.1375368050085, 4207.957920420818, 4253.21315556623, 3581.516495273157, 3609.5488063992, 3695.297893400299, 3698.334299826003, 3714.0, 4360.716553424018, 4373.081652852873, 4391.055922976511, 4411.205982923105, 4422.137683151755, 5066.898662026812, 5069.771860266297, 5069.8732531687, 5077.593792496591, 5118.10433174193, 4206.074663574009, 4293.742375457483, 4300.118475712471, 4318.848840290575, 4364.934525982113, 4383.60547550722, 4421.889452763707, 4448.822047118144, 4487.125010622897, 4493.078918821634, 4751.524847515221, 4789.808407663654, 4809.038192361471, 4809.062232864558, 4870.537298956593, 4771.260454629538, 4945.233488809096, 5041.117804384291, 5046.6719663221775, 5057.988402319477, 4707.952920470889, 4775.044991001883, 4784.354112194809, 4789.329493870791, 4829.251466022632, 4979.153543897473, 4999.150144475375, 5015.573676237561, 5018.172001619692, 5062.038212739568, 4818.566329030404, 4917.311576379238, 5096.923546146885, 5108.131617624938, 5135.87160320995, 4748.453927798348, 4806.8798280043275, 4827.806887724451, 4840.975795121143, 4868.610511159028, 4905.877353066202, 4926.965337279212, 4935.4570997190995, 4941.160002799461, 4967.05625931072, 4673.322368256516, 4794.496577859414, 4842.685225460334, 4843.878903027453, 4893.559579637849, 4878.341423907727, 4897.240927656219, 4961.131801934719, 4973.0, 5027.949720502748, 4819.373481447529, 4820.084184005028, 4824.782884770124, 4827.058723548875, 4866.391701037371], "unit": "ms", "name": "dojo.html", "value": 4616.774789095003}, {"lowerIsBetter": false, "replicates": [586.6040422714666, 589.828949604615, 592.4223881715327, 597.3011576455547, 599.3736545310151, 27158.5926211107, 34493.82753086234, 35743.285134297366, 35749.46375804359, 35784.64215357849, 39040.80479597605, 39636.0, 39649.801750991275, 39686.0, 39737.0, 6940.30596940307, 7056.717731290768, 7811.179826118261, 7972.043354797433, 7974.880376794353, 9787.755306117333, 10043.0, 10046.0, 10047.849282260771, 10063.0, 9681.12869841714, 9751.90248097517, 9753.366031207985, 9796.608135674565, 9798.216142708567, 7147.0, 7330.230325815766, 7343.265673432614, 7351.191368949411, 9515.90484095157, 10091.394516329045, 10360.792784144274, 10364.429956352473, 10368.585256589728, 10384.584616615326, 37037.44443833345, 37384.38309318349, 37460.0, 37481.812590937145, 37574.81212593919, 2688.8924443022256, 2730.84980326082, 2736.2201772494745, 2803.7756979441597, 2818.7744980401517, 27087.0, 27437.58843617347, 27604.723952760418, 27632.309192270353, 28244.85877570599, 3208.711215990572, 3222.5166225066428, 3236.773425860191, 3248.3665685191395, 3314.7016768490953, 216603.0, 216674.0, 217037.0, 217791.0, 217846.0, 49771.50228497741, 50670.74664626727, 53105.46894531082, 53399.0, 53977.73011134998, 47266.29100563494, 47461.050778984914, 47655.52344476511, 47676.523234767905, 47696.7615161922, 14133.929330353489, 14212.218327991854, 14308.0, 14322.355494002586, 14345.067570607876, 10865.83701244482, 10971.83542246867, 10973.231873768918, 10993.780124397466, 10994.230403871812, 18152.273909043754, 18241.36155234587, 18374.35689750879, 18416.539586510444, 18539.629207415775, 7234.24040475753, 7518.3609393201095, 7578.355839753683, 7596.164421913585, 7607.125180604301, 960.9663661771805, 985.2019863910256, 1007.7178390050798, 1010.7978404319166, 1042.4475028235047, 25933.870330648228, 25957.22128336153, 25981.0, 26211.34471638186, 26315.473690526083, 978.515634760798, 978.7797745507346, 980.26969907418, 1000.6547741029333, 1070.1438848920832, 13515.864841351657, 13784.724305513833, 13916.652083697989, 13933.442662293597, 13965.511207107702, 269574.0, 274584.0, 274691.0, 274747.0, 275005.0, 45371.319430208576, 45582.0, 45635.08729825385, 45740.771296143306, 45828.31257531073, 1040.942748148859, 1222.0895432902366, 1226.7178548933796, 1227.2145826670937, 1241.7764802335485, 20090.69863952071, 24807.0, 25158.993640254186, 25180.845160548306, 26768.33079173036, 36582.63417365792, 36855.44716829303, 36872.0, 36912.81543592265, 36922.33849476834, 217637.0, 221179.0, 221480.0, 223066.0, 337105.0, 28372.85813570919, 28550.42899142047, 28591.85704071466, 28793.7120628791, 28974.130776076752, 38087.238255235294, 39004.80497597494, 39707.60292397039, 39708.043793431214, 39858.800705996284, 31119.844400777853, 32805.671943280264, 33160.834195828866, 33501.49747753737, 35087.0, 31532.0, 31842.522362164123, 31844.0, 32002.35995280128, 32115.83942080368, 32057.0, 32602.51096233606, 32821.0, 32902.01293961185, 33032.50451243281, 28506.287342816595, 29192.708072919, 31292.530612041293, 32592.948093045616, 32698.182545436553, 23033.769662303162, 23136.190233341753, 23242.0, 23388.76611233934, 23495.295141145794], "unit": "ms", "name": "ext.html", "value": 16914.61517225117}, {"lowerIsBetter": false, "replicates": [331.5739275031585, 334.31632311922124, 334.5182936571337, 335.92503987240804, 336.77604393078605, 12603.0, 13007.089503734742, 14974.475893343735, 15363.692726145484, 15852.524424267262, 8722.91277087229, 9311.348205625609, 9665.66170184042, 9685.467299298536, 9945.701628951125, 4406.823727050914, 4514.322851572258, 4514.435695538058, 4531.841385551506, 4533.0253995390985, 3317.303366293081, 3402.982985085071, 4515.345274935149, 5061.0, 5214.165733482643, 5161.535461808437, 5193.013327467788, 5193.63644544882, 5199.14214154664, 5215.374155101393, 5167.044096842077, 5409.26974858393, 5775.711214439261, 5787.942120578825, 5790.594658373915, 5094.974525127388, 5108.284840122349, 5116.053530096944, 5123.359580052494, 5128.640995130342, 18247.270109195615, 18518.259269629198, 18616.441506754818, 18670.25318987239, 19409.320673776492, 1719.3982106262833, 1782.6523827853573, 1834.4038187588953, 1852.1757817770963, 1882.3129557711475, 10477.423741694203, 12497.625071247878, 12516.436760345716, 12832.550860719923, 12916.935415322958, 1690.5689049292475, 1721.070621864192, 1725.8878172918846, 1779.973300400495, 1782.9375971841052, 54731.452685473036, 55913.16130258049, 57572.13641795376, 58049.709751451395, 58884.0, 9329.580168892417, 9534.427934323963, 9718.222542196607, 9734.36726612768, 9798.755031124136, 12455.377231138587, 12470.625881223577, 12471.0, 12493.18794278369, 12494.187877787916, 6707.228668703162, 6934.826629334307, 6948.6178260196175, 7019.92980070203, 7036.824079398056, 6695.531312808057, 6707.765228216989, 6730.02414649873, 6734.292899245509, 6762.628055456997, 4125.0, 4136.751794892316, 4161.10536234705, 4177.540470548237, 4194.622483976456, 1544.2047345617016, 1603.8155612104758, 1635.8936669116708, 1649.3567508671629, 1696.0, 827.0695467598952, 843.1231519219942, 864.6152462154407, 869.365363284793, 940.9294302927308, 13421.328933553283, 13867.306634668226, 15653.843461565466, 15949.760753588705, 16187.352505899633, 838.0906716212977, 873.0963452826421, 883.9469631822111, 909.9727008189765, 913.7304495173939, 9007.909920900838, 9186.770330741785, 9191.126842949909, 9197.402168859002, 9318.580663870142, 471584.0, 474721.0, 480177.0, 488364.0, 488910.0, 65082.67458662677, 66366.33633663699, 68164.0, 71089.2891071093, 77898.2210177891, 414.14065813437236, 436.1059827353912, 437.5515097025511, 438.2855944810003, 439.2949316347281, 9064.592093355683, 9181.49501777382, 9355.25157987373, 9651.083147101295, 9655.517224138905, 32330.0, 32728.50907236441, 32802.67197327996, 33113.33773324568, 34130.65869341275, 39579.60420395759, 39635.80182099071, 39767.2046559073, 41229.1754164909, 41269.793651031556, 8589.355798315026, 8716.477011379338, 8794.29645628361, 8951.239144672516, 8978.147076027766, 10435.843462348223, 10557.683269501927, 16061.11663858499, 16532.917335413247, 16719.665606688042, 8185.222403871623, 13744.312784360942, 14071.648208794863, 14203.360848761624, 14278.500252491112, 8343.457675251331, 8397.118302578141, 8619.956900215459, 8630.56847157627, 8932.330075244252, 7672.80817979555, 8010.359171266401, 8653.264472519906, 8925.910740892508, 8969.192772650493, 13994.16035037901, 14349.497767578085, 14511.709765804413, 14583.489577864724, 14639.48761793332, 14004.649883752987, 14227.857721422653, 14364.85635143677, 14847.480338188112, 14935.954483186508], "unit": "ms", "name": "jquery.html", "value": 7732.03484128669}, {"lowerIsBetter": false, "replicates": [1393.2058726525881, 1409.2037998530823, 1429.3425024488736, 1453.3024148408763, 1465.8314293856204, 6156.938430615693, 6761.56049856759, 7131.536450130738, 7143.285671432861, 7160.10498687664, 7034.542754720939, 7117.644117794102, 7169.46229032822, 7176.138863336394, 7180.210176880539, 1751.8598512119063, 1793.7757780277466, 1980.87124336918, 2004.9398518044482, 2011.2256781139295, 2054.8972551372444, 2062.865913715611, 2066.731324927757, 2066.7623223329283, 2068.927587534429, 1957.6476234277825, 1972.6646470100045, 2001.7497812773404, 2006.107282259395, 2007.8393728501758, 2017.9293724719712, 2039.3474088291753, 2041.0917141871873, 2079.490524821421, 2080.479880029985, 2039.4901274681329, 2063.504758857863, 2063.9484012899647, 2066.7519897612383, 2067.7622073461594, 6872.862542749167, 6975.546589471719, 6979.092717946685, 7007.544509606859, 7017.964910175417, 4107.876763697094, 4179.728317659373, 4179.958200417987, 4200.936985945214, 4202.054537729017, 2321.1527792355837, 2608.739126087395, 2741.821781584191, 2749.42262124952, 2760.530709779322, 792.7661339904741, 796.195842199377, 803.5058439059936, 804.0753133896008, 850.9361797865123, 9042.638294468214, 9077.546122693839, 9161.038091000415, 9173.724788256362, 9215.216706579882, 3809.2381523694817, 3816.542014958223, 3880.7865567394065, 3898.9610103899167, 3903.590123037097, 8104.756857294291, 8128.268455839003, 8139.877901831477, 8140.023197216372, 8148.959255203686, 4178.895527611773, 4189.120284740238, 4199.2441360554785, 4205.011822221775, 4208.6633069354375, 3833.6358045985585, 3837.2325534893134, 3842.346801043829, 3845.8653947111716, 3850.1914597934747, 3310.7185889199686, 3310.8013519188926, 3324.1855745342546, 3329.5505106810756, 3346.748993825473, 1057.8095942730383, 1064.0423618743039, 1070.6948519671855, 1078.9838152427562, 1079.7192729890285, 1177.0230708511915, 1183.2131632464486, 1199.7060720123625, 1200.6038007457519, 1212.6907638552113, 6696.129503164558, 6777.186737591422, 6786.626735529593, 6797.966010169917, 6798.320167983162, 372.88440583419225, 384.90762217067703, 385.4796025365734, 385.5046265548812, 386.3412881037824, 5274.894502109936, 5310.468953104736, 5326.840194794162, 5341.0, 5349.518543331119, 8069.435139540175, 8088.069871964682, 8266.917330826735, 8272.255497005299, 8391.790205244917, 8274.8345033099, 8275.172482751797, 8347.624356903954, 8353.081161072278, 8359.498430094214, 6597.703103360361, 6614.074029635759, 6624.370684784938, 6687.799366019027, 6746.932530674729, 6724.226713927766, 6791.93208067913, 6794.864102717819, 6796.2524122347495, 6799.864002720017, 7584.241575842592, 7683.231676832272, 7719.343855772097, 7749.186335434923, 7828.060632724109, 7865.646045927832, 7885.250901164381, 7916.84166316682, 8027.478213916077, 8041.597920104088, 6460.838479038061, 6533.118029066205, 6544.280129185881, 6545.37818907203, 6560.343965603402, 6679.165104361955, 6889.793306200822, 6902.723891044503, 6914.239433662394, 6920.8961865573065, 6405.455536279468, 6463.547551671338, 6519.869602607826, 6571.474282057519, 6596.538242323183, 6381.0, 6405.135306733531, 6486.643234621953, 6494.577852439576, 6556.573822701509, 6299.244090708961, 6391.456726178327, 6393.1688880445245, 6406.327335629878, 6417.197850268716, 6022.638641681513, 6024.367441418588, 6027.36712645166, 6032.90950635732, 6058.90911636317, 5414.377346605191, 5856.0, 6036.185115009417, 6036.63780173191, 6115.938840611537], "unit": "ms", "name": "mootools.html", "value": 3956.2549743883524}, {"lowerIsBetter": false, "replicates": [291.3924467485293, 295.6924798209862, 297.85702862625936, 303.0756193609492, 306.0, 5270.0, 5301.7879284828605, 5317.069512835253, 5324.600654950879, 5350.35795704515, 5027.572656324217, 5085.923711144326, 5172.431032586413, 5190.0, 5279.894402111965, 4097.774622395767, 4105.999999999993, 4126.0510082681, 4130.772807495587, 4136.648384887273, 4103.466549348595, 4111.36273877548, 4115.218108559364, 4120.443740095094, 4127.401526778615, 3857.3635350167187, 3959.960400395988, 3969.2458432897656, 4067.6542493888055, 4083.8570650027254, 4081.9183616327805, 4084.101497670508, 4098.774567398792, 4099.508059032905, 4100.0569868930315, 3612.4581312803025, 3613.5483064616924, 3615.4576813477925, 3621.0, 3623.7644553103964, 5020.648554601143, 5039.44566097729, 5047.116754567973, 5049.64652474327, 5052.57053150479, 4499.280115181588, 4587.816487340502, 4589.472210695746, 4703.412073490814, 4709.952900470986, 5515.255440515519, 5523.6409633373705, 5526.917096243559, 5533.280673512458, 5535.529479994206, 3776.527934008249, 3776.8866933992026, 3781.9599610107166, 3781.9810900945595, 3786.318462676717, 5724.112762521816, 5799.420057994209, 5804.013317735995, 5813.128030795415, 5814.360420353758, 3828.8659896903473, 3937.8818635440985, 3947.624975627311, 3970.1861118470642, 3987.2623564640635, 4020.336644453691, 4032.2540330039037, 4034.495688038995, 4034.515858097047, 4036.1524079942956, 4596.37948876904, 4612.7001744886475, 4624.9768751156025, 4640.628749700016, 4644.256918892961, 5537.861553461115, 5543.916841247385, 5550.639208451437, 5551.056320425538, 5553.444655534495, 1337.77257866163, 1366.8291463567055, 1386.202933313349, 1394.268009295108, 1423.8860891128684, 930.1442672741094, 934.065934065934, 947.5688561704408, 949.6723630347519, 958.434523631061, 4819.277108433693, 4856.3201151838775, 4866.367372241586, 4872.610191184696, 4875.268709693574, 5684.971575142098, 5695.145728140812, 5697.601167918288, 5700.686462244534, 5705.515031222392, 4858.246971719389, 4865.683730557503, 4866.367372241657, 4868.367112275381, 4871.2206047032305, 3003.339265361617, 3026.379592183597, 3066.5246886732593, 3068.861901214451, 3069.64699059611, 5504.2018907258225, 5528.778848846082, 5551.583631227593, 5554.250176226238, 5557.194206839986, 5955.255593050869, 5956.880862382728, 5968.46283834457, 5971.313298970587, 5974.103884417372, 5521.033819081645, 5541.5289700375915, 5554.277943867352, 5554.416786237468, 5557.861053473695, 5620.634658747168, 5772.682502462405, 5781.335146458211, 5783.537317014713, 5785.132230165341, 5651.57613179005, 5661.980843448054, 5665.093585026376, 5665.688387138582, 5669.801556945487, 5513.58648101402, 5517.613767036269, 5548.611597188158, 5550.0, 5551.7779288828, 3899.434581985653, 3938.9212215756097, 3946.3488524393156, 3947.131631041166, 3957.3470377387407, 5572.108462645957, 5588.608797384307, 5761.452661997104, 5790.218320526844, 5802.912956305743, 5446.210299506629, 5489.725513724377, 5570.6657600544095, 5579.0, 5591.9720401397735, 5547.944520554905, 5565.1374037024325, 5570.415106413769, 5570.860728481658, 5572.86067848307, 5428.240046393587, 5441.646292990943, 5444.6188766785945, 5452.781888724565, 5454.836354909359, 5478.479544443431, 5604.8318550443555, 5608.046632072639, 5615.971920140373, 5618.52242559387, 5441.564674825925, 5444.6188766785945, 5452.645578037414, 5455.236266922713, 5457.536109430743], "unit": "ms", "name": "prototype.html", "value": 4158.192518755479}, {"lowerIsBetter": false, "replicates": [708.1643660480631, 761.3680645064594, 801.4389927051064, 810.7000409848357, 819.3854609043218, 10889.401082940434, 11070.28043177193, 11076.446177691114, 11089.112870970323, 11103.333799971997, 11881.0, 11995.460204290806, 12017.0, 12060.0, 12084.456199471022, 615.3047056825781, 627.9780207692731, 787.299303619776, 809.6113865344638, 809.7085049382217, 805.2189376304975, 805.6334367862609, 812.9268365847073, 814.4176913506841, 815.176671561721, 636.0491065856551, 825.0470706334164, 829.6142293833366, 836.0343802907621, 836.3727204596553, 635.9014352775328, 818.2022528035147, 842.4650347029681, 845.1717317029315, 845.3786466946789, 610.7526451787033, 617.2777849915565, 617.6664601115392, 617.8980468222738, 618.1778234947509, 11298.830517542161, 11436.542538298458, 11442.027427668658, 11480.655580332603, 11496.827547586792, 11297.152713546435, 11803.822942655866, 11805.114616403804, 11915.821262681067, 12402.875971240263, 8954.597043133075, 9088.50013249271, 9516.095970882756, 9689.32174747768, 9694.466804325759, 3213.9875939079348, 3226.3869864725625, 3261.8205998670064, 3297.3570153820015, 3344.9832750836335, 38597.80701096504, 38766.61233387658, 39011.219775604615, 39126.217475650614, 39239.8038009811, 9299.302552308603, 9396.01341859095, 9433.151016408556, 9617.374870633386, 9681.70954871355, 17161.056141912315, 17183.65632687339, 17191.828081719024, 17198.226079826436, 17210.31158753636, 6283.403076707706, 6435.227772667216, 6462.612243265419, 6569.080328753978, 6593.241777195588, 3545.37955857729, 3596.82015899204, 3648.4892115103908, 3660.5973342932257, 3693.316736403774, 2760.8205466645004, 2809.325761817149, 2821.3510892494432, 2821.4498172856506, 2839.261791934112, 504.76023888653333, 518.7432221050605, 521.3457111325263, 522.0628970996994, 527.1881302793655, 557.5901712241499, 581.6742624130501, 588.5703436491385, 595.1637948682109, 599.5054080383701, 7651.923480765233, 7723.382129429745, 7883.881741773878, 8643.697470588499, 8857.291416686778, 437.9737215767064, 467.63057184823606, 545.9208414779914, 593.092568370394, 618.1685632823845, 3581.659742324475, 3597.8201089945396, 3681.668649821529, 3730.570984336836, 3878.7672739635714, 49314.0, 49818.519962804065, 50068.49931500711, 50135.0, 50239.74880125576, 42853.0, 42914.570854291684, 43264.35103473451, 43366.13267734628, 45128.54871451309, 40844.38733419001, 40984.59015409927, 41116.38325425121, 41277.58722412797, 41534.1693166135, 8098.0, 8115.797105072184, 8229.25936665703, 8346.374021948257, 8359.916400835913, 29865.0, 30098.548521772627, 30630.0, 32213.194670133435, 32588.83705581457, 37460.81269593634, 38453.230935381696, 38706.225875482894, 39014.6098539011, 39359.80320098381, 9984.251181161297, 10406.1785751633, 10537.736556586147, 10582.470876455993, 10691.0, 10883.23817332779, 10952.069074128789, 11039.282446640942, 12221.144519883523, 12236.816447753468, 10629.0, 11117.666470005914, 11174.608888688857, 11652.242604230698, 11702.122340824642, 10820.296680715728, 11169.050630696156, 11292.378919159524, 11471.541138354372, 11498.0, 8542.359323050672, 9706.417614943126, 10487.0, 11290.15323850698, 11360.0, 8704.434211776213, 8998.640054398013, 9052.637894484411, 9334.159925606727, 9483.715488535356, 8774.780630484289, 9014.864777028219, 9082.046385129466, 9168.768756792317, 9239.86140207884], "unit": "ms", "name": "yui.html", "value": 5756.105900553079}], "name": "dromaeo_css", "value": 6206.922661382605}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 111.0, 111.0, 109.0, 100.0, 110.0, 109.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 128.0, 163.0, 161.0, 135.0, 155.0, 151.0, 130.0, 179.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 161.0, 160.0, 162.0, 162.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 80.0, 89.0, 72.0, 74.0, 72.0, 98.0, 95.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 143.0, 94.0, 95.0, 95.0, 134.0, 95.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.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, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 72.0, 71.0, 71.0, 71.0, 71.0, 79.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 73.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 84.0, 83.0, 84.0, 83.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 119.0, 114.0, 119.0, 125.0, 128.0, 121.0, 127.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [149.0, 141.0, 148.0, 149.0, 149.0, 136.0, 146.0, 147.0, 144.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1515.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.85328058028355], "unit": "score", "name": "Richards", "value": 214.14193200000003}, {"lowerIsBetter": false, "replicates": [185.42555164101614], "unit": "score", "name": "DeltaBlue", "value": 356.5743740000001}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [781.25], "unit": "score", "name": "Earley", "value": 853.0726399999998}, {"lowerIsBetter": false, "replicates": [11905.882352941177], "unit": "score", "name": "Boyer", "value": 55.97762351778653}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [617.6652254478073], "unit": "score", "name": "Splay", "value": 131.93392900000003}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 19888.987006468993}]} 13:43:54 INFO - RETURN: dromaeo_css: 6206.92 13:43:54 INFO - RETURN: kraken: 1515.00 13:43:54 INFO - RETURN: v8_7: 19888.99 13:43:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19888.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6206.92"}}} 13:43:54 INFO - Return code: 0 13:43:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:43:54 INFO - # TBPL SUCCESS # 13:43:54 INFO - Running post-action listener: _resource_record_post_action 13:43:54 INFO - Running post-run listener: _resource_record_post_run 13:43:55 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515665920; Read time: 12; Write time: 483600 13:43:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237662208; Read time: 0; Write time: 276508 13:43:55 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273948672; Read time: 12; Write time: 206236 13:43:55 INFO - Running post-run listener: _upload_blobber_files 13:43:55 INFO - Blob upload gear active. 13:43:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:43:55 INFO - Copying logs to upload dir... 13:43:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.499774 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-04 13:43:55.446755) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:43:55.449917) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009036 build_url: 'https://queue.taskcluster.net/v1/task/AfGkOUQNQ9uJ8np-0lHqgg/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-04 13:43:55.509175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:43:55.509972) ========= 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=7f67ac1ceef7774224e327f2000001f6-1449264163.770485-1307676654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:43:55.564009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:43:55.564468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:43:55.565331) ========= ========= Total master_lag: 0.26 =========