builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1449751991.02 results: success (0) buildid: 20151210030842 builduid: d39c74da16b843a88728fca669a9c4ca revision: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.025106) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.025502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.025774) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.056959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.057232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.078794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.079040) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.129743) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.130007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.130374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.130642) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 04:53:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.5M=0s 2015-12-10 04:53:11 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.260543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.260832) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019994 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.327079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.327398) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 04:53:11,714 truncating revision to first 12 chars 2015-12-10 04:53:11,714 Setting DEBUG logging. 2015-12-10 04:53:11,714 attempt 1/10 2015-12-10 04:53:11,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/412e4d7ce98c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 04:53:12,301 unpacking tar archive at: mozilla-central-412e4d7ce98c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.875495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.219189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.219577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.228523) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.229005) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.229530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-10 04:53:12.229844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:12 INFO - MultiFileLogger online at 20151210 04:53:12 in /builds/slave/test 04:53:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:53:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:12 INFO - {'append_to_log': False, 04:53:12 INFO - 'base_work_dir': '/builds/slave/test', 04:53:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:53:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:12 INFO - 'branch': 'Firefox-Non-PGO', 04:53:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:12 INFO - 'config_files': ('talos/linux_config.py',), 04:53:12 INFO - 'default_actions': ('clobber', 04:53:12 INFO - 'read-buildbot-config', 04:53:12 INFO - 'download-and-extract', 04:53:12 INFO - 'populate-webroot', 04:53:12 INFO - 'create-virtualenv', 04:53:12 INFO - 'install', 04:53:12 INFO - 'run-tests'), 04:53:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:12 INFO - 'download_minidump_stackwalk': True, 04:53:12 INFO - 'download_symbols': 'ondemand', 04:53:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:12 INFO - 'installer_path': 'installer.exe', 04:53:12 INFO - 'log_level': 'info', 04:53:12 INFO - 'log_name': 'talos', 04:53:12 INFO - 'log_to_console': True, 04:53:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:12 INFO - 'opt_config_files': (), 04:53:12 INFO - 'pip_index': False, 04:53:12 INFO - 'sps_profile': False, 04:53:12 INFO - 'sps_profile_interval': 0, 04:53:12 INFO - 'suite': 'dromaeojs-e10s', 04:53:12 INFO - 'system_bits': '64', 04:53:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:12 INFO - 'title': 'talos-linux64-ix-030', 04:53:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:12 INFO - 'use_talos_json': True, 04:53:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:12 INFO - 'work_dir': 'build'} 04:53:12 INFO - ##### 04:53:12 INFO - ##### Running clobber step. 04:53:12 INFO - ##### 04:53:12 INFO - Running pre-action listener: _resource_record_pre_action 04:53:12 INFO - Running main action method: clobber 04:53:12 INFO - rmtree: /builds/slave/test/build 04:53:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:13 INFO - Running post-action listener: _resource_record_post_action 04:53:13 INFO - ##### 04:53:13 INFO - ##### Running read-buildbot-config step. 04:53:13 INFO - ##### 04:53:13 INFO - Running pre-action listener: _resource_record_pre_action 04:53:13 INFO - Running main action method: read_buildbot_config 04:53:13 INFO - Using buildbot properties: 04:53:13 INFO - { 04:53:13 INFO - "properties": { 04:53:13 INFO - "buildnumber": 114, 04:53:13 INFO - "product": "firefox", 04:53:13 INFO - "script_repo_revision": "production", 04:53:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:53:13 INFO - "repository": "", 04:53:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:53:13 INFO - "buildid": "20151210030842", 04:53:13 INFO - "slavename": "talos-linux64-ix-030", 04:53:13 INFO - "pgo_build": "False", 04:53:13 INFO - "basedir": "/builds/slave/test", 04:53:13 INFO - "project": "", 04:53:13 INFO - "platform": "ubuntu64_hw", 04:53:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:53:13 INFO - "slavebuilddir": "test", 04:53:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:53:13 INFO - "branch": "mozilla-central", 04:53:13 INFO - "repo_path": "mozilla-central", 04:53:13 INFO - "stage_platform": "linux64", 04:53:13 INFO - "builduid": "d39c74da16b843a88728fca669a9c4ca", 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - }, 04:53:13 INFO - "sourcestamp": { 04:53:13 INFO - "repository": "", 04:53:13 INFO - "hasPatch": false, 04:53:13 INFO - "project": "", 04:53:13 INFO - "branch": "mozilla-central-linux64-talos", 04:53:13 INFO - "changes": [ 04:53:13 INFO - { 04:53:13 INFO - "category": null, 04:53:13 INFO - "files": [ 04:53:13 INFO - { 04:53:13 INFO - "url": null, 04:53:13 INFO - "name": "https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:53:13 INFO - } 04:53:13 INFO - ], 04:53:13 INFO - "repository": "", 04:53:13 INFO - "rev": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f", 04:53:13 INFO - "who": "cbook@mozilla.com", 04:53:13 INFO - "when": 1449751914, 04:53:13 INFO - "number": 7238589, 04:53:13 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:53:13 INFO - "project": "", 04:53:13 INFO - "at": "Thu 10 Dec 2015 04:51:54", 04:53:13 INFO - "branch": "mozilla-central-linux64-talos", 04:53:13 INFO - "revlink": "", 04:53:13 INFO - "properties": [ 04:53:13 INFO - [ 04:53:13 INFO - "buildid", 04:53:13 INFO - "20151210030842", 04:53:13 INFO - "Change" 04:53:13 INFO - ], 04:53:13 INFO - [ 04:53:13 INFO - "builduid", 04:53:13 INFO - "d39c74da16b843a88728fca669a9c4ca", 04:53:13 INFO - "Change" 04:53:13 INFO - ], 04:53:13 INFO - [ 04:53:13 INFO - "pgo_build", 04:53:13 INFO - "False", 04:53:13 INFO - "Change" 04:53:13 INFO - ] 04:53:13 INFO - ], 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - } 04:53:13 INFO - ], 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - } 04:53:13 INFO - } 04:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:53:13 INFO - Running post-action listener: _resource_record_post_action 04:53:13 INFO - ##### 04:53:13 INFO - ##### Running download-and-extract step. 04:53:13 INFO - ##### 04:53:13 INFO - Running pre-action listener: _resource_record_pre_action 04:53:13 INFO - Running main action method: download_and_extract 04:53:13 INFO - mkdir: /builds/slave/test/build/tests 04:53: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')]} 04:53:13 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json 04:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json 04:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:53:13 INFO - Downloaded 1302 bytes. 04:53:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:53:13 INFO - Using the following test package requirements: 04:53:13 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'jsshell-linux-x86_64.zip'], 04:53:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:13 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:13 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53: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')]} 04:53:13 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:15 INFO - Downloaded 21866764 bytes. 04:53:15 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 04:53:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:15 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 04:53:16 INFO - Return code: 0 04:53:16 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 04:53:16 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')]} 04:53:16 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:21 INFO - Downloaded 21866764 bytes. 04:53:21 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 04:53:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:21 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 04:53:22 INFO - Return code: 0 04:53:22 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')]} 04:53:22 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:23 INFO - Downloaded 11132038 bytes. 04:53:23 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 04:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:23 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 04:53:23 INFO - Return code: 0 04:53:23 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')]} 04:53:23 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:24 INFO - Downloaded 57726826 bytes. 04:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:24 INFO - mkdir: /builds/slave/test/properties 04:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:24 INFO - Contents: 04:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:24 INFO - Running post-action listener: _resource_record_post_action 04:53:24 INFO - Running post-action listener: set_extra_try_arguments 04:53:24 INFO - ##### 04:53:24 INFO - ##### Running populate-webroot step. 04:53:24 INFO - ##### 04:53:24 INFO - Running pre-action listener: _resource_record_pre_action 04:53:24 INFO - Running main action method: populate_webroot 04:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:24 INFO - '--tppagecycles', 04:53:24 INFO - '7'], 04:53:24 INFO - 'tests': ['tsvgm']}}, 04:53:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:53:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'tests': ['damp', 'tps']}, 04:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['damp', 'tps']}, 04:53:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:24 INFO - 'other': {'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'other_l64': {'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'other_nol64': {'tests': ['a11yr', 04:53:24 INFO - 'ts_paint', 04:53:24 INFO - 'tpaint', 04:53:24 INFO - 'sessionrestore', 04:53:24 INFO - 'sessionrestore_no_auto_restore']}, 04:53:24 INFO - 'svgr': {'tests': ['tsvgx', 04:53:24 INFO - 'tsvgr_opacity', 04:53:24 INFO - 'tart', 04:53:24 INFO - 'tscrollx', 04:53:24 INFO - 'cart']}, 04:53:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['tsvgx', 04:53:24 INFO - 'tsvgr_opacity', 04:53:24 INFO - 'tart', 04:53:24 INFO - 'tscrollx', 04:53:24 INFO - 'cart']}, 04:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'tests': ['tp5o']}, 04:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'talos_options': ['--e10s'], 04:53:24 INFO - 'tests': ['tp5o']}, 04:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'talos_options': ['--xperf_path', 04:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:24 INFO - 'tests': ['tp5n']}, 04:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:24 INFO - 'talos_options': ['--e10s', 04:53:24 INFO - '--xperf_path', 04:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:24 INFO - 'tests': ['tp5n']}}, 04:53:24 INFO - 'talos.zip': {'path': '', 04:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:24 INFO - Running post-action listener: _resource_record_post_action 04:53:24 INFO - ##### 04:53:24 INFO - ##### Running create-virtualenv step. 04:53:24 INFO - ##### 04:53:24 INFO - Running pre-action listener: _resource_record_pre_action 04:53:24 INFO - Running main action method: create_virtualenv 04:53:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:24 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 04:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:25 INFO - Using real prefix '/usr' 04:53:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:27 INFO - Installing pip.................done. 04:53:27 INFO - Return code: 0 04:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:27 INFO - Using env: {'DISPLAY': ':0', 04:53:27 INFO - 'HOME': '/home/cltbld', 04:53:27 INFO - 'LANG': 'en_US.UTF-8', 04:53:27 INFO - 'LANGUAGE': 'en_US:en', 04:53:27 INFO - 'LOGNAME': 'cltbld', 04:53:27 INFO - 'MAIL': '/var/mail/cltbld', 04:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:27 INFO - 'MOZ_NO_REMOTE': '1', 04:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:27 INFO - 'NO_EM_RESTART': '1', 04:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:27 INFO - 'PWD': '/builds/slave/test', 04:53:27 INFO - 'SHELL': '/bin/bash', 04:53:27 INFO - 'SHLVL': '1', 04:53:27 INFO - 'TERM': 'linux', 04:53:27 INFO - 'TMOUT': '86400', 04:53:27 INFO - 'USER': 'cltbld', 04:53:27 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:27 INFO - '_': '/tools/buildbot/bin/python'} 04:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:27 INFO - Cleaning up... 04:53:27 INFO - Return code: 0 04:53:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:53:27 INFO - Using env: {'DISPLAY': ':0', 04:53:27 INFO - 'HOME': '/home/cltbld', 04:53:27 INFO - 'LANG': 'en_US.UTF-8', 04:53:27 INFO - 'LANGUAGE': 'en_US:en', 04:53:27 INFO - 'LOGNAME': 'cltbld', 04:53:27 INFO - 'MAIL': '/var/mail/cltbld', 04:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:27 INFO - 'MOZ_NO_REMOTE': '1', 04:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:27 INFO - 'NO_EM_RESTART': '1', 04:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:27 INFO - 'PWD': '/builds/slave/test', 04:53:27 INFO - 'SHELL': '/bin/bash', 04:53:27 INFO - 'SHLVL': '1', 04:53:27 INFO - 'TERM': 'linux', 04:53:27 INFO - 'TMOUT': '86400', 04:53:27 INFO - 'USER': 'cltbld', 04:53:27 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:27 INFO - '_': '/tools/buildbot/bin/python'} 04:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:27 INFO - Downloading/unpacking psutil>=0.7.1 04:53:27 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 04:53:27 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 04:53:27 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 04:53:27 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 04:53:27 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 04:53:27 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 04:53:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:53:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:29 INFO - Installing collected packages: psutil 04:53:29 INFO - Running setup.py install for psutil 04:53:29 INFO - building 'psutil._psutil_linux' extension 04:53:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:53:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:53:30 INFO - building 'psutil._psutil_posix' extension 04:53:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:53:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:30 INFO - Successfully installed psutil 04:53:30 INFO - Cleaning up... 04:53:30 INFO - Return code: 0 04:53:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:53:30 INFO - Using env: {'DISPLAY': ':0', 04:53:30 INFO - 'HOME': '/home/cltbld', 04:53:30 INFO - 'LANG': 'en_US.UTF-8', 04:53:30 INFO - 'LANGUAGE': 'en_US:en', 04:53:30 INFO - 'LOGNAME': 'cltbld', 04:53:30 INFO - 'MAIL': '/var/mail/cltbld', 04:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:30 INFO - 'MOZ_NO_REMOTE': '1', 04:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:30 INFO - 'NO_EM_RESTART': '1', 04:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:30 INFO - 'PWD': '/builds/slave/test', 04:53:30 INFO - 'SHELL': '/bin/bash', 04:53:30 INFO - 'SHLVL': '1', 04:53:30 INFO - 'TERM': 'linux', 04:53:30 INFO - 'TMOUT': '86400', 04:53:30 INFO - 'USER': 'cltbld', 04:53:30 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:30 INFO - '_': '/tools/buildbot/bin/python'} 04:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:32 INFO - Installing collected packages: mozsystemmonitor 04:53:32 INFO - Running setup.py install for mozsystemmonitor 04:53:32 INFO - Successfully installed mozsystemmonitor 04:53:32 INFO - Cleaning up... 04:53:32 INFO - Return code: 0 04:53:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:32 INFO - Using env: {'DISPLAY': ':0', 04:53:32 INFO - 'HOME': '/home/cltbld', 04:53:32 INFO - 'LANG': 'en_US.UTF-8', 04:53:32 INFO - 'LANGUAGE': 'en_US:en', 04:53:32 INFO - 'LOGNAME': 'cltbld', 04:53:32 INFO - 'MAIL': '/var/mail/cltbld', 04:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:32 INFO - 'MOZ_NO_REMOTE': '1', 04:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:32 INFO - 'NO_EM_RESTART': '1', 04:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:32 INFO - 'PWD': '/builds/slave/test', 04:53:32 INFO - 'SHELL': '/bin/bash', 04:53:32 INFO - 'SHLVL': '1', 04:53:32 INFO - 'TERM': 'linux', 04:53:32 INFO - 'TMOUT': '86400', 04:53:32 INFO - 'USER': 'cltbld', 04:53:32 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:32 INFO - '_': '/tools/buildbot/bin/python'} 04:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:35 INFO - Downloading docopt-0.6.1.tar.gz 04:53:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:35 INFO - Running setup.py install for blobuploader 04:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:35 INFO - Running setup.py install for requests 04:53:35 INFO - Running setup.py install for docopt 04:53:35 INFO - Successfully installed blobuploader requests docopt 04:53:35 INFO - Cleaning up... 04:53:35 INFO - Return code: 0 04:53:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:35 INFO - Using env: {'DISPLAY': ':0', 04:53:35 INFO - 'HOME': '/home/cltbld', 04:53:35 INFO - 'LANG': 'en_US.UTF-8', 04:53:35 INFO - 'LANGUAGE': 'en_US:en', 04:53:35 INFO - 'LOGNAME': 'cltbld', 04:53:35 INFO - 'MAIL': '/var/mail/cltbld', 04:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:35 INFO - 'MOZ_NO_REMOTE': '1', 04:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:35 INFO - 'NO_EM_RESTART': '1', 04:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:35 INFO - 'PWD': '/builds/slave/test', 04:53:35 INFO - 'SHELL': '/bin/bash', 04:53:35 INFO - 'SHLVL': '1', 04:53:35 INFO - 'TERM': 'linux', 04:53:35 INFO - 'TMOUT': '86400', 04:53:35 INFO - 'USER': 'cltbld', 04:53:35 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:35 INFO - '_': '/tools/buildbot/bin/python'} 04:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:35 INFO - Running setup.py (path:/tmp/pip-6SrdX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:35 INFO - Running setup.py (path:/tmp/pip-thMV_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 INFO - Running setup.py (path:/tmp/pip-7pDBtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:36 INFO - Running setup.py (path:/tmp/pip-XfaOg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:36 INFO - Running setup.py (path:/tmp/pip-vfRVUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:36 INFO - Running setup.py (path:/tmp/pip-EPdcOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:36 INFO - Running setup.py (path:/tmp/pip-iyAHWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:36 INFO - Running setup.py (path:/tmp/pip-Tl7dUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:36 INFO - Running setup.py (path:/tmp/pip-qpDXQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:36 INFO - Running setup.py (path:/tmp/pip-o5q9Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:36 INFO - Running setup.py (path:/tmp/pip-4wTjlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:36 INFO - Running setup.py (path:/tmp/pip-vlC0RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:36 INFO - Running setup.py (path:/tmp/pip-BsBnkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:36 INFO - Running setup.py (path:/tmp/pip-sQITXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:36 INFO - Running setup.py (path:/tmp/pip-lkd_AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:36 INFO - Running setup.py (path:/tmp/pip-CW06V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:37 INFO - Running setup.py (path:/tmp/pip-TnL9ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:37 INFO - Running setup.py install for manifestparser 04:53:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Running setup.py install for mozcrash 04:53:37 INFO - Running setup.py install for mozdebug 04:53:37 INFO - Running setup.py install for mozdevice 04:53:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Running setup.py install for mozfile 04:53:37 INFO - Running setup.py install for mozhttpd 04:53:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Running setup.py install for mozinfo 04:53:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Running setup.py install for mozInstall 04:53:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:37 INFO - Running setup.py install for mozleak 04:53:38 INFO - Running setup.py install for mozlog 04:53:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for moznetwork 04:53:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for mozprocess 04:53:38 INFO - Running setup.py install for mozprofile 04:53:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for mozrunner 04:53:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for mozscreenshot 04:53:38 INFO - Running setup.py install for moztest 04:53:38 INFO - Running setup.py install for mozversion 04:53:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:38 INFO - Cleaning up... 04:53:38 INFO - Return code: 0 04:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:38 INFO - Using env: {'DISPLAY': ':0', 04:53:38 INFO - 'HOME': '/home/cltbld', 04:53:38 INFO - 'LANG': 'en_US.UTF-8', 04:53:38 INFO - 'LANGUAGE': 'en_US:en', 04:53:38 INFO - 'LOGNAME': 'cltbld', 04:53:38 INFO - 'MAIL': '/var/mail/cltbld', 04:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:38 INFO - 'MOZ_NO_REMOTE': '1', 04:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:38 INFO - 'NO_EM_RESTART': '1', 04:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:38 INFO - 'PWD': '/builds/slave/test', 04:53:38 INFO - 'SHELL': '/bin/bash', 04:53:38 INFO - 'SHLVL': '1', 04:53:38 INFO - 'TERM': 'linux', 04:53:38 INFO - 'TMOUT': '86400', 04:53:38 INFO - 'USER': 'cltbld', 04:53:38 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:38 INFO - '_': '/tools/buildbot/bin/python'} 04:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:39 INFO - Running setup.py (path:/tmp/pip-QmZCMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:39 INFO - Running setup.py (path:/tmp/pip-FzmK7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:39 INFO - Running setup.py (path:/tmp/pip-pZAURP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:39 INFO - Running setup.py (path:/tmp/pip-hqPmUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:39 INFO - Running setup.py (path:/tmp/pip-F8olhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:39 INFO - Running setup.py (path:/tmp/pip-LAbrF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:39 INFO - Running setup.py (path:/tmp/pip-zsm060-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:39 INFO - Running setup.py (path:/tmp/pip-jAbxuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:39 INFO - Running setup.py (path:/tmp/pip-PGHLdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:39 INFO - Running setup.py (path:/tmp/pip-i7Plaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:39 INFO - Running setup.py (path:/tmp/pip-Jb5chO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:39 INFO - Running setup.py (path:/tmp/pip-l2VREX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:39 INFO - Running setup.py (path:/tmp/pip-ZwF1t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:40 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)) 04:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:40 INFO - Running setup.py (path:/tmp/pip-NXv1ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:40 INFO - Running setup.py (path:/tmp/pip-Hmbm99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:40 INFO - Running setup.py (path:/tmp/pip-y7zqne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:40 INFO - Running setup.py (path:/tmp/pip-HIGqOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - Downloading blessings-1.5.1.tar.gz 04:53:42 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 04:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:42 INFO - Installing collected packages: blessings 04:53:42 INFO - Running setup.py install for blessings 04:53:42 INFO - Successfully installed blessings 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:42 INFO - Reading from file tmpfile_stdout 04:53:42 INFO - Current package versions: 04:53:42 INFO - argparse == 1.2.1 04:53:42 INFO - blessings == 1.5.1 04:53:42 INFO - blobuploader == 1.2.4 04:53:42 INFO - docopt == 0.6.1 04:53:42 INFO - manifestparser == 1.1 04:53:42 INFO - mozInstall == 1.12 04:53:42 INFO - mozcrash == 0.16 04:53:42 INFO - mozdebug == 0.1 04:53:42 INFO - mozdevice == 0.47 04:53:42 INFO - mozfile == 1.2 04:53:42 INFO - mozhttpd == 0.7 04:53:42 INFO - mozinfo == 0.9 04:53:42 INFO - mozleak == 0.1 04:53:42 INFO - mozlog == 3.1 04:53:42 INFO - moznetwork == 0.27 04:53:42 INFO - mozprocess == 0.22 04:53:42 INFO - mozprofile == 0.27 04:53:42 INFO - mozrunner == 6.11 04:53:42 INFO - mozscreenshot == 0.1 04:53:42 INFO - mozsystemmonitor == 0.0 04:53:42 INFO - moztest == 0.7 04:53:42 INFO - mozversion == 1.4 04:53:42 INFO - psutil == 3.1.1 04:53:42 INFO - requests == 1.2.3 04:53:42 INFO - wsgiref == 0.1.2 04:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:42 INFO - Using env: {'DISPLAY': ':0', 04:53:42 INFO - 'HOME': '/home/cltbld', 04:53:42 INFO - 'LANG': 'en_US.UTF-8', 04:53:42 INFO - 'LANGUAGE': 'en_US:en', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MAIL': '/var/mail/cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SHLVL': '1', 04:53:42 INFO - 'TERM': 'linux', 04:53:42 INFO - 'TMOUT': '86400', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - '_': '/tools/buildbot/bin/python'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:42 INFO - Using env: {'DISPLAY': ':0', 04:53:42 INFO - 'HOME': '/home/cltbld', 04:53:42 INFO - 'LANG': 'en_US.UTF-8', 04:53:42 INFO - 'LANGUAGE': 'en_US:en', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MAIL': '/var/mail/cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SHLVL': '1', 04:53:42 INFO - 'TERM': 'linux', 04:53:42 INFO - 'TMOUT': '86400', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - '_': '/tools/buildbot/bin/python'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Downloading/unpacking jsonschema 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:53:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:44 INFO - warning: no files found matching '*.txt' 04:53:44 INFO - no previously-included directories found matching 'build' 04:53:44 INFO - no previously-included directories found matching 'dist' 04:53:44 INFO - no previously-included directories found matching '.git*' 04:53:44 INFO - Installing collected packages: jsonschema, functools32 04:53:44 INFO - Running setup.py install for functools32 04:53:44 INFO - warning: no files found matching '*.txt' 04:53:44 INFO - no previously-included directories found matching 'build' 04:53:44 INFO - no previously-included directories found matching 'dist' 04:53:44 INFO - no previously-included directories found matching '.git*' 04:53:45 INFO - Successfully installed jsonschema functools32 04:53:45 INFO - Cleaning up... 04:53:45 INFO - Return code: 0 04:53:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53:45 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')]} 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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')]} 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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 0x7f2cef36cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', '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 04:53:45 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 04:53:45 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 04:53:45 INFO - Using env: {'DISPLAY': ':0', 04:53:45 INFO - 'HOME': '/home/cltbld', 04:53:45 INFO - 'LANG': 'en_US.UTF-8', 04:53:45 INFO - 'LANGUAGE': 'en_US:en', 04:53:45 INFO - 'LOGNAME': 'cltbld', 04:53:45 INFO - 'MAIL': '/var/mail/cltbld', 04:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:45 INFO - 'MOZ_NO_REMOTE': '1', 04:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:45 INFO - 'NO_EM_RESTART': '1', 04:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:45 INFO - 'PWD': '/builds/slave/test', 04:53:45 INFO - 'SHELL': '/bin/bash', 04:53:45 INFO - 'SHLVL': '1', 04:53:45 INFO - 'TERM': 'linux', 04:53:45 INFO - 'TMOUT': '86400', 04:53:45 INFO - 'USER': 'cltbld', 04:53:45 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:45 INFO - '_': '/tools/buildbot/bin/python'} 04:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:45 INFO - Downloading/unpacking flake8 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:53:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:47 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 04:53:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:53:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:47 INFO - no previously-included directories found matching 'docs/_build' 04:53:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:47 INFO - Running setup.py install for pep8 04:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:47 INFO - no previously-included directories found matching 'docs/_build' 04:53:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:53:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:47 INFO - Cleaning up... 04:53:47 INFO - Return code: 0 04:53:47 INFO - Running post-action listener: _resource_record_post_action 04:53:47 INFO - Running post-action listener: _start_resource_monitoring 04:53:47 INFO - Starting resource monitoring. 04:53:47 INFO - ##### 04:53:47 INFO - ##### Running install step. 04:53:47 INFO - ##### 04:53:47 INFO - Running pre-action listener: _resource_record_pre_action 04:53:47 INFO - Running main action method: install 04:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:48 INFO - Reading from file tmpfile_stdout 04:53:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:48 INFO - Reading from file tmpfile_stdout 04:53:48 INFO - Output received: 04:53:48 INFO - Usage: mozinstall [options] installer 04:53:48 INFO - Options: 04:53:48 INFO - -h, --help show this help message and exit 04:53:48 INFO - -d DEST, --destination=DEST 04:53:48 INFO - Directory to install application into. [default: 04:53:48 INFO - "/builds/slave/test"] 04:53:48 INFO - --app=APP Application being installed. [default: firefox] 04:53:48 INFO - mkdir: /builds/slave/test/build/application 04:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:54:02 INFO - Reading from file tmpfile_stdout 04:54:02 INFO - Output received: 04:54:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:02 INFO - Running post-action listener: _resource_record_post_action 04:54:02 INFO - ##### 04:54:02 INFO - ##### Running run-tests step. 04:54:02 INFO - ##### 04:54:02 INFO - Running pre-action listener: _resource_record_pre_action 04:54:02 INFO - Running main action method: run_tests 04:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:02 INFO - Python 2.7.3 04:54:02 INFO - Return code: 0 04:54:02 INFO - grabbing minidump binary from tooltool 04:54: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')]} 04:54:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b80b0>, '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 0x11b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:54:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:02 INFO - Return code: 0 04:54:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:03 INFO - Return code: 0 04:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 04:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 04:54:03 INFO - Using env: {'DISPLAY': ':0', 04:54:03 INFO - 'HOME': '/home/cltbld', 04:54:03 INFO - 'LANG': 'en_US.UTF-8', 04:54:03 INFO - 'LANGUAGE': 'en_US:en', 04:54:03 INFO - 'LOGNAME': 'cltbld', 04:54:03 INFO - 'MAIL': '/var/mail/cltbld', 04:54:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:03 INFO - 'MOZ_NO_REMOTE': '1', 04:54:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:03 INFO - 'NO_EM_RESTART': '1', 04:54:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:03 INFO - 'PWD': '/builds/slave/test', 04:54:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:03 INFO - 'SHELL': '/bin/bash', 04:54:03 INFO - 'SHLVL': '1', 04:54:03 INFO - 'TERM': 'linux', 04:54:03 INFO - 'TMOUT': '86400', 04:54:03 INFO - 'USER': 'cltbld', 04:54:03 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410', 04:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:03 INFO - '_': '/tools/buildbot/bin/python'} 04:54:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 04:54:03 INFO - mozversion INFO | application_buildid: 20151210030842 04:54:03 INFO - mozversion INFO | application_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 04:54:03 INFO - mozversion INFO | application_display_name: Nightly 04:54:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:03 INFO - mozversion INFO | application_name: Firefox 04:54:03 INFO - mozversion INFO | application_remotingname: firefox 04:54:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:54:03 INFO - mozversion INFO | application_vendor: Mozilla 04:54:03 INFO - mozversion INFO | application_version: 45.0a1 04:54:03 INFO - mozversion INFO | platform_buildid: 20151210030842 04:54:03 INFO - mozversion INFO | platform_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 04:54:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:54:03 INFO - mozversion INFO | platform_version: 45.0a1 04:54:03 INFO - 2015-12-10 04:54:03,967 DEBUG : using testdate: 1449752043 04:54:03 INFO - 2015-12-10 04:54:03,967 DEBUG : actual date: 1449752043 04:54:03 INFO - 2015-12-10 04:54:03,975 INFO : starting webserver on 'localhost:41332' 04:54:03 INFO - 2015-12-10 04:54:03,976 INFO : Starting test suite talos-linux64-ix-030.e 04:54:03 INFO - 2015-12-10 04:54:03,976 INFO : Starting test dromaeo_css 04:54:03 INFO - 2015-12-10 04:54:03,977 DEBUG : operating with platform_type : linux_ 04:54:03 INFO - 2015-12-10 04:54:03,977 INFO : Initialising browser for dromaeo_css test... 04:54:03 INFO - 2015-12-10 04:54:03,993 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIHvC0/profile http://localhost:41332/getInfo.html 04:54:09 INFO - 2015-12-10 04:54:09,276 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:54:09 INFO - 2015-12-10 04:54:09,276 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:54:09 INFO - 2015-12-10 04:54:09,276 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:54:09 INFO - 2015-12-10 04:54:09,276 DEBUG : BROWSER_OUTPUT: __metrics 04:54:09 INFO - 2015-12-10 04:54:09,418 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] 04:54:10 INFO - 2015-12-10 04:54:10,329 INFO : Browser initialized. 04:54:10 INFO - 2015-12-10 04:54:10,330 INFO : Running cycle 1/1 for dromaeo_css test... 04:54:10 INFO - 2015-12-10 04:54:10,330 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIHvC0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:54:22 INFO - 2015-12-10 04:54:22,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 143122432 04:54:22 INFO - 2015-12-10 04:54:22,456 DEBUG : BROWSER_OUTPUT: 04:55:12 INFO - 2015-12-10 04:55:12,087 DEBUG : BROWSER_OUTPUT: 1449752112082 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] 04:57:23 INFO - 2015-12-10 04:57:23,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41332/tests/dromaeo/cssquery-ext.html) 04:57:24 INFO - 2015-12-10 04:57:24,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 145620992 04:57:24 INFO - 2015-12-10 04:57:24,614 DEBUG : BROWSER_OUTPUT: 05:00:26 INFO - 2015-12-10 05:00:26,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-ext.html (next: http://localhost:41332/tests/dromaeo/cssquery-jquery.html) 05:00:27 INFO - 2015-12-10 05:00:27,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 145027072 05:00:27 INFO - 2015-12-10 05:00:27,305 DEBUG : BROWSER_OUTPUT: 05:03:29 INFO - 2015-12-10 05:03:29,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41332/tests/dromaeo/cssquery-mootools.html) 05:03:29 INFO - 2015-12-10 05:03:29,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 145797120 05:03:29 INFO - 2015-12-10 05:03:29,675 DEBUG : BROWSER_OUTPUT: 05:06:31 INFO - 2015-12-10 05:06:31,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41332/tests/dromaeo/cssquery-prototype.html) 05:06:32 INFO - 2015-12-10 05:06:32,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 144183296 05:06:32 INFO - 2015-12-10 05:06:32,062 DEBUG : BROWSER_OUTPUT: 05:09:34 INFO - 2015-12-10 05:09:34,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41332/tests/dromaeo/cssquery-yui.html) 05:09:35 INFO - 2015-12-10 05:09:35,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 144756736 05:09:35 INFO - 2015-12-10 05:09:35,354 DEBUG : BROWSER_OUTPUT: 05:12:37 INFO - 2015-12-10 05:12:37,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/dromaeo/cssquery-yui.html (next: http://localhost:41332/tests/dromaeo/cssquery-dojo.html) 05:12:38 INFO - 2015-12-10 05:12:38,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 147308544 05:12:38 INFO - 2015-12-10 05:12:38,035 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,035 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:38 INFO - 2015-12-10 05:12:38,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:38 INFO - 2015-12-10 05:12:38,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:38 INFO - 2015-12-10 05:12:38,036 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:38 INFO - 2015-12-10 05:12:38,036 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2652.8806203720833;2659.920202393929;2700.2169370882443;2701.5542435498146;2721.265258380237;4551.8634440966825;4618.007128467379;4619.168549661055;4636.675432719711;4663.347131401602;4575.748333841638;4630.536946305368;4635.374224479694;4641;4654.8370807021765;4122.402251673506;4351.608355248027;4353.499347575022;4401.647868170555;4542.04617030424;4223.556526564697;4453;4474.194644963905;4503.211937910869;4522.615577675885;4201.76890271035;4319.308910574293;4331.675124365685;4340.197063543254;4344.804483798237;4343.131373725236;4356.237658409766;4376.343548467724;4381.38660587518;4389.188000219938;4219.641330486912;4330.501992270866;4342.761148136851;4349.804258808361;4362.716423432498;4472.955270447286;4520.886977825548;4539.909201815978;4569.908601827945;4576.519465456113;4935.185694360426;5034.471380505068;5080.822171223989;5083.593312534988;5101.591872650179;4813.590844778198;4941.901161976741;4951.03454826309;5124.154514505102;5129.9230511542355;4579.885502862422;4616.8614941551805;4643.605293550086;4664.020555683311;4692.741899195577;5163.845084647466;5189.974050129726;5192.558632516203;5213.374395072539;5221.269022336875;4759.0719809637485;4847.103285892122;4982.77577509013;5018.623603229772;5036.647434679538;4928.6303527235605;4970.72661003641;4991.975040124777;4994.600431965434;5044.722540260247;5021.447640759514;5021.84934451967;5028.748562571856;5050.141475949097;5090.541851233333;4744.335792988984;4872.756362181876;4888.6577939543895;5006.324146240211;5061.063703214843;4122;4139.3583994480905;4153.833846646161;4167.74993500391;4209.410682504452;3613.2231570212007;3616.8010759407957;3618.1859081706407;3646.9817650912105;3652.5799533054037;4212.515560710496;4345.152695224464;4349.108432771274;4353.891152721208;4373.803178856959;4994.475580064113;5077.289179514871;5096.668716533413;5105;5141.0232055909255;4321.351797230378;4325.02686895446;4326.762028088486;4369.344598310216;4370.147821174904;4291.184674911757;4382.824687012548;4405.339199120093;4417.955820441819;4450.3991961085485;4844.660873738804;4870.1233777920315;4883.658143929891;4893.412790465025;4933.753312334441;5109.412417572027;5110.591152707849;5110.71891045996;5115.616328775282;5116.7441627917715;4589.334546490807;4655.2784318430695;4703.388559487382;4710.952890471189;4922.532359425849;4976.452590215001;4980.925286120639;4986.8753281168265;5002.724850133278;5062.038212739568;5025.874353141201;5059.46875578059;5069.138246498031;5070;5108.642395032312;4738.715677059387;4838.516148385133;4860.805567777391;4905.926411103765;4909.289184098429;4936.506349365179;4937.8271760488215;4938.43208031081;4968.602511798975;5022.799088036584;4837.516248375275;4881.975590122027;4883.194272944925;4899.534544218293;4904.092742842586;4772.546608072227;4833.564979151894;4885.780139893643;4912.312276281395;4937.358143441474;4828.155072862305;4851.660383773102;4863.027394521181;4876.829310974099;4906.1659517881335 05:12:38 INFO - 2015-12-10 05:12:38,039 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.2031156381066;580.4369761331507;582.4874110782511;588.9105155462395;590.8109404990404;35638.64361356386;36001.45997810035;36041.45937810931;36064.27871442576;36068;39928.80035599825;40514.79742601283;40532.59467405325;40541.391879121766;40586.797066014704;7909.169537198583;8002.359811215118;8029.478083924555;8079;8083.232092951161;7848.215178482134;7890.960545197266;7933.0480342359;7943.880841787378;7975.042994840598;7926.405519586026;8016.919830801705;8029.237222463886;8053.838923221532;8061.435699501038;7936.365090792723;8009.038915330139;8030.317423019051;8034.437589368747;8053.838923221532;7820.296173344369;7845.37237021037;7872.803179920491;7903.209679032051;7948.920510794934;36712.265754684755;36773.81613091944;36794.816025919965;37036.44445333322;37091.629083709086;2810.901618443365;3110.860011299497;3335.96664033359;3364.7308215342714;3713.665770080706;27422.177334679993;27639.86180069107;27660;28103.156905292875;28866.42267154666;3325.334933013407;3412.6246112927556;3416.7437442191685;3484.2508860595094;3558.217192217708;214932;215099;215922;217031;217187.99999999843;51897;52775;55502;55531.167032494544;56420;48538.5146148534;48540.27189592159;48718.75640621774;48797.512024879295;49035.754821225666;12764.425600847799;12936.547220847226;12939.805902911465;12983.935080324727;13093.476260949647;9316.720498385059;9331.206847418045;9340.159385655188;9342.392744471588;9361.812763744687;18587.535311617048;18888.71666924997;18979;18993;18998.905005474884;7941.9205807942335;8079.394045446497;8124.7562573122905;8131;8214.178582141738;800.7637746864689;851.7019043334783;914.8627705844043;931.669257413622;969.6218474794836;26017;26233.737662623513;26235.21294361172;29544.556831647544;30701.232469188002;917.4403613795579;928.4522131942186;946.8911075226299;1018.251585084962;1109.6338208391212;12981.935090324489;15438.691226175413;15918.283677234553;16148.919255403884;16324.183790810412;315168;315407;320168;320517;322160;45926.5407345929;46642.766786165856;46746;46917;46933;1183.1303991566192;1188.589936471933;1190.5773450425147;1202.8436303280694;1350.891928645706;26715.95245449245;26806.195814125607;27054.864725676245;27164.592531111655;27344.179674609793;38786.6121338783;39325;39412.2117557653;39415.80292098521;39434.21131577295;249325;249970;250045;251293;251795;28276;41459.585404146776;41722.1655566893;42110.36834447547;42390.78804606081;36987.44518832274;37105.81447092747;37201.4419783698;37329.25341493101;38175.42736859005;31569.843015698247;32316.030519084467;32426.513602296458;32651.18372040623;32970;32522.83738581292;33709.662903370656;38039.80980095082;38388.80805596066;38638.80680596579;31841.203969900936;31920.231777859528;32046;32200.516992244666;32247.35505289834;29163;29313;29622.703772962857;29759.55360669635;29842.8507857468;23126;23260.53478930378;23584.882075589514;23608.881955590114;23614.29157125289 05:12:38 INFO - 2015-12-10 05:12:38,041 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.1963016356806;344.83103279393094;345.4024537550037;346.71396098218975;346.9375512407767;14998.40006399744;15371.923140384297;16084.75872861908;16679.49961501154;17361.739573906387;10037.046480584351;10257.487125643707;14298;15777.842221577781;15829.60425989351;4528.343390208426;4650.2559590465535;6487;6743.8651226975435;6765.695543700521;6563.868722625544;6659.533832631718;6697.095892054584;6703.1956165260235;6732.83167920801;6082.118092876531;6297.433231009209;6299;6783.321667833202;6793.354631310018;6232.376762323754;6237.719302631393;6275.968620156916;6365.618062916194;6605.9669701651665;6434.806955791287;6479;6487;6502.382273683992;6502.772402965874;20739.377818665314;21111.47221319464;21638.783612163992;22170.224042158447;22253.666195006925;1901.2300018492533;1999.7300364450905;2001.0195004447862;2048.702938073971;2106.031225636209;13740.65648358789;13767;13985.650358741113;14146.575602731935;14278.000539962206;1841.9815405933655;1853.4624958761942;1892.1579896945864;1935.816097470738;1973.2501649373146;49849.25226121611;50210.7489462554;59573.40426595722;64161.358386416;65562.3443765561;14335.641608959651;14811.925940370229;14944.402223910922;14946.252687365588;14961.40154393812;22783.202587909345;22897.885510572673;22984.4253893654;23031.53936921252;23048.76951230466;8542.273906717874;8609.22516973463;8642.740717778352;8646.092160323076;8654.567271636393;6473.579217350857;6488.935110648928;6853.7943861684225;6882.105326307548;7067.151941767021;7889.171636978034;7918.683252669944;7927;7931.603419828985;8005.839883202303;1775.4851093182833;1848.5009047557085;3181.920451988719;3248.7888287261253;3275.623303320149;371.74906937816866;372.3595415884674;410.6571013204008;414.31430981725293;762.1540090499541;9356.532173391302;9596;9864.803160548745;9865.358751681119;9907;398.2314133721944;409.6886366361527;412.16125185247876;415.61347946410126;432.6863024307352;5306.230596563477;5508.834734957877;5518.91721624176;9177;9602.471864047544;508609;513009;513676.4742644242;532273;538787;70542;71074.28925710676;71354;71805.28194717986;71859;1067.1196263083143;1078.7087486378791;1123.5112725964232;1151.83874257604;1153.037213926381;14277.14337139775;14371.92814035923;14582.562523124323;14739.705205896036;14912.328945197276;33432.33135337328;33647.15882102869;33775.66224337823;34348.656513434544;34809.65190348064;39212.2157556853;40333.59666403416;40448;40833;41047.794761027195;8253.669853205805;8388.622511987098;8567.40028198045;8677.349198809989;8695.434796738191;15917.363305467652;16322.918385407997;16389.42637007699;16692.24884880159;16748.497545073667;14211;14279;14448.349824257723;14511.927440362731;14516.709665806837;13414.463421463031;13505.189688618715;13731.931340343235;13928.51250206238;14147;12842.165259258118;13272.469101235842;14491.420343186155;14718.116912985255;14838;8611.569421528773;8613.913860861312;8628.352873534635;8697.391182617155;8768.561571921506;9555.283353748358;9643.08390702882;12777.425015874494;14154.575362739135;14404.495842645458 05:12:38 INFO - 2015-12-10 05:12:38,042 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1474.9896321020096;1602.95992600185;1688.932442702292;1696.39777878853;1721.896686198828;5974.31295401029;6186.164867742853;6558.770443034495;7006.439484841207;7027.648617569121;6608.140941677587;6779.254282028973;6879.5184337096425;6885.483588730853;6887.793366199022;1968.3406058970227;2025.2607798153715;2025.7163997040427;2027.564073724149;2028.868123571963;2077.3767869639123;2088.342172215755;2102.3903068110308;2134.6691262854206;2141.2398598497543;2023.655978483654;2046.3963130876352;2063.4325560470916;2077.5948690005457;2078.1168003598486;1933.419974007806;1934.458351661537;1946.1826033066004;1949.1228946973777;1950.8731932424348;2019.4345583236718;2027.9695804562796;2031.3905828251466;2045.0694933805082;2057.5370541628163;6911.101556797635;6982.371586557234;6993.860122797516;7015.193252775894;7039.824004399879;4051.108756073659;4077.97961010196;4097.303458412077;4098.426220329156;4098.4876890388705;2536.1630661881536;2539.4667119904843;2552.706438759548;2621.3315604520726;2624.357032527043;858.6436628799041;861.0485413617924;873.4846440600077;885.0441523155041;891.3448615267773;9106.225970792491;9110.0434454382;9135.223506001998;9187.586558604879;9191.080891910822;3664.5602527696315;3670.963290367062;3710;3718.7396882217986;3728.1984373359314;7886.211378862068;7925.8811117833275;7937.642806073625;7946.841063178819;7957.244061814118;4093.099518106012;4108.281050816096;4113.115680128787;4116.567760385176;4126.319157339006;3208.7593430492807;3266.2977459846247;3698.8335524901445;3791.829367678461;3801.9619803801606;3302.141443224779;3331.1339051846694;3348.748843836673;3378.239896023375;3385.8476368563474;1049.4962418039383;1054.778496515725;1063.2504084620325;1065.94137322448;1075.9085477734325;1152.6081132414852;1173.3957012138756;1179.9705007374712;1184.3663639952583;1205;6659.101021362054;6679.2318883329035;6730.562513436611;6746.22418421878;6764.222114456802;407.7084884307734;408.50162801382265;408.93457046872356;410.17554715022425;412.28262822688305;5014.84955451337;5017.54842064216;5023.246513023076;5031.094403007493;5614.2701448811395;8086.676532938616;8191.180881911761;8282.213189746964;8355.248027677539;8367.665293388318;8124.431289809657;8145.959270203611;8194;8230.62962166704;8303.792405189797;6442.613443193423;6454.709058188475;6486.156799616019;6510.479161667055;6534.313897040837;6528.771492997722;6547.083408322744;6578.046183303299;6587.769428070186;6592.208934927839;7416.184219735933;7534.54792712439;7573.507721998052;7628.656710447932;7659.195784442553;7094.822629434099;7231.855362892607;7301.525400848928;7324.414046876131;7381.557106573623;6233.189685340877;6287.056941458635;6328.557001010069;6337.683115844282;6365.204349456318;6550.181227346582;6556.508261880283;6583.80248592543;6587.769428069994;6604.801855944329;6002.909956350571;6158.291796443287;6250.00000000016;6263.311035785969;6423.164988551458;6029.336772955059;6332.430081292706;6333.65164915934;6365.204349456318;6373.840653983502;6465.579737317059;6469.547131700736;6504.674766261763;6520.543561950808;6524.641144737085;5722.942770572407;5751.1373294006235;5756.021476348947;5759.39526349744;5761.8559536011935;5922.2597175353085;6093.878122437615;6100.0849872519475;6100.572959892765;6102.237220347457 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.9613798275215;317.785494791016;321.29315505887024;321.34445730709353;325.29086591231106;5398.838034858955;5435.673859568424;5453.7818487260565;5489.066858634032;5608.5793565482545;5395.676259424427;5418;5425.3760817506;5455.945440545594;5486.341639003315;4043.231785960673;4157.958420415803;4163.687723420756;4197.097624010837;4200.726952748077;4168.291390463613;4187.7277976931555;4191.601797829201;4194.30793919003;4201.936970945439;4151.418801367811;4154.335306350985;4157.127003329289;4158.729682570638;4161.375793630949;4158.459400277975;4161.167766446708;4169.478815148106;4170.47869016373;4173.227952828736;3518.4194607889667;3643.234920666663;3664.578573464059;3667.21154951684;3668.7615305005356;5076.74616269185;5176.922346164811;5195.480451954812;5209.635325527214;5214.348206474191;4726.621870250372;4746.83386081489;4774.045190961821;4774.73738944358;4776.546228108324;5691.117876729114;5698.458646428583;5712.942870571283;5714.628549144334;5726.79956201531;3800.467934489174;3925.7644541327327;3942.15243722601;3948.2300951314505;3963.742356746802;5969.313528944183;6025.0661147522205;6030;6039.184710064129;6045.365236650133;4076.735012224196;4083.693722970789;4094.058366575645;4095.9385609215888;4106.014556506477;4154.127633197062;4155.439015732898;4159.147374788161;4165.604267594635;4170.374443833449;4651.465081515669;4714.88212794676;4750.501197374295;4759.762011899391;4764.118638051971;5451.700156491352;5609.80365687199;5639.605227634026;5644.97177514118;5655.632383895116;1490.8136482939633;1513.5610672904734;1521.246982743549;1522.7868098466001;1525.4508376984277;1041.3491567770143;1058.2962330050584;1070.4701172919454;1076.4187338836941;1076.56399158341;5002.2496625506465;5030.748462576857;5038.420581633086;5048.646594738407;5051.520105589963;5865.296164460292;5905.645661260338;5910.408959104141;5917.289925208916;5929.762809487658;4997.175466048134;5001.874953126128;5007.69953802773;5022.949770502321;5024.120778863684;3116.2053676312394;3157.7631677623813;3186.060112266887;3188.2029492626843;3192.074298453469;5593.524550413179;5606.887862242732;5617.101263797773;5622.746976386073;5625.831225063254;6023.247094113236;6052.6671033092725;6071.301800292935;6075.665838378844;6088.512918966472;5440.700761458158;5618.522425593788;5618.831435056954;5622.353429355677;5623;5891.440313170242;5902.321233058254;5906.940930590639;5911.261092363455;5919.289685237799;5770.567207459541;5772.509336706259;5773.393793651606;5778.537716982547;5785.797497087582;5597.552195824405;5611.859703507445;5612.887742245214;5620.859478512906;5621.775128994795;4077.041895154577;4157.7089603727445;4168.062186008246;4204.747715137101;4225.5774422558725;5821.854453638693;5872.265966754156;5878.823635290948;5902.321233058254;6003.039513677791;5742.339630942328;5761.942380576141;5763.769449221984;5764.971175144097;5784.884302314014;5746.281714785652;5746.798862039808;5751.8562035949435;5754.741036653444;5762.279715035621;5422.701751403552;5628.831135065954;5637.154426836008;5639.069553523786;5640;5788.507976822018;5802.854928626649;5807.76768929255;5809.215755872903;5812.534997200299;5614.438556144516;5644.153376993484;5656.264685590847;5656.5757568181725;5660.518855897295 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.4668958212594;684.8527566573185;687.522172090397;783.8393129408465;785.3481610263482;11214.66356009319;11427.142964277671;11435.142364322677;11521.654350369492;13890.652733681663;13692.315384230798;13759.449622015132;13810.723785524284;13835.79246311306;13844.930775346134;643.2441880790076;648.8215740671305;816.1838161838161;816.2612835383987;828.9709860154895;810.1452967119686;814.1044850664251;814.7881550796776;815.3192084609358;822.6544851162496;852.688768599463;856.3834039491587;857.952812595307;859.9011113721939;860.3934226370394;845.5011543189547;848.7199224256043;850.0352100366067;851.0723311590334;852.518327145161;628.7170773152054;633.4172561243666;635.3551145587187;636.2396935661886;637;12388.81416778749;12503.687407814787;12542.05934554912;12568.937155314165;12612.68468288291;10645.414502202375;10733.62432314873;11246.437678116143;11288.492017859217;11326.03728683063;9425.434473931586;9466.763330916714;9515.666951656727;9602.183814375787;9610.423374597547;3324.933501329984;3356.590232102523;3381.1547113221695;3385.407553678121;3471.2710330830555;39047.60952390497;39390.21219575592;39640.008999774946;39868.80065599683;40103.7994810027;9227.907720922705;9457.66898158575;9558;9611.231101512001;9720.27097967641;15859.920700396424;15928.442504512519;15966.281517331749;15997.440089596808;16063.759043614355;6227.252729672468;6245.5628106033055;6311.684415779193;6396;6409.198850143732;3642.1258897864323;3647.6899463545365;3703.703703703697;3712.1462063724953;3726.347889119393;2659.6143559184197;2699.1497678231294;2700;2703.851288179169;2704.0535812465873;472.79433446450906;485.5751217684526;486.35800743018876;489.31740222389567;505.6435213174703;503.1572116704505;517.8006467510036;527.857478480808;533.0857579251602;537.8332716857786;7194;7263.273672632695;7300.853982920418;7333.816654583678;7338.926610733931;436.7510519004137;443.8291257865745;456.6415363939292;463.9512851150648;509.20818127810867;3342.398368293682;3350.2294472271515;3353.1449480382835;3497.038314463543;3509.192885636267;47846.28230576544;48094.27858582124;48221.27668084981;48359.03281934412;48407;43552.34671479931;43829.12341753147;44281.557184428384;44435.333469997975;45046.32430513545;40164.397534037016;41291.58708412937;41410.79294603508;41633.167336653096;41755;6925.099737034153;6958.860822783618;6959.582425054513;7036.2260151384335;7133.678984445609;30632.387352252383;30924.536131958488;31527.21181970469;32355.19112022218;32364.676353236166;36030.81984590165;36443.817780910926;36473.63526364809;40378.39432408458;40728.59271407248;7846.293833555007;8124.7562573122905;8139.79650508742;8272.214139656722;8590.269827064769;9644.228461723185;9898.56470811714;9983.60065597368;10034.297599167989;11389.202755807346;10419.114375278186;10492.47537623131;10770;10782.892171078189;10989.61536346224;10239.948800255952;10359.32664376813;10371.429571373646;10600.787984240425;11143.2199746017;10016.148627366463;10233.897661023295;10355.482225888525;10714.464276785973;11037.834432483358;8296.875546866922;8820.603072861608;8843.646254150019;9233.030531794066;9556.331056826233;8202.466839655403;8654.697085601974;9129.634814607341;9276.6289348428;9396.67111651089 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,337 05:12:38 INFO - 2015-12-10 05:12:38,046 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753158033__endTimestamp 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4640.65 Median:4772.55 stddev:493.98 (10.4%) stddev-sans-first:470.24 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: Values: 2652.9 2659.9 2700.2 2701.6 2721.3 4551.9 4618.0 4619.2 4636.7 4663.3 4575.7 4630.5 4635.4 4641.0 4654.8 4122.4 4351.6 4353.5 4401.6 4542.0 4223.6 4453.0 4474.2 4503.2 4522.6 4201.8 4319.3 4331.7 4340.2 4344.8 4343.1 4356.2 4376.3 4381.4 4389.2 4219.6 4330.5 4342.8 4349.8 4362.7 4473.0 4520.9 4539.9 4569.9 4576.5 4935.2 5034.5 5080.8 5083.6 5101.6 4813.6 4941.9 4951.0 5124.2 5129.9 4579.9 4616.9 4643.6 4664.0 4692.7 5163.8 5190.0 5192.6 5213.4 5221.3 4759.1 4847.1 4982.8 5018.6 5036.6 4928.6 4970.7 4992.0 4994.6 5044.7 5021.4 5021.8 5028.7 5050.1 5090.5 4744.3 4872.8 4888.7 5006.3 5061.1 4122.0 4139.4 4153.8 4167.7 4209.4 3613.2 3616.8 3618.2 3647.0 3652.6 4212.5 4345.2 4349.1 4353.9 4373.8 4994.5 5077.3 5096.7 5105.0 5141.0 4321.4 4325.0 4326.8 4369.3 4370.1 4291.2 4382.8 4405.3 4418.0 4450.4 4844.7 4870.1 4883.7 4893.4 4933.8 5109.4 5110.6 5110.7 5115.6 5116.7 4589.3 4655.3 4703.4 4711.0 4922.5 4976.5 4980.9 4986.9 5002.7 5062.0 5025.9 5059.5 5069.1 5070.0 5108.6 4738.7 4838.5 4860.8 4905.9 4909.3 4936.5 4937.8 4938.4 4968.6 5022.8 4837.5 4882.0 4883.2 4899.5 4904.1 4772.5 4833.6 4885.8 4912.3 4937.4 4828.2 4851.7 4863.0 4876.8 4906.2 05:12:38 INFO - 2015-12-10 05:12:38,047 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,048 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42092.46 Median:36784.32 stddev:69287.81 (188.4%) stddev-sans-first:69412.04 05:12:38 INFO - 2015-12-10 05:12:38,048 DEBUG : BROWSER_OUTPUT: Values: 569.2 580.4 582.5 588.9 590.8 35638.6 36001.5 36041.5 36064.3 36068.0 39928.8 40514.8 40532.6 40541.4 40586.8 7909.2 8002.4 8029.5 8079.0 8083.2 7848.2 7891.0 7933.0 7943.9 7975.0 7926.4 8016.9 8029.2 8053.8 8061.4 7936.4 8009.0 8030.3 8034.4 8053.8 7820.3 7845.4 7872.8 7903.2 7948.9 36712.3 36773.8 36794.8 37036.4 37091.6 2810.9 3110.9 3336.0 3364.7 3713.7 27422.2 27639.9 27660.0 28103.2 28866.4 3325.3 3412.6 3416.7 3484.3 3558.2 214932.0 215099.0 215922.0 217031.0 217188.0 51897.0 52775.0 55502.0 55531.2 56420.0 48538.5 48540.3 48718.8 48797.5 49035.8 12764.4 12936.5 12939.8 12983.9 13093.5 9316.7 9331.2 9340.2 9342.4 9361.8 18587.5 18888.7 18979.0 18993.0 18998.9 7941.9 8079.4 8124.8 8131.0 8214.2 800.8 851.7 914.9 931.7 969.6 26017.0 26233.7 26235.2 29544.6 30701.2 917.4 928.5 946.9 1018.3 1109.6 12981.9 15438.7 15918.3 16148.9 16324.2 315168.0 315407.0 320168.0 320517.0 322160.0 45926.5 46642.8 46746.0 46917.0 46933.0 1183.1 1188.6 1190.6 1202.8 1350.9 26716.0 26806.2 27054.9 27164.6 27344.2 38786.6 39325.0 39412.2 39415.8 39434.2 249325.0 249970.0 250045.0 251293.0 251795.0 28276.0 41459.6 41722.2 42110.4 42390.8 36987.4 37105.8 37201.4 37329.3 38175.4 31569.8 32316.0 32426.5 32651.2 32970.0 32522.8 33709.7 38039.8 38388.8 38638.8 31841.2 31920.2 32046.0 32200.5 32247.4 29163.0 29313.0 29622.7 29759.6 29842.9 23126.0 23260.5 23584.9 23608.9 23614.3 05:12:38 INFO - 2015-12-10 05:12:38,048 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,048 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28074.93 Median:19805.22 stddev:84980.23 (429.1%) stddev-sans-first:85193.11 05:12:38 INFO - 2015-12-10 05:12:38,049 DEBUG : BROWSER_OUTPUT: Values: 344.2 344.8 345.4 346.7 346.9 14998.4 15371.9 16084.8 16679.5 17361.7 10037.0 10257.5 14298.0 15777.8 15829.6 4528.3 4650.3 6487.0 6743.9 6765.7 6563.9 6659.5 6697.1 6703.2 6732.8 6082.1 6297.4 6299.0 6783.3 6793.4 6232.4 6237.7 6276.0 6365.6 6606.0 6434.8 6479.0 6487.0 6502.4 6502.8 20739.4 21111.5 21638.8 22170.2 22253.7 1901.2 1999.7 2001.0 2048.7 2106.0 13740.7 13767.0 13985.7 14146.6 14278.0 1842.0 1853.5 1892.2 1935.8 1973.3 49849.3 50210.7 59573.4 64161.4 65562.3 14335.6 14811.9 14944.4 14946.3 14961.4 22783.2 22897.9 22984.4 23031.5 23048.8 8542.3 8609.2 8642.7 8646.1 8654.6 6473.6 6488.9 6853.8 6882.1 7067.2 7889.2 7918.7 7927.0 7931.6 8005.8 1775.5 1848.5 3181.9 3248.8 3275.6 371.7 372.4 410.7 414.3 762.2 9356.5 9596.0 9864.8 9865.4 9907.0 398.2 409.7 412.2 415.6 432.7 5306.2 5508.8 5518.9 9177.0 9602.5 508609.0 513009.0 513676.5 532273.0 538787.0 70542.0 71074.3 71354.0 71805.3 71859.0 1067.1 1078.7 1123.5 1151.8 1153.0 14277.1 14371.9 14582.6 14739.7 14912.3 33432.3 33647.2 33775.7 34348.7 34809.7 39212.2 40333.6 40448.0 40833.0 41047.8 8253.7 8388.6 8567.4 8677.3 8695.4 15917.4 16322.9 16389.4 16692.2 16748.5 14211.0 14279.0 14448.3 14511.9 14516.7 13414.5 13505.2 13731.9 13928.5 14147.0 12842.2 13272.5 14491.4 14718.1 14838.0 8611.6 8613.9 8628.4 8697.4 8768.6 9555.3 9643.1 12777.4 14154.6 14404.5 05:12:38 INFO - 2015-12-10 05:12:38,049 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,049 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4833.81 Median:6100.33 stddev:2500.68 (41.0%) stddev-sans-first:2494.96 05:12:38 INFO - 2015-12-10 05:12:38,050 DEBUG : BROWSER_OUTPUT: Values: 1475.0 1603.0 1688.9 1696.4 1721.9 5974.3 6186.2 6558.8 7006.4 7027.6 6608.1 6779.3 6879.5 6885.5 6887.8 1968.3 2025.3 2025.7 2027.6 2028.9 2077.4 2088.3 2102.4 2134.7 2141.2 2023.7 2046.4 2063.4 2077.6 2078.1 1933.4 1934.5 1946.2 1949.1 1950.9 2019.4 2028.0 2031.4 2045.1 2057.5 6911.1 6982.4 6993.9 7015.2 7039.8 4051.1 4078.0 4097.3 4098.4 4098.5 2536.2 2539.5 2552.7 2621.3 2624.4 858.6 861.0 873.5 885.0 891.3 9106.2 9110.0 9135.2 9187.6 9191.1 3664.6 3671.0 3710.0 3718.7 3728.2 7886.2 7925.9 7937.6 7946.8 7957.2 4093.1 4108.3 4113.1 4116.6 4126.3 3208.8 3266.3 3698.8 3791.8 3802.0 3302.1 3331.1 3348.7 3378.2 3385.8 1049.5 1054.8 1063.3 1065.9 1075.9 1152.6 1173.4 1180.0 1184.4 1205.0 6659.1 6679.2 6730.6 6746.2 6764.2 407.7 408.5 408.9 410.2 412.3 5014.8 5017.5 5023.2 5031.1 5614.3 8086.7 8191.2 8282.2 8355.2 8367.7 8124.4 8146.0 8194.0 8230.6 8303.8 6442.6 6454.7 6486.2 6510.5 6534.3 6528.8 6547.1 6578.0 6587.8 6592.2 7416.2 7534.5 7573.5 7628.7 7659.2 7094.8 7231.9 7301.5 7324.4 7381.6 6233.2 6287.1 6328.6 6337.7 6365.2 6550.2 6556.5 6583.8 6587.8 6604.8 6002.9 6158.3 6250.0 6263.3 6423.2 6029.3 6332.4 6333.7 6365.2 6373.8 6465.6 6469.5 6504.7 6520.5 6524.6 5722.9 5751.1 5756.0 5759.4 5761.9 5922.3 6093.9 6100.1 6100.6 6102.2 05:12:38 INFO - 2015-12-10 05:12:38,050 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,050 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4737.98 Median:5397.26 stddev:1386.84 (25.7%) stddev-sans-first:1350.30 05:12:38 INFO - 2015-12-10 05:12:38,050 DEBUG : BROWSER_OUTPUT: Values: 309.0 317.8 321.3 321.3 325.3 5398.8 5435.7 5453.8 5489.1 5608.6 5395.7 5418.0 5425.4 5455.9 5486.3 4043.2 4158.0 4163.7 4197.1 4200.7 4168.3 4187.7 4191.6 4194.3 4201.9 4151.4 4154.3 4157.1 4158.7 4161.4 4158.5 4161.2 4169.5 4170.5 4173.2 3518.4 3643.2 3664.6 3667.2 3668.8 5076.7 5176.9 5195.5 5209.6 5214.3 4726.6 4746.8 4774.0 4774.7 4776.5 5691.1 5698.5 5712.9 5714.6 5726.8 3800.5 3925.8 3942.2 3948.2 3963.7 5969.3 6025.1 6030.0 6039.2 6045.4 4076.7 4083.7 4094.1 4095.9 4106.0 4154.1 4155.4 4159.1 4165.6 4170.4 4651.5 4714.9 4750.5 4759.8 4764.1 5451.7 5609.8 5639.6 5645.0 5655.6 1490.8 1513.6 1521.2 1522.8 1525.5 1041.3 1058.3 1070.5 1076.4 1076.6 5002.2 5030.7 5038.4 5048.6 5051.5 5865.3 5905.6 5910.4 5917.3 5929.8 4997.2 5001.9 5007.7 5022.9 5024.1 3116.2 3157.8 3186.1 3188.2 3192.1 5593.5 5606.9 5617.1 5622.7 5625.8 6023.2 6052.7 6071.3 6075.7 6088.5 5440.7 5618.5 5618.8 5622.4 5623.0 5891.4 5902.3 5906.9 5911.3 5919.3 5770.6 5772.5 5773.4 5778.5 5785.8 5597.6 5611.9 5612.9 5620.9 5621.8 4077.0 4157.7 4168.1 4204.7 4225.6 5821.9 5872.3 5878.8 5902.3 6003.0 5742.3 5761.9 5763.8 5765.0 5784.9 5746.3 5746.8 5751.9 5754.7 5762.3 5422.7 5628.8 5637.2 5639.1 5640.0 5788.5 5802.9 5807.8 5809.2 5812.5 5614.4 5644.2 5656.3 5656.6 5660.5 05:12:38 INFO - 2015-12-10 05:12:38,050 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,051 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12082.41 Median:468.37 stddev:13623.98 (2908.8%) stddev-sans-first:13635.30 05:12:38 INFO - 2015-12-10 05:12:38,052 DEBUG : BROWSER_OUTPUT: Values: 683.5 684.9 687.5 783.8 785.3 11214.7 11427.1 11435.1 11521.7 13890.7 13692.3 13759.4 13810.7 13835.8 13844.9 643.2 648.8 816.2 816.3 829.0 810.1 814.1 814.8 815.3 822.7 852.7 856.4 858.0 859.9 860.4 845.5 848.7 850.0 851.1 852.5 628.7 633.4 635.4 636.2 637.0 12388.8 12503.7 12542.1 12568.9 12612.7 10645.4 10733.6 11246.4 11288.5 11326.0 9425.4 9466.8 9515.7 9602.2 9610.4 3324.9 3356.6 3381.2 3385.4 3471.3 39047.6 39390.2 39640.0 39868.8 40103.8 9227.9 9457.7 9558.0 9611.2 9720.3 15859.9 15928.4 15966.3 15997.4 16063.8 6227.3 6245.6 6311.7 6396.0 6409.2 3642.1 3647.7 3703.7 3712.1 3726.3 2659.6 2699.1 2700.0 2703.9 2704.1 472.8 485.6 486.4 489.3 505.6 503.2 517.8 527.9 533.1 537.8 7194.0 7263.3 7300.9 7333.8 7338.9 436.8 443.8 456.6 464.0 509.2 3342.4 3350.2 3353.1 3497.0 3509.2 47846.3 48094.3 48221.3 48359.0 48407.0 43552.3 43829.1 44281.6 44435.3 45046.3 40164.4 41291.6 41410.8 41633.2 41755.0 6925.1 6958.9 6959.6 7036.2 7133.7 30632.4 30924.5 31527.2 32355.2 32364.7 36030.8 36443.8 36473.6 40378.4 40728.6 7846.3 8124.8 8139.8 8272.2 8590.3 9644.2 9898.6 9983.6 10034.3 11389.2 10419.1 10492.5 10770.0 10782.9 10989.6 10239.9 10359.3 10371.4 10600.8 11143.2 10016.1 10233.9 10355.5 10714.5 11037.8 8296.9 8820.6 8843.6 9233.0 9556.3 8202.5 8654.7 9129.6 9276.6 9396.7 05:12:38 INFO - 2015-12-10 05:12:38,052 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:38 INFO - 2015-12-10 05:12:38,053 DEBUG : BROWSER_OUTPUT: 05:12:38 INFO - 2015-12-10 05:12:38,790 INFO : Browser exited with error code: 0 05:12:38 INFO - 2015-12-10 05:12:38,808 INFO : Completed test dromaeo_css (00:18:34) 05:12:38 INFO - 2015-12-10 05:12:38,808 INFO : Starting test kraken 05:12:38 INFO - 2015-12-10 05:12:38,808 DEBUG : operating with platform_type : linux_ 05:12:38 INFO - 2015-12-10 05:12:38,809 INFO : Initialising browser for kraken test... 05:12:38 INFO - 2015-12-10 05:12:38,815 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRGimL/profile http://localhost:41332/getInfo.html 05:12:43 INFO - 2015-12-10 05:12:43,695 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:12:43 INFO - 2015-12-10 05:12:43,695 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:12:43 INFO - 2015-12-10 05:12:43,695 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:12:43 INFO - 2015-12-10 05:12:43,695 DEBUG : BROWSER_OUTPUT: __metrics 05:12:43 INFO - 2015-12-10 05:12:43,812 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] 05:12:44 INFO - 2015-12-10 05:12:44,741 INFO : Browser initialized. 05:12:44 INFO - 2015-12-10 05:12:44,742 INFO : Running cycle 1/1 for kraken test... 05:12:44 INFO - 2015-12-10 05:12:44,742 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRGimL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:56 INFO - 2015-12-10 05:12:56,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 143081472 05:12:56 INFO - 2015-12-10 05:12:56,736 DEBUG : BROWSER_OUTPUT: 05:12:59 INFO - 2015-12-10 05:12:59,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41332/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:59 INFO - 2015-12-10 05:12:59,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 143388672 05:12:59 INFO - 2015-12-10 05:12:59,917 DEBUG : BROWSER_OUTPUT: 05:13:02 INFO - 2015-12-10 05:13:02,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41332/tests/kraken/driver.html?testName=audio-dft) 05:13:03 INFO - 2015-12-10 05:13:03,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 142761984 05:13:03 INFO - 2015-12-10 05:13:03,269 DEBUG : BROWSER_OUTPUT: 05:13:06 INFO - 2015-12-10 05:13:06,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41332/tests/kraken/driver.html?testName=audio-fft) 05:13:06 INFO - 2015-12-10 05:13:06,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 05:13:06 INFO - 2015-12-10 05:13:06,754 DEBUG : BROWSER_OUTPUT: 05:13:08 INFO - 2015-12-10 05:13:08,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41332/tests/kraken/driver.html?testName=audio-oscillator) 05:13:09 INFO - 2015-12-10 05:13:09,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 138129408 05:13:09 INFO - 2015-12-10 05:13:09,476 DEBUG : BROWSER_OUTPUT: 05:13:11 INFO - 2015-12-10 05:13:11,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:12 INFO - 2015-12-10 05:13:12,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 140136448 05:13:12 INFO - 2015-12-10 05:13:12,331 DEBUG : BROWSER_OUTPUT: 05:13:15 INFO - 2015-12-10 05:13:15,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41332/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:15 INFO - 2015-12-10 05:13:15,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 141041664 05:13:15 INFO - 2015-12-10 05:13:15,976 DEBUG : BROWSER_OUTPUT: 05:13:19 INFO - 2015-12-10 05:13:19,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41332/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:20 INFO - 2015-12-10 05:13:20,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 05:13:20 INFO - 2015-12-10 05:13:20,080 DEBUG : BROWSER_OUTPUT: 05:13:22 INFO - 2015-12-10 05:13:22,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41332/tests/kraken/driver.html?testName=json-parse-financial) 05:13:23 INFO - 2015-12-10 05:13:23,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 05:13:23 INFO - 2015-12-10 05:13:23,560 DEBUG : BROWSER_OUTPUT: 05:13:25 INFO - 2015-12-10 05:13:25,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:25 INFO - 2015-12-10 05:13:25,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 140419072 05:13:25 INFO - 2015-12-10 05:13:25,930 DEBUG : BROWSER_OUTPUT: 05:13:27 INFO - 2015-12-10 05:13:27,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:28 INFO - 2015-12-10 05:13:28,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 139223040 05:13:28 INFO - 2015-12-10 05:13:28,431 DEBUG : BROWSER_OUTPUT: 05:13:30 INFO - 2015-12-10 05:13:30,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:31 INFO - 2015-12-10 05:13:31,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 05:13:31 INFO - 2015-12-10 05:13:31,169 DEBUG : BROWSER_OUTPUT: 05:13:33 INFO - 2015-12-10 05:13:33,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:34 INFO - 2015-12-10 05:13:34,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 140562432 05:13:34 INFO - 2015-12-10 05:13:34,380 DEBUG : BROWSER_OUTPUT: 05:13:37 INFO - 2015-12-10 05:13:37,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:37 INFO - 2015-12-10 05:13:37,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 139714560 05:13:37 INFO - 2015-12-10 05:13:37,631 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41332/tests/kraken/driver.html?testName=ai-astar) 05:13:39 INFO - 2015-12-10 05:13:39,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 140410880 05:13:39 INFO - 2015-12-10 05:13:39,650 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,652 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:39 INFO - 2015-12-10 05:13:39,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:39 INFO - 2015-12-10 05:13:39,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:39 INFO - 2015-12-10 05:13:39,652 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:39 INFO - 2015-12-10 05:13:39,652 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;111;114;115;113;125;112;113;114;112 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;140;158;164;130;162;154;132;168;140 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;164;163;163;173;163;165;164 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;76;79;72;72;135;79;78;83;74 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;142;95;94;94;132;95;95;130 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;113;110;110;110;110 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;147;147;147;147;148;148 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;95;96;96 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;75;74;74;73;73;74;74;71 05:13:39 INFO - 2015-12-10 05:13:39,654 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;67;67;68;67;67;67;68 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;83;85;84;91;84;83;84;84 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;136;130;126;123;137;123;135;121;122 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;153;148;148;139;149;148;146;151;159 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;73;70;71;71;74;73;72;72 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753219651__endTimestamp 05:13:39 INFO - 2015-12-10 05:13:39,655 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:113.50 stddev:3.97 (3.5%) stddev-sans-first:4.18 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: Values: 113.0 111.0 114.0 115.0 113.0 125.0 112.0 113.0 114.0 112.0 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.00 stddev:13.75 (8.8%) stddev-sans-first:14.44 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: Values: 156.0 140.0 158.0 164.0 130.0 162.0 154.0 132.0 168.0 140.0 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,657 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.37 (2.1%) stddev-sans-first:3.49 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 164.0 163.0 163.0 173.0 163.0 165.0 164.0 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:18.93 (24.6%) stddev-sans-first:19.79 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 79.0 72.0 72.0 135.0 79.0 78.0 83.0 74.0 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:19.54 (20.6%) stddev-sans-first:20.26 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 142.0 95.0 94.0 94.0 132.0 95.0 95.0 130.0 05:13:39 INFO - 2015-12-10 05:13:39,658 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,659 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 05:13:39 INFO - 2015-12-10 05:13:39,659 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 113.0 110.0 110.0 110.0 110.0 05:13:39 INFO - 2015-12-10 05:13:39,659 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:74.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 75.0 74.0 74.0 73.0 73.0 74.0 74.0 71.0 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.37 (2.8%) stddev-sans-first:2.51 05:13:39 INFO - 2015-12-10 05:13:39,660 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 83.0 85.0 84.0 91.0 84.0 83.0 84.0 84.0 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.00 stddev:6.63 (5.2%) stddev-sans-first:6.49 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: Values: 120.0 136.0 130.0 126.0 123.0 137.0 123.0 135.0 121.0 122.0 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:148.50 stddev:5.82 (3.9%) stddev-sans-first:5.39 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: Values: 140.0 153.0 148.0 148.0 139.0 149.0 148.0 146.0 151.0 159.0 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.58 (2.2%) stddev-sans-first:1.58 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 73.0 70.0 71.0 71.0 74.0 73.0 72.0 72.0 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:39 INFO - 2015-12-10 05:13:39,661 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-12-10 05:13:40,573 INFO : Browser exited with error code: 0 05:13:40 INFO - 2015-12-10 05:13:40,627 INFO : Completed test kraken (00:01:01) 05:13:40 INFO - 2015-12-10 05:13:40,627 INFO : Starting test v8_7 05:13:40 INFO - 2015-12-10 05:13:40,627 DEBUG : operating with platform_type : linux_ 05:13:40 INFO - 2015-12-10 05:13:40,627 INFO : Initialising browser for v8_7 test... 05:13:40 INFO - 2015-12-10 05:13:40,633 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzG5XA/profile http://localhost:41332/getInfo.html 05:13:45 INFO - 2015-12-10 05:13:45,614 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:13:45 INFO - 2015-12-10 05:13:45,614 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:13:45 INFO - 2015-12-10 05:13:45,615 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:13:45 INFO - 2015-12-10 05:13:45,615 DEBUG : BROWSER_OUTPUT: __metrics 05:13:45 INFO - 2015-12-10 05:13:45,756 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] 05:13:46 INFO - 2015-12-10 05:13:46,749 INFO : Browser initialized. 05:13:46 INFO - 2015-12-10 05:13:46,750 INFO : Running cycle 1/1 for v8_7 test... 05:13:46 INFO - 2015-12-10 05:13:46,750 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzG5XA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:13:58 INFO - 2015-12-10 05:13:58,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 143134720 05:13:58 INFO - 2015-12-10 05:13:58,780 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41332/tests/v8_7/run.html (next: http://localhost:41332/tests/v8_7/run.html) 05:14:20 INFO - 2015-12-10 05:14:20,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 138141696 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 05:14:20 INFO - 2015-12-10 05:14:20,522 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.49751053236307 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1082.2510822510822 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |5;Earley;726.7441860465116 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 05:14:20 INFO - 2015-12-10 05:14:20,523 DEBUG : BROWSER_OUTPUT: |8;Splay;608.2224909310762 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753260521__endTimestamp 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:14:20 INFO - 2015-12-10 05:14:20,524 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: Values: 166.3 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.50 Median:191.50 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,525 DEBUG : BROWSER_OUTPUT: Values: 191.5 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: Values: 277.5 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: Values: 5208.3 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: Values: 1082.3 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,526 DEBUG : BROWSER_OUTPUT: Values: 726.7 05:14:20 INFO - 2015-12-10 05:14:20,527 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: Values: 12219.5 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: Values: 26153.8 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.22 Median:608.22 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: Values: 608.2 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: Values: 4840.6 05:14:20 INFO - 2015-12-10 05:14:20,528 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:14:20 INFO - 2015-12-10 05:14:20,529 DEBUG : BROWSER_OUTPUT: 05:14:21 INFO - 2015-12-10 05:14:21,517 INFO : Browser exited with error code: 0 05:14:21 INFO - 2015-12-10 05:14:21,534 INFO : Completed test v8_7 (00:00:40) 05:14:21 INFO - 2015-12-10 05:14:21,987 INFO : Completed test suite (00:20:18) 05:14:21 INFO - 2015-12-10 05:14:21,988 DEBUG : Working with test: dromaeo_css 05:14:21 INFO - 2015-12-10 05:14:21,988 DEBUG : Generating results file: dromaeo_css 05:14:21 INFO - 2015-12-10 05:14:21,989 DEBUG : Working with test: kraken 05:14:21 INFO - 2015-12-10 05:14:21,989 DEBUG : Generating results file: kraken 05:14:21 INFO - 2015-12-10 05:14:21,989 INFO : javascript benchmark 05:14:21 INFO - 2015-12-10 05:14:21,990 DEBUG : Working with test: v8_7 05:14:21 INFO - 2015-12-10 05:14:21,990 DEBUG : Generating results file: v8_7 05:14:21 INFO - 2015-12-10 05:14:21,990 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:22 INFO - 2015-12-10 05:14:22,044 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 05:14:22 INFO - 2015-12-10 05:14:22,044 DEBUG : process_Request line: dromaeo_css 6348.63 graph.html#tests=[[72,94,43]] 05:14:22 INFO - 2015-12-10 05:14:22,044 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:22 INFO - 2015-12-10 05:14:22,074 DEBUG : process_Request line: kraken 1542.60 graph.html#tests=[[232,94,43]] 05:14:22 INFO - 2015-12-10 05:14:22,074 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:22 INFO - 2015-12-10 05:14:22,182 DEBUG : process_Request line: v8_7 21196.29 graph.html#tests=[[230,94,43]] 05:14:22 INFO - 2015-12-10 05:14:22,183 INFO : javascript benchmark 05:14:22 INFO - 2015-12-10 05:14:22,187 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2652.8806203720833, 2659.920202393929, 2700.2169370882443, 2701.5542435498146, 2721.265258380237, 4551.8634440966825, 4618.007128467379, 4619.168549661055, 4636.675432719711, 4663.347131401602, 4575.748333841638, 4630.536946305368, 4635.374224479694, 4641.0, 4654.8370807021765, 4122.402251673506, 4351.608355248027, 4353.499347575022, 4401.647868170555, 4542.04617030424, 4223.556526564697, 4453.0, 4474.194644963905, 4503.211937910869, 4522.615577675885, 4201.76890271035, 4319.308910574293, 4331.675124365685, 4340.197063543254, 4344.804483798237, 4343.131373725236, 4356.237658409766, 4376.343548467724, 4381.38660587518, 4389.188000219938, 4219.641330486912, 4330.501992270866, 4342.761148136851, 4349.804258808361, 4362.716423432498, 4472.955270447286, 4520.886977825548, 4539.909201815978, 4569.908601827945, 4576.519465456113, 4935.185694360426, 5034.471380505068, 5080.822171223989, 5083.593312534988, 5101.591872650179, 4813.590844778198, 4941.901161976741, 4951.03454826309, 5124.154514505102, 5129.9230511542355, 4579.885502862422, 4616.8614941551805, 4643.605293550086, 4664.020555683311, 4692.741899195577, 5163.845084647466, 5189.974050129726, 5192.558632516203, 5213.374395072539, 5221.269022336875, 4759.0719809637485, 4847.103285892122, 4982.77577509013, 5018.623603229772, 5036.647434679538, 4928.6303527235605, 4970.72661003641, 4991.975040124777, 4994.600431965434, 5044.722540260247, 5021.447640759514, 5021.84934451967, 5028.748562571856, 5050.141475949097, 5090.541851233333, 4744.335792988984, 4872.756362181876, 4888.6577939543895, 5006.324146240211, 5061.063703214843, 4122.0, 4139.3583994480905, 4153.833846646161, 4167.74993500391, 4209.410682504452, 3613.2231570212007, 3616.8010759407957, 3618.1859081706407, 3646.9817650912105, 3652.5799533054037, 4212.515560710496, 4345.152695224464, 4349.108432771274, 4353.891152721208, 4373.803178856959, 4994.475580064113, 5077.289179514871, 5096.668716533413, 5105.0, 5141.0232055909255, 4321.351797230378, 4325.02686895446, 4326.762028088486, 4369.344598310216, 4370.147821174904, 4291.184674911757, 4382.824687012548, 4405.339199120093, 4417.955820441819, 4450.3991961085485, 4844.660873738804, 4870.1233777920315, 4883.658143929891, 4893.412790465025, 4933.753312334441, 5109.412417572027, 5110.591152707849, 5110.71891045996, 5115.616328775282, 5116.7441627917715, 4589.334546490807, 4655.2784318430695, 4703.388559487382, 4710.952890471189, 4922.532359425849, 4976.452590215001, 4980.925286120639, 4986.8753281168265, 5002.724850133278, 5062.038212739568, 5025.874353141201, 5059.46875578059, 5069.138246498031, 5070.0, 5108.642395032312, 4738.715677059387, 4838.516148385133, 4860.805567777391, 4905.926411103765, 4909.289184098429, 4936.506349365179, 4937.8271760488215, 4938.43208031081, 4968.602511798975, 5022.799088036584, 4837.516248375275, 4881.975590122027, 4883.194272944925, 4899.534544218293, 4904.092742842586, 4772.546608072227, 4833.564979151894, 4885.780139893643, 4912.312276281395, 4937.358143441474, 4828.155072862305, 4851.660383773102, 4863.027394521181, 4876.829310974099, 4906.1659517881335], "unit": "ms", "name": "dojo.html", "value": 4609.4887398467245}, {"lowerIsBetter": false, "replicates": [569.2031156381066, 580.4369761331507, 582.4874110782511, 588.9105155462395, 590.8109404990404, 35638.64361356386, 36001.45997810035, 36041.45937810931, 36064.27871442576, 36068.0, 39928.80035599825, 40514.79742601283, 40532.59467405325, 40541.391879121766, 40586.797066014704, 7909.169537198583, 8002.359811215118, 8029.478083924555, 8079.0, 8083.232092951161, 7848.215178482134, 7890.960545197266, 7933.0480342359, 7943.880841787378, 7975.042994840598, 7926.405519586026, 8016.919830801705, 8029.237222463886, 8053.838923221532, 8061.435699501038, 7936.365090792723, 8009.038915330139, 8030.317423019051, 8034.437589368747, 8053.838923221532, 7820.296173344369, 7845.37237021037, 7872.803179920491, 7903.209679032051, 7948.920510794934, 36712.265754684755, 36773.81613091944, 36794.816025919965, 37036.44445333322, 37091.629083709086, 2810.901618443365, 3110.860011299497, 3335.96664033359, 3364.7308215342714, 3713.665770080706, 27422.177334679993, 27639.86180069107, 27660.0, 28103.156905292875, 28866.42267154666, 3325.334933013407, 3412.6246112927556, 3416.7437442191685, 3484.2508860595094, 3558.217192217708, 214932.0, 215099.0, 215922.0, 217031.0, 217187.99999999843, 51897.0, 52775.0, 55502.0, 55531.167032494544, 56420.0, 48538.5146148534, 48540.27189592159, 48718.75640621774, 48797.512024879295, 49035.754821225666, 12764.425600847799, 12936.547220847226, 12939.805902911465, 12983.935080324727, 13093.476260949647, 9316.720498385059, 9331.206847418045, 9340.159385655188, 9342.392744471588, 9361.812763744687, 18587.535311617048, 18888.71666924997, 18979.0, 18993.0, 18998.905005474884, 7941.9205807942335, 8079.394045446497, 8124.7562573122905, 8131.0, 8214.178582141738, 800.7637746864689, 851.7019043334783, 914.8627705844043, 931.669257413622, 969.6218474794836, 26017.0, 26233.737662623513, 26235.21294361172, 29544.556831647544, 30701.232469188002, 917.4403613795579, 928.4522131942186, 946.8911075226299, 1018.251585084962, 1109.6338208391212, 12981.935090324489, 15438.691226175413, 15918.283677234553, 16148.919255403884, 16324.183790810412, 315168.0, 315407.0, 320168.0, 320517.0, 322160.0, 45926.5407345929, 46642.766786165856, 46746.0, 46917.0, 46933.0, 1183.1303991566192, 1188.589936471933, 1190.5773450425147, 1202.8436303280694, 1350.891928645706, 26715.95245449245, 26806.195814125607, 27054.864725676245, 27164.592531111655, 27344.179674609793, 38786.6121338783, 39325.0, 39412.2117557653, 39415.80292098521, 39434.21131577295, 249325.0, 249970.0, 250045.0, 251293.0, 251795.0, 28276.0, 41459.585404146776, 41722.1655566893, 42110.36834447547, 42390.78804606081, 36987.44518832274, 37105.81447092747, 37201.4419783698, 37329.25341493101, 38175.42736859005, 31569.843015698247, 32316.030519084467, 32426.513602296458, 32651.18372040623, 32970.0, 32522.83738581292, 33709.662903370656, 38039.80980095082, 38388.80805596066, 38638.80680596579, 31841.203969900936, 31920.231777859528, 32046.0, 32200.516992244666, 32247.35505289834, 29163.0, 29313.0, 29622.703772962857, 29759.55360669635, 29842.8507857468, 23126.0, 23260.53478930378, 23584.882075589514, 23608.881955590114, 23614.29157125289], "unit": "ms", "name": "ext.html", "value": 17075.121219101402}, {"lowerIsBetter": false, "replicates": [344.1963016356806, 344.83103279393094, 345.4024537550037, 346.71396098218975, 346.9375512407767, 14998.40006399744, 15371.923140384297, 16084.75872861908, 16679.49961501154, 17361.739573906387, 10037.046480584351, 10257.487125643707, 14298.0, 15777.842221577781, 15829.60425989351, 4528.343390208426, 4650.2559590465535, 6487.0, 6743.8651226975435, 6765.695543700521, 6563.868722625544, 6659.533832631718, 6697.095892054584, 6703.1956165260235, 6732.83167920801, 6082.118092876531, 6297.433231009209, 6299.0, 6783.321667833202, 6793.354631310018, 6232.376762323754, 6237.719302631393, 6275.968620156916, 6365.618062916194, 6605.9669701651665, 6434.806955791287, 6479.0, 6487.0, 6502.382273683992, 6502.772402965874, 20739.377818665314, 21111.47221319464, 21638.783612163992, 22170.224042158447, 22253.666195006925, 1901.2300018492533, 1999.7300364450905, 2001.0195004447862, 2048.702938073971, 2106.031225636209, 13740.65648358789, 13767.0, 13985.650358741113, 14146.575602731935, 14278.000539962206, 1841.9815405933655, 1853.4624958761942, 1892.1579896945864, 1935.816097470738, 1973.2501649373146, 49849.25226121611, 50210.7489462554, 59573.40426595722, 64161.358386416, 65562.3443765561, 14335.641608959651, 14811.925940370229, 14944.402223910922, 14946.252687365588, 14961.40154393812, 22783.202587909345, 22897.885510572673, 22984.4253893654, 23031.53936921252, 23048.76951230466, 8542.273906717874, 8609.22516973463, 8642.740717778352, 8646.092160323076, 8654.567271636393, 6473.579217350857, 6488.935110648928, 6853.7943861684225, 6882.105326307548, 7067.151941767021, 7889.171636978034, 7918.683252669944, 7927.0, 7931.603419828985, 8005.839883202303, 1775.4851093182833, 1848.5009047557085, 3181.920451988719, 3248.7888287261253, 3275.623303320149, 371.74906937816866, 372.3595415884674, 410.6571013204008, 414.31430981725293, 762.1540090499541, 9356.532173391302, 9596.0, 9864.803160548745, 9865.358751681119, 9907.0, 398.2314133721944, 409.6886366361527, 412.16125185247876, 415.61347946410126, 432.6863024307352, 5306.230596563477, 5508.834734957877, 5518.91721624176, 9177.0, 9602.471864047544, 508609.0, 513009.0, 513676.4742644242, 532273.0, 538787.0, 70542.0, 71074.28925710676, 71354.0, 71805.28194717986, 71859.0, 1067.1196263083143, 1078.7087486378791, 1123.5112725964232, 1151.83874257604, 1153.037213926381, 14277.14337139775, 14371.92814035923, 14582.562523124323, 14739.705205896036, 14912.328945197276, 33432.33135337328, 33647.15882102869, 33775.66224337823, 34348.656513434544, 34809.65190348064, 39212.2157556853, 40333.59666403416, 40448.0, 40833.0, 41047.794761027195, 8253.669853205805, 8388.622511987098, 8567.40028198045, 8677.349198809989, 8695.434796738191, 15917.363305467652, 16322.918385407997, 16389.42637007699, 16692.24884880159, 16748.497545073667, 14211.0, 14279.0, 14448.349824257723, 14511.927440362731, 14516.709665806837, 13414.463421463031, 13505.189688618715, 13731.931340343235, 13928.51250206238, 14147.0, 12842.165259258118, 13272.469101235842, 14491.420343186155, 14718.116912985255, 14838.0, 8611.569421528773, 8613.913860861312, 8628.352873534635, 8697.391182617155, 8768.561571921506, 9555.283353748358, 9643.08390702882, 12777.425015874494, 14154.575362739135, 14404.495842645458], "unit": "ms", "name": "jquery.html", "value": 8786.97304465617}, {"lowerIsBetter": false, "replicates": [1474.9896321020096, 1602.95992600185, 1688.932442702292, 1696.39777878853, 1721.896686198828, 5974.31295401029, 6186.164867742853, 6558.770443034495, 7006.439484841207, 7027.648617569121, 6608.140941677587, 6779.254282028973, 6879.5184337096425, 6885.483588730853, 6887.793366199022, 1968.3406058970227, 2025.2607798153715, 2025.7163997040427, 2027.564073724149, 2028.868123571963, 2077.3767869639123, 2088.342172215755, 2102.3903068110308, 2134.6691262854206, 2141.2398598497543, 2023.655978483654, 2046.3963130876352, 2063.4325560470916, 2077.5948690005457, 2078.1168003598486, 1933.419974007806, 1934.458351661537, 1946.1826033066004, 1949.1228946973777, 1950.8731932424348, 2019.4345583236718, 2027.9695804562796, 2031.3905828251466, 2045.0694933805082, 2057.5370541628163, 6911.101556797635, 6982.371586557234, 6993.860122797516, 7015.193252775894, 7039.824004399879, 4051.108756073659, 4077.97961010196, 4097.303458412077, 4098.426220329156, 4098.4876890388705, 2536.1630661881536, 2539.4667119904843, 2552.706438759548, 2621.3315604520726, 2624.357032527043, 858.6436628799041, 861.0485413617924, 873.4846440600077, 885.0441523155041, 891.3448615267773, 9106.225970792491, 9110.0434454382, 9135.223506001998, 9187.586558604879, 9191.080891910822, 3664.5602527696315, 3670.963290367062, 3710.0, 3718.7396882217986, 3728.1984373359314, 7886.211378862068, 7925.8811117833275, 7937.642806073625, 7946.841063178819, 7957.244061814118, 4093.099518106012, 4108.281050816096, 4113.115680128787, 4116.567760385176, 4126.319157339006, 3208.7593430492807, 3266.2977459846247, 3698.8335524901445, 3791.829367678461, 3801.9619803801606, 3302.141443224779, 3331.1339051846694, 3348.748843836673, 3378.239896023375, 3385.8476368563474, 1049.4962418039383, 1054.778496515725, 1063.2504084620325, 1065.94137322448, 1075.9085477734325, 1152.6081132414852, 1173.3957012138756, 1179.9705007374712, 1184.3663639952583, 1205.0, 6659.101021362054, 6679.2318883329035, 6730.562513436611, 6746.22418421878, 6764.222114456802, 407.7084884307734, 408.50162801382265, 408.93457046872356, 410.17554715022425, 412.28262822688305, 5014.84955451337, 5017.54842064216, 5023.246513023076, 5031.094403007493, 5614.2701448811395, 8086.676532938616, 8191.180881911761, 8282.213189746964, 8355.248027677539, 8367.665293388318, 8124.431289809657, 8145.959270203611, 8194.0, 8230.62962166704, 8303.792405189797, 6442.613443193423, 6454.709058188475, 6486.156799616019, 6510.479161667055, 6534.313897040837, 6528.771492997722, 6547.083408322744, 6578.046183303299, 6587.769428070186, 6592.208934927839, 7416.184219735933, 7534.54792712439, 7573.507721998052, 7628.656710447932, 7659.195784442553, 7094.822629434099, 7231.855362892607, 7301.525400848928, 7324.414046876131, 7381.557106573623, 6233.189685340877, 6287.056941458635, 6328.557001010069, 6337.683115844282, 6365.204349456318, 6550.181227346582, 6556.508261880283, 6583.80248592543, 6587.769428069994, 6604.801855944329, 6002.909956350571, 6158.291796443287, 6250.00000000016, 6263.311035785969, 6423.164988551458, 6029.336772955059, 6332.430081292706, 6333.65164915934, 6365.204349456318, 6373.840653983502, 6465.579737317059, 6469.547131700736, 6504.674766261763, 6520.543561950808, 6524.641144737085, 5722.942770572407, 5751.1373294006235, 5756.021476348947, 5759.39526349744, 5761.8559536011935, 5922.2597175353085, 6093.878122437615, 6100.0849872519475, 6100.572959892765, 6102.237220347457], "unit": "ms", "name": "mootools.html", "value": 3916.2430260052956}, {"lowerIsBetter": false, "replicates": [308.9613798275215, 317.785494791016, 321.29315505887024, 321.34445730709353, 325.29086591231106, 5398.838034858955, 5435.673859568424, 5453.7818487260565, 5489.066858634032, 5608.5793565482545, 5395.676259424427, 5418.0, 5425.3760817506, 5455.945440545594, 5486.341639003315, 4043.231785960673, 4157.958420415803, 4163.687723420756, 4197.097624010837, 4200.726952748077, 4168.291390463613, 4187.7277976931555, 4191.601797829201, 4194.30793919003, 4201.936970945439, 4151.418801367811, 4154.335306350985, 4157.127003329289, 4158.729682570638, 4161.375793630949, 4158.459400277975, 4161.167766446708, 4169.478815148106, 4170.47869016373, 4173.227952828736, 3518.4194607889667, 3643.234920666663, 3664.578573464059, 3667.21154951684, 3668.7615305005356, 5076.74616269185, 5176.922346164811, 5195.480451954812, 5209.635325527214, 5214.348206474191, 4726.621870250372, 4746.83386081489, 4774.045190961821, 4774.73738944358, 4776.546228108324, 5691.117876729114, 5698.458646428583, 5712.942870571283, 5714.628549144334, 5726.79956201531, 3800.467934489174, 3925.7644541327327, 3942.15243722601, 3948.2300951314505, 3963.742356746802, 5969.313528944183, 6025.0661147522205, 6030.0, 6039.184710064129, 6045.365236650133, 4076.735012224196, 4083.693722970789, 4094.058366575645, 4095.9385609215888, 4106.014556506477, 4154.127633197062, 4155.439015732898, 4159.147374788161, 4165.604267594635, 4170.374443833449, 4651.465081515669, 4714.88212794676, 4750.501197374295, 4759.762011899391, 4764.118638051971, 5451.700156491352, 5609.80365687199, 5639.605227634026, 5644.97177514118, 5655.632383895116, 1490.8136482939633, 1513.5610672904734, 1521.246982743549, 1522.7868098466001, 1525.4508376984277, 1041.3491567770143, 1058.2962330050584, 1070.4701172919454, 1076.4187338836941, 1076.56399158341, 5002.2496625506465, 5030.748462576857, 5038.420581633086, 5048.646594738407, 5051.520105589963, 5865.296164460292, 5905.645661260338, 5910.408959104141, 5917.289925208916, 5929.762809487658, 4997.175466048134, 5001.874953126128, 5007.69953802773, 5022.949770502321, 5024.120778863684, 3116.2053676312394, 3157.7631677623813, 3186.060112266887, 3188.2029492626843, 3192.074298453469, 5593.524550413179, 5606.887862242732, 5617.101263797773, 5622.746976386073, 5625.831225063254, 6023.247094113236, 6052.6671033092725, 6071.301800292935, 6075.665838378844, 6088.512918966472, 5440.700761458158, 5618.522425593788, 5618.831435056954, 5622.353429355677, 5623.0, 5891.440313170242, 5902.321233058254, 5906.940930590639, 5911.261092363455, 5919.289685237799, 5770.567207459541, 5772.509336706259, 5773.393793651606, 5778.537716982547, 5785.797497087582, 5597.552195824405, 5611.859703507445, 5612.887742245214, 5620.859478512906, 5621.775128994795, 4077.041895154577, 4157.7089603727445, 4168.062186008246, 4204.747715137101, 4225.5774422558725, 5821.854453638693, 5872.265966754156, 5878.823635290948, 5902.321233058254, 6003.039513677791, 5742.339630942328, 5761.942380576141, 5763.769449221984, 5764.971175144097, 5784.884302314014, 5746.281714785652, 5746.798862039808, 5751.8562035949435, 5754.741036653444, 5762.279715035621, 5422.701751403552, 5628.831135065954, 5637.154426836008, 5639.069553523786, 5640.0, 5788.507976822018, 5802.854928626649, 5807.76768929255, 5809.215755872903, 5812.534997200299, 5614.438556144516, 5644.153376993484, 5656.264685590847, 5656.5757568181725, 5660.518855897295], "unit": "ms", "name": "prototype.html", "value": 4301.148138032947}, {"lowerIsBetter": false, "replicates": [683.4668958212594, 684.8527566573185, 687.522172090397, 783.8393129408465, 785.3481610263482, 11214.66356009319, 11427.142964277671, 11435.142364322677, 11521.654350369492, 13890.652733681663, 13692.315384230798, 13759.449622015132, 13810.723785524284, 13835.79246311306, 13844.930775346134, 643.2441880790076, 648.8215740671305, 816.1838161838161, 816.2612835383987, 828.9709860154895, 810.1452967119686, 814.1044850664251, 814.7881550796776, 815.3192084609358, 822.6544851162496, 852.688768599463, 856.3834039491587, 857.952812595307, 859.9011113721939, 860.3934226370394, 845.5011543189547, 848.7199224256043, 850.0352100366067, 851.0723311590334, 852.518327145161, 628.7170773152054, 633.4172561243666, 635.3551145587187, 636.2396935661886, 637.0, 12388.81416778749, 12503.687407814787, 12542.05934554912, 12568.937155314165, 12612.68468288291, 10645.414502202375, 10733.62432314873, 11246.437678116143, 11288.492017859217, 11326.03728683063, 9425.434473931586, 9466.763330916714, 9515.666951656727, 9602.183814375787, 9610.423374597547, 3324.933501329984, 3356.590232102523, 3381.1547113221695, 3385.407553678121, 3471.2710330830555, 39047.60952390497, 39390.21219575592, 39640.008999774946, 39868.80065599683, 40103.7994810027, 9227.907720922705, 9457.66898158575, 9558.0, 9611.231101512001, 9720.27097967641, 15859.920700396424, 15928.442504512519, 15966.281517331749, 15997.440089596808, 16063.759043614355, 6227.252729672468, 6245.5628106033055, 6311.684415779193, 6396.0, 6409.198850143732, 3642.1258897864323, 3647.6899463545365, 3703.703703703697, 3712.1462063724953, 3726.347889119393, 2659.6143559184197, 2699.1497678231294, 2700.0, 2703.851288179169, 2704.0535812465873, 472.79433446450906, 485.5751217684526, 486.35800743018876, 489.31740222389567, 505.6435213174703, 503.1572116704505, 517.8006467510036, 527.857478480808, 533.0857579251602, 537.8332716857786, 7194.0, 7263.273672632695, 7300.853982920418, 7333.816654583678, 7338.926610733931, 436.7510519004137, 443.8291257865745, 456.6415363939292, 463.9512851150648, 509.20818127810867, 3342.398368293682, 3350.2294472271515, 3353.1449480382835, 3497.038314463543, 3509.192885636267, 47846.28230576544, 48094.27858582124, 48221.27668084981, 48359.03281934412, 48407.0, 43552.34671479931, 43829.12341753147, 44281.557184428384, 44435.333469997975, 45046.32430513545, 40164.397534037016, 41291.58708412937, 41410.79294603508, 41633.167336653096, 41755.0, 6925.099737034153, 6958.860822783618, 6959.582425054513, 7036.2260151384335, 7133.678984445609, 30632.387352252383, 30924.536131958488, 31527.21181970469, 32355.19112022218, 32364.676353236166, 36030.81984590165, 36443.817780910926, 36473.63526364809, 40378.39432408458, 40728.59271407248, 7846.293833555007, 8124.7562573122905, 8139.79650508742, 8272.214139656722, 8590.269827064769, 9644.228461723185, 9898.56470811714, 9983.60065597368, 10034.297599167989, 11389.202755807346, 10419.114375278186, 10492.47537623131, 10770.0, 10782.892171078189, 10989.61536346224, 10239.948800255952, 10359.32664376813, 10371.429571373646, 10600.787984240425, 11143.2199746017, 10016.148627366463, 10233.897661023295, 10355.482225888525, 10714.464276785973, 11037.834432483358, 8296.875546866922, 8820.603072861608, 8843.646254150019, 9233.030531794066, 9556.331056826233, 8202.466839655403, 8654.697085601974, 9129.634814607341, 9276.6289348428, 9396.67111651089], "unit": "ms", "name": "yui.html", "value": 5619.810934444547}], "name": "dromaeo_css", "value": 6348.628171475534}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 114.0, 115.0, 113.0, 125.0, 112.0, 113.0, 114.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 158.0, 164.0, 130.0, 162.0, 154.0, 132.0, 168.0, 140.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 164.0, 163.0, 163.0, 173.0, 163.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 79.0, 72.0, 72.0, 135.0, 79.0, 78.0, 83.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 142.0, 95.0, 94.0, 94.0, 132.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 113.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 75.0, 74.0, 74.0, 73.0, 73.0, 74.0, 74.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 85.0, 84.0, 91.0, 84.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [120.0, 136.0, 130.0, 126.0, 123.0, 137.0, 123.0, 135.0, 121.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [140.0, 153.0, 148.0, 148.0, 139.0, 149.0, 148.0, 146.0, 151.0, 159.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 73.0, 70.0, 71.0, 71.0, 74.0, 73.0, 72.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1542.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [191.49751053236307], "unit": "score", "name": "DeltaBlue", "value": 345.26819599999993}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [608.2224909310762], "unit": "score", "name": "Splay", "value": 133.98222067594438}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21196.294635417133}]} 05:14:22 INFO - RETURN: dromaeo_css: 6348.63 05:14:22 INFO - RETURN: kraken: 1542.60 05:14:22 INFO - RETURN: v8_7: 21196.29 05:14:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21196.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1542.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6348.63"}}} 05:14:22 INFO - Return code: 0 05:14:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:14:22 INFO - # TBPL SUCCESS # 05:14:22 INFO - Running post-action listener: _resource_record_post_action 05:14:22 INFO - Running post-run listener: _resource_record_post_run 05:14:23 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 515932160; Read time: 0; Write time: 617796 05:14:23 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 241954816; Read time: 0; Write time: 392624 05:14:23 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 273514496; Read time: 0; Write time: 225144 05:14:23 INFO - Running post-run listener: _upload_blobber_files 05:14:23 INFO - Blob upload gear active. 05:14:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:14:23 INFO - Copying logs to upload dir... 05:14:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.861691 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-10 05:14:23.118287) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:23.121857) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010156 build_url: 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:23.173542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:23.173970) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449751531.180377-2083400410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:23.224171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 05:14:23.224520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 05:14:23.224888) ========= ========= Total master_lag: 0.26 =========