builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1449663204.11 results: success (0) buildid: 20151209025641 builduid: a31111ab98084482b38f049fc212148d revision: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.107126) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.107612) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.108245) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.133469) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.133787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.170405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.170759) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.249926) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.250236) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.250666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.250986) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 04:13:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-12-09 04:13:27 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.373703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.374025) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020629 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.430286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.430665) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 --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 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 --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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 04:13:28,095 truncating revision to first 12 chars 2015-12-09 04:13:28,095 Setting DEBUG logging. 2015-12-09 04:13:28,095 attempt 1/10 2015-12-09 04:13:28,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40b58759c962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 04:13:28,371 unpacking tar archive at: mozilla-central-40b58759c962/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552004 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.000695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.001003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.012713) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.013262) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.013682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-09 04:13:25.014006) ========= /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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:28 INFO - MultiFileLogger online at 20151209 04:13:28 in /builds/slave/test 04:13:28 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:13:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:28 INFO - {'append_to_log': False, 04:13:28 INFO - 'base_work_dir': '/builds/slave/test', 04:13:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:28 INFO - 'branch': 'Firefox-Non-PGO', 04:13:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:28 INFO - 'config_files': ('talos/linux_config.py',), 04:13:28 INFO - 'default_actions': ('clobber', 04:13:28 INFO - 'read-buildbot-config', 04:13:28 INFO - 'download-and-extract', 04:13:28 INFO - 'populate-webroot', 04:13:28 INFO - 'create-virtualenv', 04:13:28 INFO - 'install', 04:13:28 INFO - 'run-tests'), 04:13:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:28 INFO - 'download_minidump_stackwalk': True, 04:13:28 INFO - 'download_symbols': 'ondemand', 04:13:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:28 INFO - 'installer_path': 'installer.exe', 04:13:28 INFO - 'log_level': 'info', 04:13:28 INFO - 'log_name': 'talos', 04:13:28 INFO - 'log_to_console': True, 04:13:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:28 INFO - 'opt_config_files': (), 04:13:28 INFO - 'pip_index': False, 04:13:28 INFO - 'sps_profile': False, 04:13:28 INFO - 'sps_profile_interval': 0, 04:13:28 INFO - 'suite': 'dromaeojs-e10s', 04:13:28 INFO - 'system_bits': '64', 04:13:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:28 INFO - 'title': 'talos-linux64-ix-048', 04:13:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:28 INFO - 'use_talos_json': True, 04:13:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:28 INFO - 'work_dir': 'build'} 04:13:28 INFO - ##### 04:13:28 INFO - ##### Running clobber step. 04:13:28 INFO - ##### 04:13:28 INFO - Running pre-action listener: _resource_record_pre_action 04:13:28 INFO - Running main action method: clobber 04:13:28 INFO - rmtree: /builds/slave/test/build 04:13:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:29 INFO - Running post-action listener: _resource_record_post_action 04:13:29 INFO - ##### 04:13:29 INFO - ##### Running read-buildbot-config step. 04:13:29 INFO - ##### 04:13:29 INFO - Running pre-action listener: _resource_record_pre_action 04:13:29 INFO - Running main action method: read_buildbot_config 04:13:29 INFO - Using buildbot properties: 04:13:29 INFO - { 04:13:29 INFO - "properties": { 04:13:29 INFO - "buildnumber": 141, 04:13:29 INFO - "product": "firefox", 04:13:29 INFO - "script_repo_revision": "production", 04:13:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:13:29 INFO - "repository": "", 04:13:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:13:29 INFO - "buildid": "20151209025641", 04:13:29 INFO - "slavename": "talos-linux64-ix-048", 04:13:29 INFO - "pgo_build": "False", 04:13:29 INFO - "basedir": "/builds/slave/test", 04:13:29 INFO - "project": "", 04:13:29 INFO - "platform": "ubuntu64_hw", 04:13:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:13:29 INFO - "slavebuilddir": "test", 04:13:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:29 INFO - "branch": "mozilla-central", 04:13:29 INFO - "repo_path": "mozilla-central", 04:13:29 INFO - "stage_platform": "linux64", 04:13:29 INFO - "builduid": "a31111ab98084482b38f049fc212148d", 04:13:29 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:29 INFO - }, 04:13:29 INFO - "sourcestamp": { 04:13:29 INFO - "repository": "", 04:13:29 INFO - "hasPatch": false, 04:13:29 INFO - "project": "", 04:13:29 INFO - "branch": "mozilla-central-linux64-talos", 04:13:29 INFO - "changes": [ 04:13:29 INFO - { 04:13:29 INFO - "category": null, 04:13:29 INFO - "files": [ 04:13:29 INFO - { 04:13:29 INFO - "url": null, 04:13:29 INFO - "name": "https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:13:29 INFO - } 04:13:29 INFO - ], 04:13:29 INFO - "repository": "", 04:13:29 INFO - "rev": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50", 04:13:29 INFO - "who": "cbook@mozilla.com", 04:13:29 INFO - "when": 1449663157, 04:13:29 INFO - "number": 7145613, 04:13:29 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:13:29 INFO - "project": "", 04:13:29 INFO - "at": "Wed 09 Dec 2015 04:12:37", 04:13:29 INFO - "branch": "mozilla-central-linux64-talos", 04:13:29 INFO - "revlink": "", 04:13:29 INFO - "properties": [ 04:13:29 INFO - [ 04:13:29 INFO - "buildid", 04:13:29 INFO - "20151209025641", 04:13:29 INFO - "Change" 04:13:29 INFO - ], 04:13:29 INFO - [ 04:13:29 INFO - "builduid", 04:13:29 INFO - "a31111ab98084482b38f049fc212148d", 04:13:29 INFO - "Change" 04:13:29 INFO - ], 04:13:29 INFO - [ 04:13:29 INFO - "pgo_build", 04:13:29 INFO - "False", 04:13:29 INFO - "Change" 04:13:29 INFO - ] 04:13:29 INFO - ], 04:13:29 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:29 INFO - } 04:13:29 INFO - ], 04:13:29 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:29 INFO - } 04:13:29 INFO - } 04:13:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:13:29 INFO - Running post-action listener: _resource_record_post_action 04:13:29 INFO - ##### 04:13:29 INFO - ##### Running download-and-extract step. 04:13:29 INFO - ##### 04:13:29 INFO - Running pre-action listener: _resource_record_pre_action 04:13:29 INFO - Running main action method: download_and_extract 04:13:29 INFO - mkdir: /builds/slave/test/build/tests 04:13:29 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:13:29 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json 04:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json 04:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:29 INFO - Downloaded 1302 bytes. 04:13:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:29 INFO - Using the following test package requirements: 04:13:29 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'jsshell-linux-x86_64.zip'], 04:13:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:29 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:29 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:13:29 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:30 INFO - Downloaded 21859522 bytes. 04:13:30 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:13:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:30 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:13:31 INFO - Return code: 0 04:13:31 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:13:31 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:13:31 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:33 INFO - Downloaded 21859522 bytes. 04:13:33 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:13:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:33 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:13:34 INFO - Return code: 0 04:13:34 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:13:34 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:36 INFO - Downloaded 11132038 bytes. 04:13:36 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:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:36 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:13:36 INFO - Return code: 0 04:13:36 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:13:36 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:39 INFO - Downloaded 57731950 bytes. 04:13:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:39 INFO - mkdir: /builds/slave/test/properties 04:13:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:39 INFO - Contents: 04:13:39 INFO - build_url:https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - Running post-action listener: set_extra_try_arguments 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running populate-webroot step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: populate_webroot 04:13:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:39 INFO - '--tppagecycles', 04:13:39 INFO - '7'], 04:13:39 INFO - 'tests': ['tsvgm']}}, 04:13:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['damp', 'tps']}, 04:13:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['damp', 'tps']}, 04:13:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:39 INFO - 'other': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other_l64': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:39 INFO - 'ts_paint', 04:13:39 INFO - 'tpaint', 04:13:39 INFO - 'sessionrestore', 04:13:39 INFO - 'sessionrestore_no_auto_restore']}, 04:13:39 INFO - 'svgr': {'tests': ['tsvgx', 04:13:39 INFO - 'tsvgr_opacity', 04:13:39 INFO - 'tart', 04:13:39 INFO - 'tscrollx', 04:13:39 INFO - 'cart']}, 04:13:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tsvgx', 04:13:39 INFO - 'tsvgr_opacity', 04:13:39 INFO - 'tart', 04:13:39 INFO - 'tscrollx', 04:13:39 INFO - 'cart']}, 04:13:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'tests': ['tp5o']}, 04:13:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s'], 04:13:39 INFO - 'tests': ['tp5o']}, 04:13:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--xperf_path', 04:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:39 INFO - 'tests': ['tp5n']}, 04:13:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:39 INFO - 'talos_options': ['--e10s', 04:13:39 INFO - '--xperf_path', 04:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:39 INFO - 'tests': ['tp5n']}}, 04:13:39 INFO - 'talos.zip': {'path': '', 04:13:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running create-virtualenv step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: create_virtualenv 04:13:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:39 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:13:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:39 INFO - Using real prefix '/usr' 04:13:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:41 INFO - Installing pip.................done. 04:13:41 INFO - Return code: 0 04:13:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:41 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:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 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:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:41 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:13:41 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:13:41 INFO - Using env: {'DISPLAY': ':0', 04:13:41 INFO - 'HOME': '/home/cltbld', 04:13:41 INFO - 'LANG': 'en_US.UTF-8', 04:13:41 INFO - 'LANGUAGE': 'en_US:en', 04:13:41 INFO - 'LOGNAME': 'cltbld', 04:13:41 INFO - 'MAIL': '/var/mail/cltbld', 04:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:41 INFO - 'MOZ_NO_REMOTE': '1', 04:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:41 INFO - 'NO_EM_RESTART': '1', 04:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:41 INFO - 'PWD': '/builds/slave/test', 04:13:41 INFO - 'SHELL': '/bin/bash', 04:13:41 INFO - 'SHLVL': '1', 04:13:41 INFO - 'TERM': 'linux', 04:13:41 INFO - 'TMOUT': '86400', 04:13:41 INFO - 'USER': 'cltbld', 04:13:41 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:41 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 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:13:42 INFO - Cleaning up... 04:13:42 INFO - Return code: 0 04:13:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13: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:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', '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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:13: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 psutil>=0.7.1 04:13:42 INFO - Using env: {'DISPLAY': ':0', 04:13:42 INFO - 'HOME': '/home/cltbld', 04:13:42 INFO - 'LANG': 'en_US.UTF-8', 04:13:42 INFO - 'LANGUAGE': 'en_US:en', 04:13:42 INFO - 'LOGNAME': 'cltbld', 04:13:42 INFO - 'MAIL': '/var/mail/cltbld', 04:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:42 INFO - 'MOZ_NO_REMOTE': '1', 04:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:42 INFO - 'NO_EM_RESTART': '1', 04:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:42 INFO - 'PWD': '/builds/slave/test', 04:13:42 INFO - 'SHELL': '/bin/bash', 04:13:42 INFO - 'SHLVL': '1', 04:13:42 INFO - 'TERM': 'linux', 04:13:42 INFO - 'TMOUT': '86400', 04:13:42 INFO - 'USER': 'cltbld', 04:13:42 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:42 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 INFO - Downloading/unpacking psutil>=0.7.1 04:13: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:13: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:13: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:13: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:13: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:13: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:13:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:44 INFO - Installing collected packages: psutil 04:13:44 INFO - Running setup.py install for psutil 04:13:44 INFO - building 'psutil._psutil_linux' extension 04:13:44 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:13:44 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:13:44 INFO - building 'psutil._psutil_posix' extension 04:13:44 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:13:44 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:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:44 INFO - Successfully installed psutil 04:13:44 INFO - Cleaning up... 04:13:44 INFO - Return code: 0 04:13:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:44 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:44 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:13:44 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:13:44 INFO - Using env: {'DISPLAY': ':0', 04:13:44 INFO - 'HOME': '/home/cltbld', 04:13:44 INFO - 'LANG': 'en_US.UTF-8', 04:13:44 INFO - 'LANGUAGE': 'en_US:en', 04:13:44 INFO - 'LOGNAME': 'cltbld', 04:13:44 INFO - 'MAIL': '/var/mail/cltbld', 04:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:44 INFO - 'MOZ_NO_REMOTE': '1', 04:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:44 INFO - 'NO_EM_RESTART': '1', 04:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:44 INFO - 'PWD': '/builds/slave/test', 04:13:44 INFO - 'SHELL': '/bin/bash', 04:13:44 INFO - 'SHLVL': '1', 04:13:44 INFO - 'TERM': 'linux', 04:13:44 INFO - 'TMOUT': '86400', 04:13:44 INFO - 'USER': 'cltbld', 04:13:44 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:44 INFO - '_': '/tools/buildbot/bin/python'} 04:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13: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:13: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:13: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:13: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:13: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:13: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:13:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:13:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:46 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:13:46 INFO - Installing collected packages: mozsystemmonitor 04:13:46 INFO - Running setup.py install for mozsystemmonitor 04:13:46 INFO - Successfully installed mozsystemmonitor 04:13:46 INFO - Cleaning up... 04:13:46 INFO - Return code: 0 04:13:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:46 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:13:46 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:13:46 INFO - Using env: {'DISPLAY': ':0', 04:13:46 INFO - 'HOME': '/home/cltbld', 04:13:46 INFO - 'LANG': 'en_US.UTF-8', 04:13:46 INFO - 'LANGUAGE': 'en_US:en', 04:13:46 INFO - 'LOGNAME': 'cltbld', 04:13:46 INFO - 'MAIL': '/var/mail/cltbld', 04:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:46 INFO - 'MOZ_NO_REMOTE': '1', 04:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:46 INFO - 'NO_EM_RESTART': '1', 04:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:46 INFO - 'PWD': '/builds/slave/test', 04:13:46 INFO - 'SHELL': '/bin/bash', 04:13:46 INFO - 'SHLVL': '1', 04:13:46 INFO - 'TERM': 'linux', 04:13:46 INFO - 'TMOUT': '86400', 04:13:46 INFO - 'USER': 'cltbld', 04:13:46 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:46 INFO - '_': '/tools/buildbot/bin/python'} 04:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:13: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:13: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:13: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:13: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:13: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:13: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:13:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:48 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:13:48 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:13:48 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:13:48 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:13:48 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:13:48 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:13:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:49 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:13:49 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:13:49 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:13:49 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:13:49 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:13:49 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:13:49 INFO - Downloading docopt-0.6.1.tar.gz 04:13:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:49 INFO - Running setup.py install for blobuploader 04:13:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:49 INFO - Running setup.py install for requests 04:13:49 INFO - Running setup.py install for docopt 04:13:49 INFO - Successfully installed blobuploader requests docopt 04:13:49 INFO - Cleaning up... 04:13:49 INFO - Return code: 0 04:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:49 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:13:49 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:13:49 INFO - Using env: {'DISPLAY': ':0', 04:13:49 INFO - 'HOME': '/home/cltbld', 04:13:49 INFO - 'LANG': 'en_US.UTF-8', 04:13:49 INFO - 'LANGUAGE': 'en_US:en', 04:13:49 INFO - 'LOGNAME': 'cltbld', 04:13:49 INFO - 'MAIL': '/var/mail/cltbld', 04:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:49 INFO - 'MOZ_NO_REMOTE': '1', 04:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:49 INFO - 'NO_EM_RESTART': '1', 04:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:49 INFO - 'PWD': '/builds/slave/test', 04:13:49 INFO - 'SHELL': '/bin/bash', 04:13:49 INFO - 'SHLVL': '1', 04:13:49 INFO - 'TERM': 'linux', 04:13:49 INFO - 'TMOUT': '86400', 04:13:49 INFO - 'USER': 'cltbld', 04:13:49 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:49 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 INFO - Running setup.py (path:/tmp/pip-DHryyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:50 INFO - Running setup.py (path:/tmp/pip-4tiLyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:50 INFO - Running setup.py (path:/tmp/pip-tDnb62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:50 INFO - Running setup.py (path:/tmp/pip-YgwF_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:50 INFO - Running setup.py (path:/tmp/pip-8YVsyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:50 INFO - Running setup.py (path:/tmp/pip-dgSlkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:50 INFO - Running setup.py (path:/tmp/pip-Xo6TOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:50 INFO - Running setup.py (path:/tmp/pip-HWY73x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:50 INFO - Running setup.py (path:/tmp/pip-ayq2p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:50 INFO - Running setup.py (path:/tmp/pip-rXESgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:50 INFO - Running setup.py (path:/tmp/pip-QB3okY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:50 INFO - Running setup.py (path:/tmp/pip-DqH4Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 INFO - Running setup.py (path:/tmp/pip-OBnhwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 INFO - Running setup.py (path:/tmp/pip-UI88_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 INFO - Running setup.py (path:/tmp/pip-355C5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:51 INFO - Running setup.py (path:/tmp/pip-osa3TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:51 INFO - Running setup.py (path:/tmp/pip-R5L3l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:51 INFO - Running setup.py install for manifestparser 04:13:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:51 INFO - Running setup.py install for mozcrash 04:13:51 INFO - Running setup.py install for mozdebug 04:13:51 INFO - Running setup.py install for mozdevice 04:13:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:51 INFO - Running setup.py install for mozfile 04:13:51 INFO - Running setup.py install for mozhttpd 04:13:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:51 INFO - Running setup.py install for mozinfo 04:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozInstall 04:13:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozleak 04:13:52 INFO - Running setup.py install for mozlog 04:13:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for moznetwork 04:13:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozprocess 04:13:52 INFO - Running setup.py install for mozprofile 04:13:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozrunner 04:13:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:52 INFO - Running setup.py install for mozscreenshot 04:13:52 INFO - Running setup.py install for moztest 04:13:53 INFO - Running setup.py install for mozversion 04:13:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:53 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:53 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:13:53 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:13:53 INFO - Using env: {'DISPLAY': ':0', 04:13:53 INFO - 'HOME': '/home/cltbld', 04:13:53 INFO - 'LANG': 'en_US.UTF-8', 04:13:53 INFO - 'LANGUAGE': 'en_US:en', 04:13:53 INFO - 'LOGNAME': 'cltbld', 04:13:53 INFO - 'MAIL': '/var/mail/cltbld', 04:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:53 INFO - 'MOZ_NO_REMOTE': '1', 04:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:53 INFO - 'NO_EM_RESTART': '1', 04:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:53 INFO - 'PWD': '/builds/slave/test', 04:13:53 INFO - 'SHELL': '/bin/bash', 04:13:53 INFO - 'SHLVL': '1', 04:13:53 INFO - 'TERM': 'linux', 04:13:53 INFO - 'TMOUT': '86400', 04:13:53 INFO - 'USER': 'cltbld', 04:13:53 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:53 INFO - '_': '/tools/buildbot/bin/python'} 04:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:53 INFO - Running setup.py (path:/tmp/pip-a7BVIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:53 INFO - Running setup.py (path:/tmp/pip-KCBXZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:53 INFO - Running setup.py (path:/tmp/pip-fibaS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:53 INFO - Running setup.py (path:/tmp/pip-XiQhNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:53 INFO - Running setup.py (path:/tmp/pip-34Dusw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:53 INFO - Running setup.py (path:/tmp/pip-5j9Mui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:53 INFO - Running setup.py (path:/tmp/pip-lOkwxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:53 INFO - Running setup.py (path:/tmp/pip-5ZHFnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:53 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:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:53 INFO - Running setup.py (path:/tmp/pip-smwIgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:54 INFO - Running setup.py (path:/tmp/pip-qsC6XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:54 INFO - Running setup.py (path:/tmp/pip-BUIVnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:54 INFO - Running setup.py (path:/tmp/pip-eNWR1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:54 INFO - Running setup.py (path:/tmp/pip-8_duwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:54 INFO - Running setup.py (path:/tmp/pip-vuVm9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:54 INFO - Running setup.py (path:/tmp/pip-VabkT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:54 INFO - Running setup.py (path:/tmp/pip-kJ7Y9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:54 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:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:54 INFO - Running setup.py (path:/tmp/pip-h6lygv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:54 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:13:54 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:13:54 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:13:54 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:13:54 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:13:54 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:13:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:56 INFO - Downloading blessings-1.5.1.tar.gz 04:13:56 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:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:56 INFO - Installing collected packages: blessings 04:13:56 INFO - Running setup.py install for blessings 04:13:56 INFO - Successfully installed blessings 04:13:56 INFO - Cleaning up... 04:13:56 INFO - Return code: 0 04:13:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:56 INFO - Reading from file tmpfile_stdout 04:13:56 INFO - Current package versions: 04:13:56 INFO - argparse == 1.2.1 04:13:56 INFO - blessings == 1.5.1 04:13:56 INFO - blobuploader == 1.2.4 04:13:56 INFO - docopt == 0.6.1 04:13:56 INFO - manifestparser == 1.1 04:13:56 INFO - mozInstall == 1.12 04:13:56 INFO - mozcrash == 0.16 04:13:56 INFO - mozdebug == 0.1 04:13:56 INFO - mozdevice == 0.47 04:13:56 INFO - mozfile == 1.2 04:13:56 INFO - mozhttpd == 0.7 04:13:56 INFO - mozinfo == 0.9 04:13:56 INFO - mozleak == 0.1 04:13:56 INFO - mozlog == 3.1 04:13:56 INFO - moznetwork == 0.27 04:13:56 INFO - mozprocess == 0.22 04:13:56 INFO - mozprofile == 0.27 04:13:56 INFO - mozrunner == 6.11 04:13:56 INFO - mozscreenshot == 0.1 04:13:56 INFO - mozsystemmonitor == 0.0 04:13:56 INFO - moztest == 0.7 04:13:56 INFO - mozversion == 1.4 04:13:56 INFO - psutil == 3.1.1 04:13:56 INFO - requests == 1.2.3 04:13:56 INFO - wsgiref == 0.1.2 04:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:56 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:13:56 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:13:56 INFO - Using env: {'DISPLAY': ':0', 04:13:56 INFO - 'HOME': '/home/cltbld', 04:13:56 INFO - 'LANG': 'en_US.UTF-8', 04:13:56 INFO - 'LANGUAGE': 'en_US:en', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MAIL': '/var/mail/cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SHLVL': '1', 04:13:56 INFO - 'TERM': 'linux', 04:13:56 INFO - 'TMOUT': '86400', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - '_': '/tools/buildbot/bin/python'} 04:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 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:13:56 INFO - Cleaning up... 04:13:56 INFO - Return code: 0 04:13:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:56 INFO - Using env: {'DISPLAY': ':0', 04:13:56 INFO - 'HOME': '/home/cltbld', 04:13:56 INFO - 'LANG': 'en_US.UTF-8', 04:13:56 INFO - 'LANGUAGE': 'en_US:en', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MAIL': '/var/mail/cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SHLVL': '1', 04:13:56 INFO - 'TERM': 'linux', 04:13:56 INFO - 'TMOUT': '86400', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Downloading/unpacking jsonschema 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:58 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:13:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:59 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:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:59 INFO - warning: no files found matching '*.txt' 04:13:59 INFO - no previously-included directories found matching 'build' 04:13:59 INFO - no previously-included directories found matching 'dist' 04:13:59 INFO - no previously-included directories found matching '.git*' 04:13:59 INFO - Installing collected packages: jsonschema, functools32 04:13:59 INFO - Running setup.py install for functools32 04:13:59 INFO - warning: no files found matching '*.txt' 04:13:59 INFO - no previously-included directories found matching 'build' 04:13:59 INFO - no previously-included directories found matching 'dist' 04:13:59 INFO - no previously-included directories found matching '.git*' 04:13:59 INFO - Successfully installed jsonschema functools32 04:13:59 INFO - Cleaning up... 04:13:59 INFO - Return code: 0 04:13:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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 0x7f655b561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ade240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', '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:13:59 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:13:59 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:13:59 INFO - Using env: {'DISPLAY': ':0', 04:13:59 INFO - 'HOME': '/home/cltbld', 04:13:59 INFO - 'LANG': 'en_US.UTF-8', 04:13:59 INFO - 'LANGUAGE': 'en_US:en', 04:13:59 INFO - 'LOGNAME': 'cltbld', 04:13:59 INFO - 'MAIL': '/var/mail/cltbld', 04:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:59 INFO - 'MOZ_NO_REMOTE': '1', 04:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:59 INFO - 'NO_EM_RESTART': '1', 04:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:59 INFO - 'PWD': '/builds/slave/test', 04:13:59 INFO - 'SHELL': '/bin/bash', 04:13:59 INFO - 'SHLVL': '1', 04:13:59 INFO - 'TERM': 'linux', 04:13:59 INFO - 'TMOUT': '86400', 04:13:59 INFO - 'USER': 'cltbld', 04:13:59 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:59 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Downloading/unpacking flake8 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:01 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:14:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:01 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:14:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 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:14:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:01 INFO - no previously-included directories found matching 'docs/_build' 04:14:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:01 INFO - Running setup.py install for pep8 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:02 INFO - no previously-included directories found matching 'docs/_build' 04:14:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Running post-action listener: _resource_record_post_action 04:14:02 INFO - Running post-action listener: _start_resource_monitoring 04:14:02 INFO - Starting resource monitoring. 04:14:02 INFO - ##### 04:14:02 INFO - ##### Running install step. 04:14:02 INFO - ##### 04:14:02 INFO - Running pre-action listener: _resource_record_pre_action 04:14:02 INFO - Running main action method: install 04:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:02 INFO - Reading from file tmpfile_stdout 04:14:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:02 INFO - Reading from file tmpfile_stdout 04:14:02 INFO - Output received: 04:14:02 INFO - Usage: mozinstall [options] installer 04:14:02 INFO - Options: 04:14:02 INFO - -h, --help show this help message and exit 04:14:02 INFO - -d DEST, --destination=DEST 04:14:02 INFO - Directory to install application into. [default: 04:14:02 INFO - "/builds/slave/test"] 04:14:02 INFO - --app=APP Application being installed. [default: firefox] 04:14:02 INFO - mkdir: /builds/slave/test/build/application 04:14:02 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:14:02 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:14:17 INFO - Reading from file tmpfile_stdout 04:14:17 INFO - Output received: 04:14:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:17 INFO - Running post-action listener: _resource_record_post_action 04:14:17 INFO - ##### 04:14:17 INFO - ##### Running run-tests step. 04:14:17 INFO - ##### 04:14:17 INFO - Running pre-action listener: _resource_record_pre_action 04:14:17 INFO - Running main action method: run_tests 04:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:17 INFO - Python 2.7.3 04:14:17 INFO - Return code: 0 04:14:17 INFO - grabbing minidump binary from tooltool 04:14:17 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:14:17 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 0x2b6d0b0>, '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 0x2b6dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:17 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:14:17 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:14:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:17 INFO - Return code: 0 04:14:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:18 INFO - Return code: 0 04:14:18 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/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:18 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/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 04:14:18 INFO - Using env: {'DISPLAY': ':0', 04:14:18 INFO - 'HOME': '/home/cltbld', 04:14:18 INFO - 'LANG': 'en_US.UTF-8', 04:14:18 INFO - 'LANGUAGE': 'en_US:en', 04:14:18 INFO - 'LOGNAME': 'cltbld', 04:14:18 INFO - 'MAIL': '/var/mail/cltbld', 04:14:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:18 INFO - 'MOZ_NO_REMOTE': '1', 04:14:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:18 INFO - 'NO_EM_RESTART': '1', 04:14:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:18 INFO - 'PWD': '/builds/slave/test', 04:14:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:18 INFO - 'SHELL': '/bin/bash', 04:14:18 INFO - 'SHLVL': '1', 04:14:18 INFO - 'TERM': 'linux', 04:14:18 INFO - 'TMOUT': '86400', 04:14:18 INFO - 'USER': 'cltbld', 04:14:18 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118', 04:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:18 INFO - '_': '/tools/buildbot/bin/python'} 04:14:18 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/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 04:14:19 INFO - mozversion INFO | application_buildid: 20151209025641 04:14:19 INFO - mozversion INFO | application_changeset: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 04:14:19 INFO - mozversion INFO | application_display_name: Nightly 04:14:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:19 INFO - mozversion INFO | application_name: Firefox 04:14:19 INFO - mozversion INFO | application_remotingname: firefox 04:14:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:14:19 INFO - mozversion INFO | application_vendor: Mozilla 04:14:19 INFO - mozversion INFO | application_version: 45.0a1 04:14:19 INFO - mozversion INFO | platform_buildid: 20151209025641 04:14:19 INFO - mozversion INFO | platform_changeset: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 04:14:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:14:19 INFO - mozversion INFO | platform_version: 45.0a1 04:14:19 INFO - 2015-12-09 04:14:19,049 DEBUG : using testdate: 1449663259 04:14:19 INFO - 2015-12-09 04:14:19,050 DEBUG : actual date: 1449663259 04:14:19 INFO - 2015-12-09 04:14:19,065 INFO : starting webserver on 'localhost:49019' 04:14:19 INFO - 2015-12-09 04:14:19,066 INFO : Starting test suite talos-linux64-ix-048.e 04:14:19 INFO - 2015-12-09 04:14:19,066 INFO : Starting test dromaeo_css 04:14:19 INFO - 2015-12-09 04:14:19,066 DEBUG : operating with platform_type : linux_ 04:14:19 INFO - 2015-12-09 04:14:19,067 INFO : Initialising browser for dromaeo_css test... 04:14:19 INFO - 2015-12-09 04:14:19,077 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSH8_QO/profile http://localhost:49019/getInfo.html 04:14:23 INFO - 2015-12-09 04:14:23,881 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:23 INFO - 2015-12-09 04:14:23,881 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:23 INFO - 2015-12-09 04:14:23,881 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:23 INFO - 2015-12-09 04:14:23,881 DEBUG : BROWSER_OUTPUT: __metrics 04:14:24 INFO - 2015-12-09 04:14:24,006 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:14:24 INFO - 2015-12-09 04:14:24,929 INFO : Browser initialized. 04:14:24 INFO - 2015-12-09 04:14:24,929 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:24 INFO - 2015-12-09 04:14:24,929 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSH8_QO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:37 INFO - 2015-12-09 04:14:37,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 143618048 04:14:37 INFO - 2015-12-09 04:14:37,054 DEBUG : BROWSER_OUTPUT: 04:15:26 INFO - 2015-12-09 04:15:26,674 DEBUG : BROWSER_OUTPUT: 1449663326665 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:17:38 INFO - 2015-12-09 04:17:38,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49019/tests/dromaeo/cssquery-ext.html) 04:17:39 INFO - 2015-12-09 04:17:39,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 146198528 04:17:39 INFO - 2015-12-09 04:17:39,613 DEBUG : BROWSER_OUTPUT: 04:20:41 INFO - 2015-12-09 04:20:41,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-ext.html (next: http://localhost:49019/tests/dromaeo/cssquery-jquery.html) 04:20:42 INFO - 2015-12-09 04:20:42,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 144392192 04:20:42 INFO - 2015-12-09 04:20:42,153 DEBUG : BROWSER_OUTPUT: 04:23:43 INFO - 2015-12-09 04:23:43,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49019/tests/dromaeo/cssquery-mootools.html) 04:23:44 INFO - 2015-12-09 04:23:44,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 146079744 04:23:44 INFO - 2015-12-09 04:23:44,575 DEBUG : BROWSER_OUTPUT: 04:26:46 INFO - 2015-12-09 04:26:46,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49019/tests/dromaeo/cssquery-prototype.html) 04:26:47 INFO - 2015-12-09 04:26:47,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 144560128 04:26:47 INFO - 2015-12-09 04:26:47,003 DEBUG : BROWSER_OUTPUT: 04:29:49 INFO - 2015-12-09 04:29:49,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49019/tests/dromaeo/cssquery-yui.html) 04:29:50 INFO - 2015-12-09 04:29:50,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 143761408 04:29:50 INFO - 2015-12-09 04:29:50,230 DEBUG : BROWSER_OUTPUT: 04:32:52 INFO - 2015-12-09 04:32:52,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/dromaeo/cssquery-yui.html (next: http://localhost:49019/tests/dromaeo/cssquery-dojo.html) 04:32:53 INFO - 2015-12-09 04:32:53,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 147542016 04:32:53 INFO - 2015-12-09 04:32:53,016 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,016 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:32:53 INFO - 2015-12-09 04:32:53,016 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:32:53 INFO - 2015-12-09 04:32:53,016 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:32:53 INFO - 2015-12-09 04:32:53,017 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:32:53 INFO - 2015-12-09 04:32:53,017 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2677.8125531212813;2701.797365197611;2735.835849849008;2755.462684776468;2763.5163846326896;4483.991102002048;4798.184308667526;4803.183458812002;4831.396075490564;4839.15314819906;4681.648876334271;4725.3384526166365;4802.879928001793;4828.88935544824;4846.321514987896;4254.298040823268;4322.632576231024;4370.868873933787;4394.07724377881;4417.42573465449;525.082830731666;4286.03564198056;4319.48166220054;4339.934900976488;4432.3794668746405;4361.389405483234;4446.555344465528;4457.442819647544;4467.82128714851;4495.730256184639;4447.444069491314;4447.7776111194635;4465.307877279027;4465.37484752135;4501.977490112561;4146.979265103685;4224.9155016899485;4237.957620423787;4318.481782186158;4472.798724057425;4655.4180727409075;4667.346571479996;4673.299005149221;4687.156311863863;4710.764461776932;5090.10923088458;5139.691618502902;5141.845744627667;5148.176291793295;5210.114280572312;4937.654364194508;5072.2391641253735;5080.923786143211;5140.383154021504;5172.6379153459275;4743.407074115701;4757.785899634525;4758.976205118952;4764.857054288377;4812.663113582015;4834.661573689808;5187.896242075138;5204.635675502755;5247.475252474798;5264.42091369949;4861.246506791453;4912.263160525949;4986.0775756484445;5025.422076461254;5070.518300761421;5091.261767043758;5155.200943853709;5182.274481572583;5184.637075404761;5273.973630131824;4760.571548560646;4862.343583616237;5079.568236699922;5120.513551212629;5127.717975511308;4933.481984391659;4983.451820299764;4984.352034235526;4996.600271978233;5048.268001139814;4233.04756429807;4268.679849011337;4271.551487093872;4271.850485233064;4316.093620339701;3570.8036058016537;3654.872079477259;3670.834812433447;3761.6238376162164;3829.2341531693774;4368.825246990148;4389.890252743707;4399.890002749957;4402.933955990663;4436.334549817553;5110.591152707774;5134.921666450087;5160.767765450564;5162.819301324435;5203.60972927032;4182.121754431542;4226.429432026698;4274.679399045084;4357.629601483909;4377.233984052778;4509.6843220974215;4519.05099929012;4548.317752337176;4565.3836732040745;4594.150082234797;4846.781894814671;4856.95143048572;4866.124097662384;4867.342908707279;4897.975510122426;4880.707157570557;4978.377702787152;4982.202847544376;4983.501649834988;4986.102501549756;4678;4702.882427939329;4728.527147285382;4754.096721622881;4798.208295631322;5011.824586139468;5100.79596816138;5114.33513643224;5119.308893299357;5149.304843846033;4861.465238823655;4988.401391833003;5173.22401639757;5188.636795424284;5192.5586325162785;4888.6577939543895;4962.652614316963;4964.578010869117;4980.726060066731;5014.17266151081;4898.363212782316;4956.72737999399;4958.801647934042;4962.354893863775;4999.875003124951;4660.6970546914345;4721.952780472288;4744.051189761993;4874;4905.950940490692;4982.053409852117;4984.576311013604;5010.473900240568;5031;5033.874153146201;4896.853094407174;4900.534449227318;4902.852914412573;4906.116898958222;4915.754212289443 04:32:53 INFO - 2015-12-09 04:32:53,017 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.2493796216315;537.7069497124069;544.113095654084;551.8179000929694;560.3555910702694;26412.471750565;34686.47970280448;35097;35143.12142196446;35145.82427087864;39882;40127.59872401275;40485.39271910924;40509.59490405095;40572;7748.612569371523;7865.842683146334;7872.527648341089;7876.488028278172;7907.2488113629115;7874.606269686521;7944.404169687267;7977.56123413212;7983.281504664579;7988.281054705076;7838.372930165573;7872.803179920519;7873.409494287923;7916.0500739911;7930.881036784453;7540.321371076602;7574.7727568172495;7586.468947173727;7587;7592.278733520362;7832.960835195788;7912.762617121438;7918.841623167562;7919.089304729972;7954.801129971739;35934.28131437357;36649.267014659825;36672;36718.082047948745;36739.816300918326;2776.3649962602844;2798.6221860048836;3068.3709839483076;3313.2545177335146;3561.786292822439;27829;28289.858550707322;28456.28859278514;28456.430871382458;28541.57187642187;3232.4666430039015;3359.9496007559906;3426.3832510148163;3435.793852368866;3464.4456886897974;211265;211353;211634;212046.99999999846;212306;45487;46650;53397;54862.45137548573;54956;46664.7666761664;47228.29157562639;47525.76237118792;47548.28677569839;47878;12571.497140114476;12886.29125398112;12899.290539020256;12913.806292905614;12940.805887911689;9534.18959388446;9684;9690.321677482649;9695.078967498077;9705.932347441776;18011.459656210336;18170.727439088423;18174.36389726353;18207.362742303954;18279.360222392417;7345.338919497271;7575.0909890813455;7586.810329741801;7713.1515533291295;7736.574488403192;814.645629151321;823.9505629662119;884.6019291318933;895.3553441522224;924.6624981881699;20368.185272589228;20452;20455.28406505795;20970;22126.225582104547;863.2575984653193;939.1078475448352;981.6711401680517;992.7021893431942;1087.717193529688;11727.472263748152;11782.646520604396;12039.157258991961;12079.879201208052;12115;253137;255776;257921;259004;259223;44547;44670;44923;45028.77485612551;45083;1157.1841851494676;1180.7579446213506;1182.3851597169596;1183.5325046606542;1190.149043433949;21858.89070554637;23133.88433057824;23354.416139596648;23397.181098661466;23431.531369372857;37084;37229.62770372262;37527;37647.43528847124;37668.62331376651;240177;240625;241147;242172;243635;27893.16320510388;30690.386192275582;31313;31362.68637313689;31455;35837.462438062925;35988.10029749277;36616.08459788527;36921.44617830681;37057.81471092627;31361.68638313679;31377.372452550364;31734.206644834063;32351.19122021874;32606.83696581502;31299.68700312968;31986.360272793947;32001.839990799897;32015.519767203976;33864.83067584646;31841.840790795897;31984.840075800403;32097.518537222426;32165;34341.141471463416;34781.30437391187;34891.65108348986;35593.28813423665;35620.643793561736;36099.27801444009;28603;28977.420451590428;29113.563296550994;29211.561826572193;29532.557011645273 04:32:53 INFO - 2015-12-09 04:32:53,017 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.9958300625491;282.0972886762361;284.3332385555871;285.23699104894416;292.26786898818455;12509.562165324216;12975.545855895045;15073.170975596338;15627.453039143633;15669.921650391761;9032.50321232332;9548.379355341898;9575.473348965805;11669.649910502678;13117.47530098795;4437.511873693891;4494.393256910308;4518.97740511297;4536.614387777043;4539.704919180259;4455.086707225011;4525.547445255481;4733.502982186872;4735.242361222206;4735.810567577293;4660.021395506948;4675.766211689419;4680.227762419197;4690.507496712848;4786.449558300805;5096.286519887219;5128.05131050755;5140.280360749498;5145.845624631267;5151.871203219949;4890.462049174588;4952.405711314629;4965.925511117336;4973.776180071905;5023.6232282578585;10127.240456965757;10579.73550661232;10582.523786429629;10609.734756631146;11573.826392604118;1751.20320254284;1789.8926064436175;1811.212122726605;1828.506303298102;1866.7199920011972;8195.713150039779;8497.362697797627;9738.707838764849;11927.463264153133;12567.748645027048;1695.4320302698611;1705.6759215749091;1755.1662960093854;1757.2707326459504;1758.832910873465;47330.290045649344;49510.50489495095;50527.494725052646;50926;51147.97704045935;9455.669051583161;9520;9551.713448596553;9562;9614.71155865311;12270.263784172977;12270.754584908253;12390.132690711744;12392.75214495723;12395.194312369667;6892.104026476526;6928.44572434204;6940.305969403019;6940.6529673516125;6946.861062778716;6362.968185159045;6427.775027874002;6486.6756662167645;6515.087887695727;6519.576227545194;4022.2960981828064;4043.8989025274013;4083.9795801020805;4095.795210239476;4162.958370416257;1594.6412057287018;1643.1537758054612;1644.602088224999;1662.609286817597;1670.2316934210398;319.39634091566955;321.41983719386263;339.69257821671425;826.7437094500724;861.6036623153294;8715.172058654418;8787.121287871161;8804.647814087493;8839.69061082859;8957.372983891066;348.127939511522;762.325342072259;767.1024900866;793.3771988988732;912.4570880326195;7765;8012.879806802903;8160.795980100545;9076.500792456478;9278.304127190488;487780;489830;508204;512723;513634;64951.67524162349;73166;74593;75231.62384188044;75594.24405755872;1009.28340877976;1021.7701017271203;1034.04350975349;1039.896010398954;1053.72603123187;13889.861101388857;14647.26763661834;14833.480828170963;14853.554393368217;15156.166410847509;34159.31681366309;34292.31415371629;34865.30269394648;35019.47470787889;35132.47301290432;44173.33739993967;45530.317045245014;46207.306890396;46470.30294545652;49349.01301974012;8234.876476852733;8276.213759692819;8391.538465384463;8405.285550728257;8928.73213803587;12174.33041182708;14692.118472891661;14710.926445367704;14978.176200309088;15501.224938752792;12348.506059757508;12357.25856448616;12444.937775311066;12485.87514124847;12979.935100324816;12619.49522019109;12706.618801435972;12774.552890648783;12991.870081299066;13286.800697989345;12939.935300323437;12940.288284144463;13262.469501219843;13333.266670332836;13583.117097388638;7993.858547187578;8116.147804480681;8136.877946830684;8281.95859020701;8310.667573297;8310.958445207736;9295.442273463614;12909.741805164032;13013.479460821462;13563.525276615272 04:32:53 INFO - 2015-12-09 04:32:53,018 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1457.672023794647;1634.3217564710646;1683.150009245331;1685.6207353345499;1713.3660545598132;6670.76652317169;6884.483663725222;7118.323759242877;7163.462740294479;7171.748988785387;7179.425645948325;7248.891266631004;7307.926920730791;7315.378192853614;7350;1991.4822146242009;1997.1512107354388;2004.1382205651564;2016.2439085342996;2021.5956808638257;2003.258794246131;2013.6174126915912;2025.230412443277;2050.384884534641;2052.363767232155;1665.53365057784;1697.507722760398;1965.0076711260792;2007.4479518132484;2036.1448191759423;1927.296536764078;1934.9613007739836;1943.1935746665117;1944.2417457191707;1950.2978927586057;1970.4679736471217;1982.8512861535442;2001.129508663736;2011.6680747676762;2022.4135000849735;7043.401310888581;7079.716811327541;7125.7149714011375;7181.317774811385;7185.353318201334;4069.9389509157386;4144.668426525871;4149.3775933609895;4156.542780294165;4187.979060104711;2663.227663977444;2679.3435608276095;2710.0785732850727;2732.9590056149173;2742.5337692592107;834.1741675741033;836.1137194573711;851.3444647621297;892.7500299916034;902.2691619787993;9093.40892841963;9118.908810911938;9229.53852307382;9235.353525253235;9258.583363748647;3492.196794737174;3528.276703275874;3528.9117772055906;3531.7527773056154;3584.2473080653353;7517.962410187914;7546.698132074655;7562.130355009134;7573.583452910033;7596.962015189889;3854.807259637007;3862.6716729078344;3898.4542164097047;3915.197384536163;3915.569287378386;3623.5651721793024;3629;3636.872709455209;3644.4351125575577;3656;2934.8385838778645;2966.495695731731;2982.403519296106;2986.8954586589366;2988.716071973159;822.4037572759702;834.1783343406739;834.7996480844554;841.1714461255658;846.272205902923;796.1043825696092;797.3262593108814;807.4347956430522;958.4488918871676;984.4585477987222;6430.3891130342545;6499.805005849832;6566.901496477557;6574.046763219402;6578.506612004119;936.6206686292063;966.463612694947;969.6266937229218;976.2385339435252;977.5210147028047;5143.331366922276;5158.767855446514;5219.530242278213;5222.190560463135;5228.816991405282;8218.83562328762;8401;8475.02537208229;8486.32109431244;8490.108538603481;8309.252167304972;8339.45793523419;8357.832843343222;8372.079071302152;8373.8325233495;6346.650934198663;6559.4752419807255;6580.309067547934;6634.535582509178;6637.303083176197;6673.299303573249;6727;6727.495437842083;6729.327067293231;6748.561343512656;7446.106467223968;7658.4639075264195;7659.463837531543;7660.655270512952;7741.264579864904;7116.679749411185;7256.492045556761;7309.671064801991;7312.41500679955;7840.686372545262;6217.595856269509;6227.159333489921;6304.401081897213;6311.715972781144;6321.49428045746;6640.103586016019;6692.933070669231;6696.196456425066;6713.462922966053;6717.899231511434;6012.428819262163;6256.562040657111;6269.529785266214;6320.020396838498;6378.74485020594;5924.585279030426;5965.284165899946;6089.48239399656;6238.469730072995;6313.273973493107;6024.216851809237;6080.331163571915;6092.177556030057;6096.329403765493;6097.024476083982;5626.2967129108865;5704.515116215002;5727.11229759388;5733.512651424676;5737;5777.537796976148;5814.883702326015;5838.474537291664;5840.94159058421;5850.853728656818 04:32:53 INFO - 2015-12-09 04:32:53,018 DEBUG : BROWSER_OUTPUT: |4;prototype.html;249.7527447826651;250.2579850742548;257.26935503170995;263.66909528541674;263.90235612823255;5500.724963751812;5529.447055294469;5546.584006199531;5608.10270356743;5704.172894930232;5530.115181570949;5562.9443705562935;5574.86062848429;5608.383077861432;5608.523275521576;3894.8247328870198;4013.678905687538;4034.798260086984;4145.3574695922025;4150.792460376969;4145.709800313979;4147.4815648044;4149.9792501037455;4150.709450338478;4153.792310384469;4087.264292427362;4110.527289361717;4112.773797441139;4121.402396652484;4130.8554200602985;4092.0997380576373;4108.219438306712;4109.506859176918;4111.280525907954;4115.588441155861;3379.729621630264;3396.7792093513845;3459.0487615905577;3497.5278337424375;3499.5275637788827;5269.130593452076;5276.076686579871;5301.098813201726;5316.362036555638;5322.441143679896;4702.247640377557;4709.481956984729;4716.103940251375;4720.622350212009;4721.669483136182;5796.594238403313;5807.88384232313;5811.041178205591;5823.505002074829;5826.621269617462;3660.2862441823854;3756.9436458453147;3766.0584853786554;3804.809759512041;3812.7902965336893;5982.611130276518;6084.4828189603495;6136.325004249529;6155.199824022849;6163.815085547396;3866.6326698963553;3871.690264778811;3873.7482063666334;3874.5737968823405;3896.59085795993;3906.3554513504955;3931.4102884566973;3936.8622098226424;3940.2907476653904;3943.9802800985813;4579.107074120515;4611.631069514431;4667.299905014207;4671.252599584051;4675.228587283128;5816.069428891357;5819.447152520504;5839.416058394127;5852.151438041546;5865.970670146622;1361.0540674231315;1381.4543255414055;1384.1279993603964;1385.49429458247;1390.5480718766441;888.0630934364308;888.1340692824444;898.0929261445856;900.1088921967336;908.8863892013499;5032.345795046621;5088.185890257541;5094.490550944876;5100.872478188001;5103.132467480537;6084.726187321581;6096.847578810476;6097.847553811191;6105;6121.663308518075;5047.545720885065;5091.847244582668;5094.821681241213;5098.490150984946;5104.336436263262;3200.967990320067;3280.721138703237;3280.819554924454;3294.670532946734;3301.0756988043386;5542.140968149944;5664.6034777566;5675.035244008528;5694.829155125353;5696.743646535916;6288.717007734572;6304.401081897213;6304.779332723333;6318.936810631835;6321.65230912295;5671.206031155559;5696.829095127153;5702.287214098154;5704.3154821421695;5729.341125770589;5928.614640048383;6086.391360863879;6096.786612468542;6101.145839582373;6116.755329786759;5989;5992.730327135377;5996.940030599638;6004.099385092271;6020.187274717857;5695.544356451391;5698.515626171822;5699.059655157019;5707.400722924033;5736.110902810071;3834.961650383572;3917.6278253565865;3924.6467817895386;3934.173823496983;3938.1729836734607;5983.850403739767;6072.787452439144;6107.053406721965;6111.84720381994;6114.6636934969;5870.765169393348;5876.911846322223;5877.353491115889;5898.3216930053595;5901.7639294427745;5870.647761134345;5893;5899.144624029406;5902.734376952962;5915.08316210988;5600.467955544217;5771.971140144273;5779.595428319977;5800.245968024298;5804.709764511842;5965.105234214902;5970.671613061323;5972.8805423892145;5977.103434484862;5982.0727787193055;5809.2738407699035;5823.475887170175;5824.242848429677;5825.737841797045;5827.009408400498 04:32:53 INFO - 2015-12-09 04:32:53,019 DEBUG : BROWSER_OUTPUT: |5;yui.html;650.7136859781696;734.2363941500839;772.74499415193;779.4154384211841;780.418588151827;10896.673099807009;11592.130590205727;11627.825582616246;11629.24409913356;11638.592649257289;11075.16936229782;11118.110551155909;11159.218854680175;11187.105031597473;11236.831447528293;617.8424501752047;619.4548797058582;782.6791015683557;797.5294576200041;797.7407342613644;774.8489044636298;788.113372455987;790.4032455496092;790.746960972489;791.8139237279235;835.6657337065162;837.6733074101105;841.4446465332882;842.877782721505;843.5613480989881;830.5515021888173;830.7673851321609;831.7587899509135;833.9082700902895;835.1272919798824;616.3866952382364;620.1194304088206;621.3320680268729;622.7851391270004;622.9657368844712;11566;11661.358625275607;11682.065434765198;11693.181477296592;11699;10912.563497460093;11072.815799551385;11227.326360418401;11571.305721656643;11597.6520704379;9135.132162444623;9169.908300916972;9277.58250878712;9298.72103836886;9376;3189.027346659268;3224.3712476067176;3227.774055816094;3235.6440791512914;3256.4301247281633;38218.426723599165;38548.03629909247;38610.42084368737;38613.227735445136;38780.80609596962;8433.241008309282;8700;8850.026497085315;9017.368784185044;9192.402493837879;16973.15134243283;17061.7440738389;17077.57306067358;17087.743683844754;17132.914335428242;6313.40022697843;6412.422881940648;6461.353864613595;6461.967690161613;6631.734730610818;3341.9665803341654;3521.3133438979667;3537.4163263061823;3537.663921927413;3546.982265088658;2628.290361602357;2629.066681328139;2668.119520558211;2678.1296078774476;2680.370113023438;467.7287173439397;475.35589276530493;482.7151980331551;483.99516004840206;488.78249179115664;434.75653633965084;517.8705323669083;561.6910699115471;598.6587645042284;613.2487702564412;7149.428045756327;7304.342609165201;7367.705291788376;7453.627318634047;7818.179091195457;453.4694407543182;462.6761267113034;509.73493783233255;542.2923085373625;575.8877018981342;3527.3827080260853;3585.1344674947704;3735.327641024587;3845.442410850411;3874.1670540833293;46726.76636616863;46811.29783053257;47234.29148562774;54455.455445445834;55253;40973.59026409758;41221.38167927483;41498;41582.37626435606;42080.158396831896;38033.80983095122;38801.6119838798;39056.804715976235;39750.20499589992;39785.80107099388;7480.625968701652;7853.37173026168;8255.917440825755;8442.902422685012;8466.238038576557;29625;29648;31453;32422.83788581042;32504.67495325111;37061.44407833939;37220.62779372172;37241;37448.2510349786;37502;10594.152467802403;10755.623553175601;10979.615713449992;11047.944760276147;11054.557817687202;11118.666440006813;11299.548018079186;11427.914348136914;11479.655610331703;11617.47721352558;10030.247731420319;10156.847647285149;10254.128399086161;10602.46987650599;10776.191785616267;10273.9486302568;10497.737556561147;10551.841722374016;10808.459577021275;10831;10874.67375978722;10929.945350273198;10967.890321096687;10993.065589424668;11405.372704501333;9063.864042039242;9176.174144327042;9192.770180745534;9364.812703746024;9717.368371055858;9088.318376121684;9622.855657165288;9645.131938125602;9677.9032209677;9737 04:32:53 INFO - 2015-12-09 04:32:53,020 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:32:53 INFO - 2015-12-09 04:32:53,020 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:32:53 INFO - 2015-12-09 04:32:53,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 04:32:53 INFO - 2015-12-09 04:32:53,020 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:32:53 INFO - 2015-12-09 04:32:53,020 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664373010__endTimestamp 04:32:53 INFO - 2015-12-09 04:32:53,021 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,021 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:32:53 INFO - 2015-12-09 04:32:53,021 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:32:53 INFO - 2015-12-09 04:32:53,021 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,021 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4667.75 Median:4839.15 stddev:589.92 (12.2%) stddev-sans-first:570.70 04:32:53 INFO - 2015-12-09 04:32:53,022 DEBUG : BROWSER_OUTPUT: Values: 2677.8 2701.8 2735.8 2755.5 2763.5 4484.0 4798.2 4803.2 4831.4 4839.2 4681.6 4725.3 4802.9 4828.9 4846.3 4254.3 4322.6 4370.9 4394.1 4417.4 525.1 4286.0 4319.5 4339.9 4432.4 4361.4 4446.6 4457.4 4467.8 4495.7 4447.4 4447.8 4465.3 4465.4 4502.0 4147.0 4224.9 4238.0 4318.5 4472.8 4655.4 4667.3 4673.3 4687.2 4710.8 5090.1 5139.7 5141.8 5148.2 5210.1 4937.7 5072.2 5080.9 5140.4 5172.6 4743.4 4757.8 4759.0 4764.9 4812.7 4834.7 5187.9 5204.6 5247.5 5264.4 4861.2 4912.3 4986.1 5025.4 5070.5 5091.3 5155.2 5182.3 5184.6 5274.0 4760.6 4862.3 5079.6 5120.5 5127.7 4933.5 4983.5 4984.4 4996.6 5048.3 4233.0 4268.7 4271.6 4271.9 4316.1 3570.8 3654.9 3670.8 3761.6 3829.2 4368.8 4389.9 4399.9 4402.9 4436.3 5110.6 5134.9 5160.8 5162.8 5203.6 4182.1 4226.4 4274.7 4357.6 4377.2 4509.7 4519.1 4548.3 4565.4 4594.2 4846.8 4857.0 4866.1 4867.3 4898.0 4880.7 4978.4 4982.2 4983.5 4986.1 4678.0 4702.9 4728.5 4754.1 4798.2 5011.8 5100.8 5114.3 5119.3 5149.3 4861.5 4988.4 5173.2 5188.6 5192.6 4888.7 4962.7 4964.6 4980.7 5014.2 4898.4 4956.7 4958.8 4962.4 4999.9 4660.7 4722.0 4744.1 4874.0 4906.0 4982.1 4984.6 5010.5 5031.0 5033.9 4896.9 4900.5 4902.9 4906.1 4915.8 04:32:53 INFO - 2015-12-09 04:32:53,022 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,022 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39192.98 Median:35144.47 stddev:61786.05 (175.8%) stddev-sans-first:61891.19 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: Values: 534.2 537.7 544.1 551.8 560.4 26412.5 34686.5 35097.0 35143.1 35145.8 39882.0 40127.6 40485.4 40509.6 40572.0 7748.6 7865.8 7872.5 7876.5 7907.2 7874.6 7944.4 7977.6 7983.3 7988.3 7838.4 7872.8 7873.4 7916.1 7930.9 7540.3 7574.8 7586.5 7587.0 7592.3 7833.0 7912.8 7918.8 7919.1 7954.8 35934.3 36649.3 36672.0 36718.1 36739.8 2776.4 2798.6 3068.4 3313.3 3561.8 27829.0 28289.9 28456.3 28456.4 28541.6 3232.5 3359.9 3426.4 3435.8 3464.4 211265.0 211353.0 211634.0 212047.0 212306.0 45487.0 46650.0 53397.0 54862.5 54956.0 46664.8 47228.3 47525.8 47548.3 47878.0 12571.5 12886.3 12899.3 12913.8 12940.8 9534.2 9684.0 9690.3 9695.1 9705.9 18011.5 18170.7 18174.4 18207.4 18279.4 7345.3 7575.1 7586.8 7713.2 7736.6 814.6 824.0 884.6 895.4 924.7 20368.2 20452.0 20455.3 20970.0 22126.2 863.3 939.1 981.7 992.7 1087.7 11727.5 11782.6 12039.2 12079.9 12115.0 253137.0 255776.0 257921.0 259004.0 259223.0 44547.0 44670.0 44923.0 45028.8 45083.0 1157.2 1180.8 1182.4 1183.5 1190.1 21858.9 23133.9 23354.4 23397.2 23431.5 37084.0 37229.6 37527.0 37647.4 37668.6 240177.0 240625.0 241147.0 242172.0 243635.0 27893.2 30690.4 31313.0 31362.7 31455.0 35837.5 35988.1 36616.1 36921.4 37057.8 31361.7 31377.4 31734.2 32351.2 32606.8 31299.7 31986.4 32001.8 32015.5 33864.8 31841.8 31984.8 32097.5 32165.0 34341.1 34781.3 34891.7 35593.3 35620.6 36099.3 28603.0 28977.4 29113.6 29211.6 29532.6 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25999.12 Median:4522.26 stddev:82174.70 (1817.1%) stddev-sans-first:82382.52 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: Values: 278.0 282.1 284.3 285.2 292.3 12509.6 12975.5 15073.2 15627.5 15669.9 9032.5 9548.4 9575.5 11669.6 13117.5 4437.5 4494.4 4519.0 4536.6 4539.7 4455.1 4525.5 4733.5 4735.2 4735.8 4660.0 4675.8 4680.2 4690.5 4786.4 5096.3 5128.1 5140.3 5145.8 5151.9 4890.5 4952.4 4965.9 4973.8 5023.6 10127.2 10579.7 10582.5 10609.7 11573.8 1751.2 1789.9 1811.2 1828.5 1866.7 8195.7 8497.4 9738.7 11927.5 12567.7 1695.4 1705.7 1755.2 1757.3 1758.8 47330.3 49510.5 50527.5 50926.0 51148.0 9455.7 9520.0 9551.7 9562.0 9614.7 12270.3 12270.8 12390.1 12392.8 12395.2 6892.1 6928.4 6940.3 6940.7 6946.9 6363.0 6427.8 6486.7 6515.1 6519.6 4022.3 4043.9 4084.0 4095.8 4163.0 1594.6 1643.2 1644.6 1662.6 1670.2 319.4 321.4 339.7 826.7 861.6 8715.2 8787.1 8804.6 8839.7 8957.4 348.1 762.3 767.1 793.4 912.5 7765.0 8012.9 8160.8 9076.5 9278.3 487780.0 489830.0 508204.0 512723.0 513634.0 64951.7 73166.0 74593.0 75231.6 75594.2 1009.3 1021.8 1034.0 1039.9 1053.7 13889.9 14647.3 14833.5 14853.6 15156.2 34159.3 34292.3 34865.3 35019.5 35132.5 44173.3 45530.3 46207.3 46470.3 49349.0 8234.9 8276.2 8391.5 8405.3 8928.7 12174.3 14692.1 14710.9 14978.2 15501.2 12348.5 12357.3 12444.9 12485.9 12979.9 12619.5 12706.6 12774.6 12991.9 13286.8 12939.9 12940.3 13262.5 13333.3 13583.1 7993.9 8116.1 8136.9 8282.0 8310.7 8311.0 9295.4 12909.7 13013.5 13563.5 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,023 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4826.09 Median:6312.49 stddev:2535.48 (40.2%) stddev-sans-first:2529.96 04:32:53 INFO - 2015-12-09 04:32:53,024 DEBUG : BROWSER_OUTPUT: Values: 1457.7 1634.3 1683.2 1685.6 1713.4 6670.8 6884.5 7118.3 7163.5 7171.7 7179.4 7248.9 7307.9 7315.4 7350.0 1991.5 1997.2 2004.1 2016.2 2021.6 2003.3 2013.6 2025.2 2050.4 2052.4 1665.5 1697.5 1965.0 2007.4 2036.1 1927.3 1935.0 1943.2 1944.2 1950.3 1970.5 1982.9 2001.1 2011.7 2022.4 7043.4 7079.7 7125.7 7181.3 7185.4 4069.9 4144.7 4149.4 4156.5 4188.0 2663.2 2679.3 2710.1 2733.0 2742.5 834.2 836.1 851.3 892.8 902.3 9093.4 9118.9 9229.5 9235.4 9258.6 3492.2 3528.3 3528.9 3531.8 3584.2 7518.0 7546.7 7562.1 7573.6 7597.0 3854.8 3862.7 3898.5 3915.2 3915.6 3623.6 3629.0 3636.9 3644.4 3656.0 2934.8 2966.5 2982.4 2986.9 2988.7 822.4 834.2 834.8 841.2 846.3 796.1 797.3 807.4 958.4 984.5 6430.4 6499.8 6566.9 6574.0 6578.5 936.6 966.5 969.6 976.2 977.5 5143.3 5158.8 5219.5 5222.2 5228.8 8218.8 8401.0 8475.0 8486.3 8490.1 8309.3 8339.5 8357.8 8372.1 8373.8 6346.7 6559.5 6580.3 6634.5 6637.3 6673.3 6727.0 6727.5 6729.3 6748.6 7446.1 7658.5 7659.5 7660.7 7741.3 7116.7 7256.5 7309.7 7312.4 7840.7 6217.6 6227.2 6304.4 6311.7 6321.5 6640.1 6692.9 6696.2 6713.5 6717.9 6012.4 6256.6 6269.5 6320.0 6378.7 5924.6 5965.3 6089.5 6238.5 6313.3 6024.2 6080.3 6092.2 6096.3 6097.0 5626.3 5704.5 5727.1 5733.5 5737.0 5777.5 5814.9 5838.5 5840.9 5850.9 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4772.96 Median:5568.90 stddev:1488.81 (26.7%) stddev-sans-first:1453.77 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: Values: 249.8 250.3 257.3 263.7 263.9 5500.7 5529.4 5546.6 5608.1 5704.2 5530.1 5562.9 5574.9 5608.4 5608.5 3894.8 4013.7 4034.8 4145.4 4150.8 4145.7 4147.5 4150.0 4150.7 4153.8 4087.3 4110.5 4112.8 4121.4 4130.9 4092.1 4108.2 4109.5 4111.3 4115.6 3379.7 3396.8 3459.0 3497.5 3499.5 5269.1 5276.1 5301.1 5316.4 5322.4 4702.2 4709.5 4716.1 4720.6 4721.7 5796.6 5807.9 5811.0 5823.5 5826.6 3660.3 3756.9 3766.1 3804.8 3812.8 5982.6 6084.5 6136.3 6155.2 6163.8 3866.6 3871.7 3873.7 3874.6 3896.6 3906.4 3931.4 3936.9 3940.3 3944.0 4579.1 4611.6 4667.3 4671.3 4675.2 5816.1 5819.4 5839.4 5852.2 5866.0 1361.1 1381.5 1384.1 1385.5 1390.5 888.1 888.1 898.1 900.1 908.9 5032.3 5088.2 5094.5 5100.9 5103.1 6084.7 6096.8 6097.8 6105.0 6121.7 5047.5 5091.8 5094.8 5098.5 5104.3 3201.0 3280.7 3280.8 3294.7 3301.1 5542.1 5664.6 5675.0 5694.8 5696.7 6288.7 6304.4 6304.8 6318.9 6321.7 5671.2 5696.8 5702.3 5704.3 5729.3 5928.6 6086.4 6096.8 6101.1 6116.8 5989.0 5992.7 5996.9 6004.1 6020.2 5695.5 5698.5 5699.1 5707.4 5736.1 3835.0 3917.6 3924.6 3934.2 3938.2 5983.9 6072.8 6107.1 6111.8 6114.7 5870.8 5876.9 5877.4 5898.3 5901.8 5870.6 5893.0 5899.1 5902.7 5915.1 5600.5 5772.0 5779.6 5800.2 5804.7 5965.1 5970.7 5972.9 5977.1 5982.1 5809.3 5823.5 5824.2 5825.7 5827.0 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12017.52 Median:41097.49 stddev:13343.82 (32.5%) stddev-sans-first:13353.95 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: Values: 650.7 734.2 772.7 779.4 780.4 10896.7 11592.1 11627.8 11629.2 11638.6 11075.2 11118.1 11159.2 11187.1 11236.8 617.8 619.5 782.7 797.5 797.7 774.8 788.1 790.4 790.7 791.8 835.7 837.7 841.4 842.9 843.6 830.6 830.8 831.8 833.9 835.1 616.4 620.1 621.3 622.8 623.0 11566.0 11661.4 11682.1 11693.2 11699.0 10912.6 11072.8 11227.3 11571.3 11597.7 9135.1 9169.9 9277.6 9298.7 9376.0 3189.0 3224.4 3227.8 3235.6 3256.4 38218.4 38548.0 38610.4 38613.2 38780.8 8433.2 8700.0 8850.0 9017.4 9192.4 16973.2 17061.7 17077.6 17087.7 17132.9 6313.4 6412.4 6461.4 6462.0 6631.7 3342.0 3521.3 3537.4 3537.7 3547.0 2628.3 2629.1 2668.1 2678.1 2680.4 467.7 475.4 482.7 484.0 488.8 434.8 517.9 561.7 598.7 613.2 7149.4 7304.3 7367.7 7453.6 7818.2 453.5 462.7 509.7 542.3 575.9 3527.4 3585.1 3735.3 3845.4 3874.2 46726.8 46811.3 47234.3 54455.5 55253.0 40973.6 41221.4 41498.0 41582.4 42080.2 38033.8 38801.6 39056.8 39750.2 39785.8 7480.6 7853.4 8255.9 8442.9 8466.2 29625.0 29648.0 31453.0 32422.8 32504.7 37061.4 37220.6 37241.0 37448.3 37502.0 10594.2 10755.6 10979.6 11047.9 11054.6 11118.7 11299.5 11427.9 11479.7 11617.5 10030.2 10156.8 10254.1 10602.5 10776.2 10273.9 10497.7 10551.8 10808.5 10831.0 10874.7 10929.9 10967.9 10993.1 11405.4 9063.9 9176.2 9192.8 9364.8 9717.4 9088.3 9622.9 9645.1 9677.9 9737.0 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:32:53 INFO - 2015-12-09 04:32:53,025 DEBUG : BROWSER_OUTPUT: 04:32:53 INFO - 2015-12-09 04:32:53,769 INFO : Browser exited with error code: 0 04:32:53 INFO - 2015-12-09 04:32:53,785 INFO : Completed test dromaeo_css (00:18:34) 04:32:53 INFO - 2015-12-09 04:32:53,785 INFO : Starting test kraken 04:32:53 INFO - 2015-12-09 04:32:53,785 DEBUG : operating with platform_type : linux_ 04:32:53 INFO - 2015-12-09 04:32:53,785 INFO : Initialising browser for kraken test... 04:32:53 INFO - 2015-12-09 04:32:53,791 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiYQwO/profile http://localhost:49019/getInfo.html 04:32:58 INFO - 2015-12-09 04:32:58,290 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:32:58 INFO - 2015-12-09 04:32:58,290 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:32:58 INFO - 2015-12-09 04:32:58,290 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:32:58 INFO - 2015-12-09 04:32:58,290 DEBUG : BROWSER_OUTPUT: __metrics 04:32:58 INFO - 2015-12-09 04:32:58,435 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:32:59 INFO - 2015-12-09 04:32:59,333 INFO : Browser initialized. 04:32:59 INFO - 2015-12-09 04:32:59,333 INFO : Running cycle 1/1 for kraken test... 04:32:59 INFO - 2015-12-09 04:32:59,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphiYQwO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:11 INFO - 2015-12-09 04:33:11,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 143425536 04:33:11 INFO - 2015-12-09 04:33:11,353 DEBUG : BROWSER_OUTPUT: 04:33:13 INFO - 2015-12-09 04:33:13,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49019/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:14 INFO - 2015-12-09 04:33:14,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 141713408 04:33:14 INFO - 2015-12-09 04:33:14,584 DEBUG : BROWSER_OUTPUT: 04:33:17 INFO - 2015-12-09 04:33:17,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49019/tests/kraken/driver.html?testName=audio-dft) 04:33:17 INFO - 2015-12-09 04:33:17,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 04:33:17 INFO - 2015-12-09 04:33:17,930 DEBUG : BROWSER_OUTPUT: 04:33:20 INFO - 2015-12-09 04:33:20,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49019/tests/kraken/driver.html?testName=audio-fft) 04:33:21 INFO - 2015-12-09 04:33:21,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 137637888 04:33:21 INFO - 2015-12-09 04:33:21,442 DEBUG : BROWSER_OUTPUT: 04:33:23 INFO - 2015-12-09 04:33:23,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49019/tests/kraken/driver.html?testName=audio-oscillator) 04:33:24 INFO - 2015-12-09 04:33:24,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 138612736 04:33:24 INFO - 2015-12-09 04:33:24,136 DEBUG : BROWSER_OUTPUT: 04:33:26 INFO - 2015-12-09 04:33:26,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:26 INFO - 2015-12-09 04:33:26,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 140357632 04:33:26 INFO - 2015-12-09 04:33:26,982 DEBUG : BROWSER_OUTPUT: 04:33:30 INFO - 2015-12-09 04:33:30,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49019/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:30 INFO - 2015-12-09 04:33:30,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 04:33:30 INFO - 2015-12-09 04:33:30,642 DEBUG : BROWSER_OUTPUT: 04:33:34 INFO - 2015-12-09 04:33:34,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49019/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:34 INFO - 2015-12-09 04:33:34,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 04:33:34 INFO - 2015-12-09 04:33:34,739 DEBUG : BROWSER_OUTPUT: 04:33:37 INFO - 2015-12-09 04:33:37,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49019/tests/kraken/driver.html?testName=json-parse-financial) 04:33:38 INFO - 2015-12-09 04:33:38,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 04:33:38 INFO - 2015-12-09 04:33:38,227 DEBUG : BROWSER_OUTPUT: 04:33:40 INFO - 2015-12-09 04:33:40,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:40 INFO - 2015-12-09 04:33:40,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 04:33:40 INFO - 2015-12-09 04:33:40,583 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-09 04:33:42,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:43 INFO - 2015-12-09 04:33:43,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 139259904 04:33:43 INFO - 2015-12-09 04:33:43,065 DEBUG : BROWSER_OUTPUT: 04:33:45 INFO - 2015-12-09 04:33:45,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:45 INFO - 2015-12-09 04:33:45,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 04:33:45 INFO - 2015-12-09 04:33:45,823 DEBUG : BROWSER_OUTPUT: 04:33:48 INFO - 2015-12-09 04:33:48,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:48 INFO - 2015-12-09 04:33:48,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 04:33:48 INFO - 2015-12-09 04:33:48,978 DEBUG : BROWSER_OUTPUT: 04:33:51 INFO - 2015-12-09 04:33:51,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:52 INFO - 2015-12-09 04:33:52,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 139382784 04:33:52 INFO - 2015-12-09 04:33:52,208 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49019/tests/kraken/driver.html?testName=ai-astar) 04:33:54 INFO - 2015-12-09 04:33:54,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 140156928 04:33:54 INFO - 2015-12-09 04:33:54,262 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,263 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:54 INFO - 2015-12-09 04:33:54,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:54 INFO - 2015-12-09 04:33:54,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:54 INFO - 2015-12-09 04:33:54,263 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:54 INFO - 2015-12-09 04:33:54,264 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;116;113;115;127;115;115;116;116 04:33:54 INFO - 2015-12-09 04:33:54,264 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;131;157;169;131;157;155;134;167;132 04:33:54 INFO - 2015-12-09 04:33:54,264 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;163;163;166;165;170;163;165;164 04:33:54 INFO - 2015-12-09 04:33:54,264 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;74;73;149;73;80;73;75;158 04:33:54 INFO - 2015-12-09 04:33:54,265 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;132;94;95;95;138;95;95;130 04:33:54 INFO - 2015-12-09 04:33:54,265 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;112;110;110;111 04:33:54 INFO - 2015-12-09 04:33:54,265 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;148;148;150;148;148 04:33:54 INFO - 2015-12-09 04:33:54,265 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;95;96;96;97;97;95 04:33:54 INFO - 2015-12-09 04:33:54,266 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;75;74;76;75;75;79;72;73 04:33:54 INFO - 2015-12-09 04:33:54,266 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;69;68;69;69;68;69;68 04:33:54 INFO - 2015-12-09 04:33:54,266 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;88;96;85;88;85;86;86 04:33:54 INFO - 2015-12-09 04:33:54,266 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;123;132;118;136;120;131;128;129;120 04:33:54 INFO - 2015-12-09 04:33:54,266 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;147;151;154;149;137;143;159;152;137 04:33:54 INFO - 2015-12-09 04:33:54,267 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;74;72;70;72;72;73;77;70 04:33:54 INFO - 2015-12-09 04:33:54,267 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:54 INFO - 2015-12-09 04:33:54,267 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:54 INFO - 2015-12-09 04:33:54,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,796 04:33:54 INFO - 2015-12-09 04:33:54,268 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:54 INFO - 2015-12-09 04:33:54,268 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664434262__endTimestamp 04:33:54 INFO - 2015-12-09 04:33:54,268 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,271 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.60 Median:115.50 stddev:4.53 (3.9%) stddev-sans-first:4.76 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 116.0 113.0 115.0 127.0 115.0 115.0 116.0 116.0 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:157.00 stddev:15.98 (10.2%) stddev-sans-first:15.98 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: Values: 165.0 131.0 157.0 169.0 131.0 157.0 155.0 134.0 167.0 132.0 04:33:54 INFO - 2015-12-09 04:33:54,272 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.17 (1.3%) stddev-sans-first:2.22 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 163.0 163.0 166.0 165.0 170.0 163.0 165.0 164.0 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.30 Median:73.50 stddev:33.44 (45.5%) stddev-sans-first:35.01 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 74.0 73.0 149.0 73.0 80.0 73.0 75.0 158.0 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:18.63 (19.6%) stddev-sans-first:19.29 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 132.0 94.0 95.0 95.0 138.0 95.0 95.0 130.0 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,273 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 112.0 110.0 110.0 111.0 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 148.0 148.0 150.0 148.0 148.0 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 95.0 96.0 96.0 97.0 97.0 95.0 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.70 Median:75.00 stddev:1.89 (2.5%) stddev-sans-first:1.99 04:33:54 INFO - 2015-12-09 04:33:54,274 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 75.0 74.0 76.0 75.0 75.0 79.0 72.0 73.0 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 68.0 69.0 69.0 68.0 69.0 68.0 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:3.59 (4.2%) stddev-sans-first:3.55 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 88.0 96.0 85.0 88.0 85.0 86.0 86.0 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.50 stddev:5.97 (4.6%) stddev-sans-first:6.30 04:33:54 INFO - 2015-12-09 04:33:54,275 DEBUG : BROWSER_OUTPUT: Values: 128.0 123.0 132.0 118.0 136.0 120.0 131.0 128.0 129.0 120.0 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:150.00 stddev:7.70 (5.1%) stddev-sans-first:7.50 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: Values: 138.0 147.0 151.0 154.0 149.0 137.0 143.0 159.0 152.0 137.0 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:2.38 (3.3%) stddev-sans-first:2.28 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 74.0 72.0 70.0 72.0 72.0 73.0 77.0 70.0 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:54 INFO - 2015-12-09 04:33:54,276 DEBUG : BROWSER_OUTPUT: 04:33:55 INFO - 2015-12-09 04:33:55,233 INFO : Browser exited with error code: 0 04:33:55 INFO - 2015-12-09 04:33:55,288 INFO : Completed test kraken (00:01:01) 04:33:55 INFO - 2015-12-09 04:33:55,288 INFO : Starting test v8_7 04:33:55 INFO - 2015-12-09 04:33:55,288 DEBUG : operating with platform_type : linux_ 04:33:55 INFO - 2015-12-09 04:33:55,288 INFO : Initialising browser for v8_7 test... 04:33:55 INFO - 2015-12-09 04:33:55,294 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKt4jVn/profile http://localhost:49019/getInfo.html 04:33:59 INFO - 2015-12-09 04:33:59,842 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:59 INFO - 2015-12-09 04:33:59,842 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:59 INFO - 2015-12-09 04:33:59,842 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:59 INFO - 2015-12-09 04:33:59,842 DEBUG : BROWSER_OUTPUT: __metrics 04:33:59 INFO - 2015-12-09 04:33:59,979 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:34:00 INFO - 2015-12-09 04:34:00,857 INFO : Browser initialized. 04:34:00 INFO - 2015-12-09 04:34:00,857 INFO : Running cycle 1/1 for v8_7 test... 04:34:00 INFO - 2015-12-09 04:34:00,857 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKt4jVn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:13 INFO - 2015-12-09 04:34:13,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 143167488 04:34:13 INFO - 2015-12-09 04:34:13,004 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49019/tests/v8_7/run.html (next: http://localhost:49019/tests/v8_7/run.html) 04:34:34 INFO - 2015-12-09 04:34:34,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:34 INFO - 2015-12-09 04:34:34,632 DEBUG : BROWSER_OUTPUT: |0;Richards;170.88174982911826 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.23375624759709 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.5270768358378 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5284.210526315789 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |5;Earley;718.3908045977012 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 04:34:34 INFO - 2015-12-09 04:34:34,633 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 04:34:34 INFO - 2015-12-09 04:34:34,634 DEBUG : BROWSER_OUTPUT: |8;Splay;605.3268765133172 04:34:34 INFO - 2015-12-09 04:34:34,634 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:34:34 INFO - 2015-12-09 04:34:34,634 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:34 INFO - 2015-12-09 04:34:34,635 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664474630__endTimestamp 04:34:34 INFO - 2015-12-09 04:34:34,635 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,635 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:34 INFO - 2015-12-09 04:34:34,635 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:34 INFO - 2015-12-09 04:34:34,635 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.88 Median:170.88 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: Values: 170.9 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.23 Median:192.23 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: Values: 192.2 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,636 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.53 Median:283.53 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: Values: 283.5 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: Values: 5284.2 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: Values: 1071.8 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: Values: 718.4 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,637 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,638 DEBUG : BROWSER_OUTPUT: Values: 12207.3 04:34:34 INFO - 2015-12-09 04:34:34,638 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: Values: 26394.7 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: Values: 605.3 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:34 INFO - 2015-12-09 04:34:34,639 DEBUG : BROWSER_OUTPUT: 04:34:35 INFO - 2015-12-09 04:34:35,501 INFO : Browser exited with error code: 0 04:34:35 INFO - 2015-12-09 04:34:35,515 INFO : Completed test v8_7 (00:00:40) 04:34:35 INFO - 2015-12-09 04:34:35,690 INFO : Completed test suite (00:20:16) 04:34:35 INFO - 2015-12-09 04:34:35,690 DEBUG : Working with test: dromaeo_css 04:34:35 INFO - 2015-12-09 04:34:35,690 DEBUG : Generating results file: dromaeo_css 04:34:35 INFO - 2015-12-09 04:34:35,691 DEBUG : Working with test: kraken 04:34:35 INFO - 2015-12-09 04:34:35,691 DEBUG : Generating results file: kraken 04:34:35 INFO - 2015-12-09 04:34:35,691 INFO : javascript benchmark 04:34:35 INFO - 2015-12-09 04:34:35,691 DEBUG : Working with test: v8_7 04:34:35 INFO - 2015-12-09 04:34:35,692 DEBUG : Generating results file: v8_7 04:34:35 INFO - 2015-12-09 04:34:35,692 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:35 INFO - 2015-12-09 04:34:35,769 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:34:35 INFO - 2015-12-09 04:34:35,769 DEBUG : process_Request line: dromaeo_css 6149.70 graph.html#tests=[[72,94,43]] 04:34:35 INFO - 2015-12-09 04:34:35,769 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:35 INFO - 2015-12-09 04:34:35,814 DEBUG : process_Request line: kraken 1556.20 graph.html#tests=[[232,94,43]] 04:34:35 INFO - 2015-12-09 04:34:35,814 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:35 INFO - 2015-12-09 04:34:35,850 DEBUG : process_Request line: v8_7 21093.71 graph.html#tests=[[230,94,43]] 04:34:35 INFO - 2015-12-09 04:34:35,851 INFO : javascript benchmark 04:34:35 INFO - 2015-12-09 04:34:35,855 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2677.8125531212813, 2701.797365197611, 2735.835849849008, 2755.462684776468, 2763.5163846326896, 4483.991102002048, 4798.184308667526, 4803.183458812002, 4831.396075490564, 4839.15314819906, 4681.648876334271, 4725.3384526166365, 4802.879928001793, 4828.88935544824, 4846.321514987896, 4254.298040823268, 4322.632576231024, 4370.868873933787, 4394.07724377881, 4417.42573465449, 525.082830731666, 4286.03564198056, 4319.48166220054, 4339.934900976488, 4432.3794668746405, 4361.389405483234, 4446.555344465528, 4457.442819647544, 4467.82128714851, 4495.730256184639, 4447.444069491314, 4447.7776111194635, 4465.307877279027, 4465.37484752135, 4501.977490112561, 4146.979265103685, 4224.9155016899485, 4237.957620423787, 4318.481782186158, 4472.798724057425, 4655.4180727409075, 4667.346571479996, 4673.299005149221, 4687.156311863863, 4710.764461776932, 5090.10923088458, 5139.691618502902, 5141.845744627667, 5148.176291793295, 5210.114280572312, 4937.654364194508, 5072.2391641253735, 5080.923786143211, 5140.383154021504, 5172.6379153459275, 4743.407074115701, 4757.785899634525, 4758.976205118952, 4764.857054288377, 4812.663113582015, 4834.661573689808, 5187.896242075138, 5204.635675502755, 5247.475252474798, 5264.42091369949, 4861.246506791453, 4912.263160525949, 4986.0775756484445, 5025.422076461254, 5070.518300761421, 5091.261767043758, 5155.200943853709, 5182.274481572583, 5184.637075404761, 5273.973630131824, 4760.571548560646, 4862.343583616237, 5079.568236699922, 5120.513551212629, 5127.717975511308, 4933.481984391659, 4983.451820299764, 4984.352034235526, 4996.600271978233, 5048.268001139814, 4233.04756429807, 4268.679849011337, 4271.551487093872, 4271.850485233064, 4316.093620339701, 3570.8036058016537, 3654.872079477259, 3670.834812433447, 3761.6238376162164, 3829.2341531693774, 4368.825246990148, 4389.890252743707, 4399.890002749957, 4402.933955990663, 4436.334549817553, 5110.591152707774, 5134.921666450087, 5160.767765450564, 5162.819301324435, 5203.60972927032, 4182.121754431542, 4226.429432026698, 4274.679399045084, 4357.629601483909, 4377.233984052778, 4509.6843220974215, 4519.05099929012, 4548.317752337176, 4565.3836732040745, 4594.150082234797, 4846.781894814671, 4856.95143048572, 4866.124097662384, 4867.342908707279, 4897.975510122426, 4880.707157570557, 4978.377702787152, 4982.202847544376, 4983.501649834988, 4986.102501549756, 4678.0, 4702.882427939329, 4728.527147285382, 4754.096721622881, 4798.208295631322, 5011.824586139468, 5100.79596816138, 5114.33513643224, 5119.308893299357, 5149.304843846033, 4861.465238823655, 4988.401391833003, 5173.22401639757, 5188.636795424284, 5192.5586325162785, 4888.6577939543895, 4962.652614316963, 4964.578010869117, 4980.726060066731, 5014.17266151081, 4898.363212782316, 4956.72737999399, 4958.801647934042, 4962.354893863775, 4999.875003124951, 4660.6970546914345, 4721.952780472288, 4744.051189761993, 4874.0, 4905.950940490692, 4982.053409852117, 4984.576311013604, 5010.473900240568, 5031.0, 5033.874153146201, 4896.853094407174, 4900.534449227318, 4902.852914412573, 4906.116898958222, 4915.754212289443], "unit": "ms", "name": "dojo.html", "value": 4633.009086548107}, {"lowerIsBetter": false, "replicates": [534.2493796216315, 537.7069497124069, 544.113095654084, 551.8179000929694, 560.3555910702694, 26412.471750565, 34686.47970280448, 35097.0, 35143.12142196446, 35145.82427087864, 39882.0, 40127.59872401275, 40485.39271910924, 40509.59490405095, 40572.0, 7748.612569371523, 7865.842683146334, 7872.527648341089, 7876.488028278172, 7907.2488113629115, 7874.606269686521, 7944.404169687267, 7977.56123413212, 7983.281504664579, 7988.281054705076, 7838.372930165573, 7872.803179920519, 7873.409494287923, 7916.0500739911, 7930.881036784453, 7540.321371076602, 7574.7727568172495, 7586.468947173727, 7587.0, 7592.278733520362, 7832.960835195788, 7912.762617121438, 7918.841623167562, 7919.089304729972, 7954.801129971739, 35934.28131437357, 36649.267014659825, 36672.0, 36718.082047948745, 36739.816300918326, 2776.3649962602844, 2798.6221860048836, 3068.3709839483076, 3313.2545177335146, 3561.786292822439, 27829.0, 28289.858550707322, 28456.28859278514, 28456.430871382458, 28541.57187642187, 3232.4666430039015, 3359.9496007559906, 3426.3832510148163, 3435.793852368866, 3464.4456886897974, 211265.0, 211353.0, 211634.0, 212046.99999999846, 212306.0, 45487.0, 46650.0, 53397.0, 54862.45137548573, 54956.0, 46664.7666761664, 47228.29157562639, 47525.76237118792, 47548.28677569839, 47878.0, 12571.497140114476, 12886.29125398112, 12899.290539020256, 12913.806292905614, 12940.805887911689, 9534.18959388446, 9684.0, 9690.321677482649, 9695.078967498077, 9705.932347441776, 18011.459656210336, 18170.727439088423, 18174.36389726353, 18207.362742303954, 18279.360222392417, 7345.338919497271, 7575.0909890813455, 7586.810329741801, 7713.1515533291295, 7736.574488403192, 814.645629151321, 823.9505629662119, 884.6019291318933, 895.3553441522224, 924.6624981881699, 20368.185272589228, 20452.0, 20455.28406505795, 20970.0, 22126.225582104547, 863.2575984653193, 939.1078475448352, 981.6711401680517, 992.7021893431942, 1087.717193529688, 11727.472263748152, 11782.646520604396, 12039.157258991961, 12079.879201208052, 12115.0, 253137.0, 255776.0, 257921.0, 259004.0, 259223.0, 44547.0, 44670.0, 44923.0, 45028.77485612551, 45083.0, 1157.1841851494676, 1180.7579446213506, 1182.3851597169596, 1183.5325046606542, 1190.149043433949, 21858.89070554637, 23133.88433057824, 23354.416139596648, 23397.181098661466, 23431.531369372857, 37084.0, 37229.62770372262, 37527.0, 37647.43528847124, 37668.62331376651, 240177.0, 240625.0, 241147.0, 242172.0, 243635.0, 27893.16320510388, 30690.386192275582, 31313.0, 31362.68637313689, 31455.0, 35837.462438062925, 35988.10029749277, 36616.08459788527, 36921.44617830681, 37057.81471092627, 31361.68638313679, 31377.372452550364, 31734.206644834063, 32351.19122021874, 32606.83696581502, 31299.68700312968, 31986.360272793947, 32001.839990799897, 32015.519767203976, 33864.83067584646, 31841.840790795897, 31984.840075800403, 32097.518537222426, 32165.0, 34341.141471463416, 34781.30437391187, 34891.65108348986, 35593.28813423665, 35620.643793561736, 36099.27801444009, 28603.0, 28977.420451590428, 29113.563296550994, 29211.561826572193, 29532.557011645273], "unit": "ms", "name": "ext.html", "value": 16337.58555403409}, {"lowerIsBetter": false, "replicates": [277.9958300625491, 282.0972886762361, 284.3332385555871, 285.23699104894416, 292.26786898818455, 12509.562165324216, 12975.545855895045, 15073.170975596338, 15627.453039143633, 15669.921650391761, 9032.50321232332, 9548.379355341898, 9575.473348965805, 11669.649910502678, 13117.47530098795, 4437.511873693891, 4494.393256910308, 4518.97740511297, 4536.614387777043, 4539.704919180259, 4455.086707225011, 4525.547445255481, 4733.502982186872, 4735.242361222206, 4735.810567577293, 4660.021395506948, 4675.766211689419, 4680.227762419197, 4690.507496712848, 4786.449558300805, 5096.286519887219, 5128.05131050755, 5140.280360749498, 5145.845624631267, 5151.871203219949, 4890.462049174588, 4952.405711314629, 4965.925511117336, 4973.776180071905, 5023.6232282578585, 10127.240456965757, 10579.73550661232, 10582.523786429629, 10609.734756631146, 11573.826392604118, 1751.20320254284, 1789.8926064436175, 1811.212122726605, 1828.506303298102, 1866.7199920011972, 8195.713150039779, 8497.362697797627, 9738.707838764849, 11927.463264153133, 12567.748645027048, 1695.4320302698611, 1705.6759215749091, 1755.1662960093854, 1757.2707326459504, 1758.832910873465, 47330.290045649344, 49510.50489495095, 50527.494725052646, 50926.0, 51147.97704045935, 9455.669051583161, 9520.0, 9551.713448596553, 9562.0, 9614.71155865311, 12270.263784172977, 12270.754584908253, 12390.132690711744, 12392.75214495723, 12395.194312369667, 6892.104026476526, 6928.44572434204, 6940.305969403019, 6940.6529673516125, 6946.861062778716, 6362.968185159045, 6427.775027874002, 6486.6756662167645, 6515.087887695727, 6519.576227545194, 4022.2960981828064, 4043.8989025274013, 4083.9795801020805, 4095.795210239476, 4162.958370416257, 1594.6412057287018, 1643.1537758054612, 1644.602088224999, 1662.609286817597, 1670.2316934210398, 319.39634091566955, 321.41983719386263, 339.69257821671425, 826.7437094500724, 861.6036623153294, 8715.172058654418, 8787.121287871161, 8804.647814087493, 8839.69061082859, 8957.372983891066, 348.127939511522, 762.325342072259, 767.1024900866, 793.3771988988732, 912.4570880326195, 7765.0, 8012.879806802903, 8160.795980100545, 9076.500792456478, 9278.304127190488, 487780.0, 489830.0, 508204.0, 512723.0, 513634.0, 64951.67524162349, 73166.0, 74593.0, 75231.62384188044, 75594.24405755872, 1009.28340877976, 1021.7701017271203, 1034.04350975349, 1039.896010398954, 1053.72603123187, 13889.861101388857, 14647.26763661834, 14833.480828170963, 14853.554393368217, 15156.166410847509, 34159.31681366309, 34292.31415371629, 34865.30269394648, 35019.47470787889, 35132.47301290432, 44173.33739993967, 45530.317045245014, 46207.306890396, 46470.30294545652, 49349.01301974012, 8234.876476852733, 8276.213759692819, 8391.538465384463, 8405.285550728257, 8928.73213803587, 12174.33041182708, 14692.118472891661, 14710.926445367704, 14978.176200309088, 15501.224938752792, 12348.506059757508, 12357.25856448616, 12444.937775311066, 12485.87514124847, 12979.935100324816, 12619.49522019109, 12706.618801435972, 12774.552890648783, 12991.870081299066, 13286.800697989345, 12939.935300323437, 12940.288284144463, 13262.469501219843, 13333.266670332836, 13583.117097388638, 7993.858547187578, 8116.147804480681, 8136.877946830684, 8281.95859020701, 8310.667573297, 8310.958445207736, 9295.442273463614, 12909.741805164032, 13013.479460821462, 13563.525276615272], "unit": "ms", "name": "jquery.html", "value": 7550.069677895163}, {"lowerIsBetter": false, "replicates": [1457.672023794647, 1634.3217564710646, 1683.150009245331, 1685.6207353345499, 1713.3660545598132, 6670.76652317169, 6884.483663725222, 7118.323759242877, 7163.462740294479, 7171.748988785387, 7179.425645948325, 7248.891266631004, 7307.926920730791, 7315.378192853614, 7350.0, 1991.4822146242009, 1997.1512107354388, 2004.1382205651564, 2016.2439085342996, 2021.5956808638257, 2003.258794246131, 2013.6174126915912, 2025.230412443277, 2050.384884534641, 2052.363767232155, 1665.53365057784, 1697.507722760398, 1965.0076711260792, 2007.4479518132484, 2036.1448191759423, 1927.296536764078, 1934.9613007739836, 1943.1935746665117, 1944.2417457191707, 1950.2978927586057, 1970.4679736471217, 1982.8512861535442, 2001.129508663736, 2011.6680747676762, 2022.4135000849735, 7043.401310888581, 7079.716811327541, 7125.7149714011375, 7181.317774811385, 7185.353318201334, 4069.9389509157386, 4144.668426525871, 4149.3775933609895, 4156.542780294165, 4187.979060104711, 2663.227663977444, 2679.3435608276095, 2710.0785732850727, 2732.9590056149173, 2742.5337692592107, 834.1741675741033, 836.1137194573711, 851.3444647621297, 892.7500299916034, 902.2691619787993, 9093.40892841963, 9118.908810911938, 9229.53852307382, 9235.353525253235, 9258.583363748647, 3492.196794737174, 3528.276703275874, 3528.9117772055906, 3531.7527773056154, 3584.2473080653353, 7517.962410187914, 7546.698132074655, 7562.130355009134, 7573.583452910033, 7596.962015189889, 3854.807259637007, 3862.6716729078344, 3898.4542164097047, 3915.197384536163, 3915.569287378386, 3623.5651721793024, 3629.0, 3636.872709455209, 3644.4351125575577, 3656.0, 2934.8385838778645, 2966.495695731731, 2982.403519296106, 2986.8954586589366, 2988.716071973159, 822.4037572759702, 834.1783343406739, 834.7996480844554, 841.1714461255658, 846.272205902923, 796.1043825696092, 797.3262593108814, 807.4347956430522, 958.4488918871676, 984.4585477987222, 6430.3891130342545, 6499.805005849832, 6566.901496477557, 6574.046763219402, 6578.506612004119, 936.6206686292063, 966.463612694947, 969.6266937229218, 976.2385339435252, 977.5210147028047, 5143.331366922276, 5158.767855446514, 5219.530242278213, 5222.190560463135, 5228.816991405282, 8218.83562328762, 8401.0, 8475.02537208229, 8486.32109431244, 8490.108538603481, 8309.252167304972, 8339.45793523419, 8357.832843343222, 8372.079071302152, 8373.8325233495, 6346.650934198663, 6559.4752419807255, 6580.309067547934, 6634.535582509178, 6637.303083176197, 6673.299303573249, 6727.0, 6727.495437842083, 6729.327067293231, 6748.561343512656, 7446.106467223968, 7658.4639075264195, 7659.463837531543, 7660.655270512952, 7741.264579864904, 7116.679749411185, 7256.492045556761, 7309.671064801991, 7312.41500679955, 7840.686372545262, 6217.595856269509, 6227.159333489921, 6304.401081897213, 6311.715972781144, 6321.49428045746, 6640.103586016019, 6692.933070669231, 6696.196456425066, 6713.462922966053, 6717.899231511434, 6012.428819262163, 6256.562040657111, 6269.529785266214, 6320.020396838498, 6378.74485020594, 5924.585279030426, 5965.284165899946, 6089.48239399656, 6238.469730072995, 6313.273973493107, 6024.216851809237, 6080.331163571915, 6092.177556030057, 6096.329403765493, 6097.024476083982, 5626.2967129108865, 5704.515116215002, 5727.11229759388, 5733.512651424676, 5737.0, 5777.537796976148, 5814.883702326015, 5838.474537291664, 5840.94159058421, 5850.853728656818], "unit": "ms", "name": "mootools.html", "value": 3923.3470272787304}, {"lowerIsBetter": false, "replicates": [249.7527447826651, 250.2579850742548, 257.26935503170995, 263.66909528541674, 263.90235612823255, 5500.724963751812, 5529.447055294469, 5546.584006199531, 5608.10270356743, 5704.172894930232, 5530.115181570949, 5562.9443705562935, 5574.86062848429, 5608.383077861432, 5608.523275521576, 3894.8247328870198, 4013.678905687538, 4034.798260086984, 4145.3574695922025, 4150.792460376969, 4145.709800313979, 4147.4815648044, 4149.9792501037455, 4150.709450338478, 4153.792310384469, 4087.264292427362, 4110.527289361717, 4112.773797441139, 4121.402396652484, 4130.8554200602985, 4092.0997380576373, 4108.219438306712, 4109.506859176918, 4111.280525907954, 4115.588441155861, 3379.729621630264, 3396.7792093513845, 3459.0487615905577, 3497.5278337424375, 3499.5275637788827, 5269.130593452076, 5276.076686579871, 5301.098813201726, 5316.362036555638, 5322.441143679896, 4702.247640377557, 4709.481956984729, 4716.103940251375, 4720.622350212009, 4721.669483136182, 5796.594238403313, 5807.88384232313, 5811.041178205591, 5823.505002074829, 5826.621269617462, 3660.2862441823854, 3756.9436458453147, 3766.0584853786554, 3804.809759512041, 3812.7902965336893, 5982.611130276518, 6084.4828189603495, 6136.325004249529, 6155.199824022849, 6163.815085547396, 3866.6326698963553, 3871.690264778811, 3873.7482063666334, 3874.5737968823405, 3896.59085795993, 3906.3554513504955, 3931.4102884566973, 3936.8622098226424, 3940.2907476653904, 3943.9802800985813, 4579.107074120515, 4611.631069514431, 4667.299905014207, 4671.252599584051, 4675.228587283128, 5816.069428891357, 5819.447152520504, 5839.416058394127, 5852.151438041546, 5865.970670146622, 1361.0540674231315, 1381.4543255414055, 1384.1279993603964, 1385.49429458247, 1390.5480718766441, 888.0630934364308, 888.1340692824444, 898.0929261445856, 900.1088921967336, 908.8863892013499, 5032.345795046621, 5088.185890257541, 5094.490550944876, 5100.872478188001, 5103.132467480537, 6084.726187321581, 6096.847578810476, 6097.847553811191, 6105.0, 6121.663308518075, 5047.545720885065, 5091.847244582668, 5094.821681241213, 5098.490150984946, 5104.336436263262, 3200.967990320067, 3280.721138703237, 3280.819554924454, 3294.670532946734, 3301.0756988043386, 5542.140968149944, 5664.6034777566, 5675.035244008528, 5694.829155125353, 5696.743646535916, 6288.717007734572, 6304.401081897213, 6304.779332723333, 6318.936810631835, 6321.65230912295, 5671.206031155559, 5696.829095127153, 5702.287214098154, 5704.3154821421695, 5729.341125770589, 5928.614640048383, 6086.391360863879, 6096.786612468542, 6101.145839582373, 6116.755329786759, 5989.0, 5992.730327135377, 5996.940030599638, 6004.099385092271, 6020.187274717857, 5695.544356451391, 5698.515626171822, 5699.059655157019, 5707.400722924033, 5736.110902810071, 3834.961650383572, 3917.6278253565865, 3924.6467817895386, 3934.173823496983, 3938.1729836734607, 5983.850403739767, 6072.787452439144, 6107.053406721965, 6111.84720381994, 6114.6636934969, 5870.765169393348, 5876.911846322223, 5877.353491115889, 5898.3216930053595, 5901.7639294427745, 5870.647761134345, 5893.0, 5899.144624029406, 5902.734376952962, 5915.08316210988, 5600.467955544217, 5771.971140144273, 5779.595428319977, 5800.245968024298, 5804.709764511842, 5965.105234214902, 5970.671613061323, 5972.8805423892145, 5977.103434484862, 5982.0727787193055, 5809.2738407699035, 5823.475887170175, 5824.242848429677, 5825.737841797045, 5827.009408400498], "unit": "ms", "name": "prototype.html", "value": 4266.340722116713}, {"lowerIsBetter": false, "replicates": [650.7136859781696, 734.2363941500839, 772.74499415193, 779.4154384211841, 780.418588151827, 10896.673099807009, 11592.130590205727, 11627.825582616246, 11629.24409913356, 11638.592649257289, 11075.16936229782, 11118.110551155909, 11159.218854680175, 11187.105031597473, 11236.831447528293, 617.8424501752047, 619.4548797058582, 782.6791015683557, 797.5294576200041, 797.7407342613644, 774.8489044636298, 788.113372455987, 790.4032455496092, 790.746960972489, 791.8139237279235, 835.6657337065162, 837.6733074101105, 841.4446465332882, 842.877782721505, 843.5613480989881, 830.5515021888173, 830.7673851321609, 831.7587899509135, 833.9082700902895, 835.1272919798824, 616.3866952382364, 620.1194304088206, 621.3320680268729, 622.7851391270004, 622.9657368844712, 11566.0, 11661.358625275607, 11682.065434765198, 11693.181477296592, 11699.0, 10912.563497460093, 11072.815799551385, 11227.326360418401, 11571.305721656643, 11597.6520704379, 9135.132162444623, 9169.908300916972, 9277.58250878712, 9298.72103836886, 9376.0, 3189.027346659268, 3224.3712476067176, 3227.774055816094, 3235.6440791512914, 3256.4301247281633, 38218.426723599165, 38548.03629909247, 38610.42084368737, 38613.227735445136, 38780.80609596962, 8433.241008309282, 8700.0, 8850.026497085315, 9017.368784185044, 9192.402493837879, 16973.15134243283, 17061.7440738389, 17077.57306067358, 17087.743683844754, 17132.914335428242, 6313.40022697843, 6412.422881940648, 6461.353864613595, 6461.967690161613, 6631.734730610818, 3341.9665803341654, 3521.3133438979667, 3537.4163263061823, 3537.663921927413, 3546.982265088658, 2628.290361602357, 2629.066681328139, 2668.119520558211, 2678.1296078774476, 2680.370113023438, 467.7287173439397, 475.35589276530493, 482.7151980331551, 483.99516004840206, 488.78249179115664, 434.75653633965084, 517.8705323669083, 561.6910699115471, 598.6587645042284, 613.2487702564412, 7149.428045756327, 7304.342609165201, 7367.705291788376, 7453.627318634047, 7818.179091195457, 453.4694407543182, 462.6761267113034, 509.73493783233255, 542.2923085373625, 575.8877018981342, 3527.3827080260853, 3585.1344674947704, 3735.327641024587, 3845.442410850411, 3874.1670540833293, 46726.76636616863, 46811.29783053257, 47234.29148562774, 54455.455445445834, 55253.0, 40973.59026409758, 41221.38167927483, 41498.0, 41582.37626435606, 42080.158396831896, 38033.80983095122, 38801.6119838798, 39056.804715976235, 39750.20499589992, 39785.80107099388, 7480.625968701652, 7853.37173026168, 8255.917440825755, 8442.902422685012, 8466.238038576557, 29625.0, 29648.0, 31453.0, 32422.83788581042, 32504.67495325111, 37061.44407833939, 37220.62779372172, 37241.0, 37448.2510349786, 37502.0, 10594.152467802403, 10755.623553175601, 10979.615713449992, 11047.944760276147, 11054.557817687202, 11118.666440006813, 11299.548018079186, 11427.914348136914, 11479.655610331703, 11617.47721352558, 10030.247731420319, 10156.847647285149, 10254.128399086161, 10602.46987650599, 10776.191785616267, 10273.9486302568, 10497.737556561147, 10551.841722374016, 10808.459577021275, 10831.0, 10874.67375978722, 10929.945350273198, 10967.890321096687, 10993.065589424668, 11405.372704501333, 9063.864042039242, 9176.174144327042, 9192.770180745534, 9364.812703746024, 9717.368371055858, 9088.318376121684, 9622.855657165288, 9645.131938125602, 9677.9032209677, 9737.0], "unit": "ms", "name": "yui.html", "value": 5654.11782774692}], "name": "dromaeo_css", "value": 6149.6974725753425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 116.0, 113.0, 115.0, 127.0, 115.0, 115.0, 116.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [165.0, 131.0, 157.0, 169.0, 131.0, 157.0, 155.0, 134.0, 167.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 163.0, 166.0, 165.0, 170.0, 163.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 73.0, 149.0, 73.0, 80.0, 73.0, 75.0, 158.0], "unit": "ms", "name": "audio-fft", "value": 90.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 132.0, 94.0, 95.0, 95.0, 138.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 150.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 74.0, 76.0, 75.0, 75.0, 79.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 74.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 88.0, 96.0, 85.0, 88.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [128.0, 123.0, 132.0, 118.0, 136.0, 120.0, 131.0, 128.0, 129.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 151.0, 154.0, 149.0, 137.0, 143.0, 159.0, 152.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 74.0, 72.0, 70.0, 72.0, 72.0, 73.0, 77.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1556.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.88174982911826], "unit": "score", "name": "Richards", "value": 206.5873039999999}, {"lowerIsBetter": false, "replicates": [192.23375624759709], "unit": "score", "name": "DeltaBlue", "value": 343.9458360000001}, {"lowerIsBetter": false, "replicates": [283.5270768358378], "unit": "score", "name": "Encrypt", "value": 938.8203869999999}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21093.714137148418}]} 04:34:35 INFO - RETURN: dromaeo_css: 6149.70 04:34:35 INFO - RETURN: kraken: 1556.20 04:34:35 INFO - RETURN: v8_7: 21093.71 04:34:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21093.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1556.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6149.70"}}} 04:34:35 INFO - Return code: 0 04:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:35 INFO - # TBPL SUCCESS # 04:34:35 INFO - Running post-action listener: _resource_record_post_action 04:34:35 INFO - Running post-run listener: _resource_record_post_run 04:34:37 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 519348224; Read time: 0; Write time: 591116 04:34:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240259072; Read time: 0; Write time: 368304 04:34:37 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 274862080; Read time: 0; Write time: 222120 04:34:37 INFO - Running post-run listener: _upload_blobber_files 04:34:37 INFO - Blob upload gear active. 04:34:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:37 INFO - Copying logs to upload dir... 04:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.456755 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-09 04:34:33.485359) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:33.488859) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009634 build_url: 'https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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-09 04:34:33.541241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:33.541625) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449656104.67888-935407118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:33.592028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:34:33.592577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:34:33.592921) ========= ========= Total master_lag: 0.27 =========