builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1449834633.89 results: success (0) buildid: 20151211023735 builduid: c14a532d01334282a9f8013f402d58b4 revision: 0dd42501bbe65904cf5a4f8b6e37408d60333045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.889995) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.890422) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.893658) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006392 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.956076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.956369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.062007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.062246) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004668 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.130388) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.130661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.131026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.131347) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 03:50:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2015-12-11 03:50:34 (21.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.319485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.319759) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.123730 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.454344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.454643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0dd42501bbe65904cf5a4f8b6e37408d60333045 --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 0dd42501bbe65904cf5a4f8b6e37408d60333045 --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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 03:50:34,572 truncating revision to first 12 chars 2015-12-11 03:50:34,572 Setting DEBUG logging. 2015-12-11 03:50:34,572 attempt 1/10 2015-12-11 03:50:34,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0dd42501bbe6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 03:50:34,820 unpacking tar archive at: mozilla-central-0dd42501bbe6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.026777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.027082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.035730) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.036043) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.036457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-11 03:50:35.036734) ========= /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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:35 INFO - MultiFileLogger online at 20151211 03:50:35 in /builds/slave/test 03:50:35 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 03:50:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:35 INFO - {'append_to_log': False, 03:50:35 INFO - 'base_work_dir': '/builds/slave/test', 03:50:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:50:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:35 INFO - 'branch': 'Firefox-Non-PGO', 03:50:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:35 INFO - 'config_files': ('talos/linux_config.py',), 03:50:35 INFO - 'default_actions': ('clobber', 03:50:35 INFO - 'read-buildbot-config', 03:50:35 INFO - 'download-and-extract', 03:50:35 INFO - 'populate-webroot', 03:50:35 INFO - 'create-virtualenv', 03:50:35 INFO - 'install', 03:50:35 INFO - 'run-tests'), 03:50:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:35 INFO - 'download_minidump_stackwalk': True, 03:50:35 INFO - 'download_symbols': 'ondemand', 03:50:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:35 INFO - 'installer_path': 'installer.exe', 03:50:35 INFO - 'log_level': 'info', 03:50:35 INFO - 'log_name': 'talos', 03:50:35 INFO - 'log_to_console': True, 03:50:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:35 INFO - 'opt_config_files': (), 03:50:35 INFO - 'pip_index': False, 03:50:35 INFO - 'sps_profile': False, 03:50:35 INFO - 'sps_profile_interval': 0, 03:50:35 INFO - 'suite': 'dromaeojs-e10s', 03:50:35 INFO - 'system_bits': '64', 03:50:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:35 INFO - 'title': 'talos-linux64-ix-003', 03:50:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:35 INFO - 'use_talos_json': True, 03:50:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:35 INFO - 'work_dir': 'build'} 03:50:35 INFO - ##### 03:50:35 INFO - ##### Running clobber step. 03:50:35 INFO - ##### 03:50:35 INFO - Running pre-action listener: _resource_record_pre_action 03:50:35 INFO - Running main action method: clobber 03:50:35 INFO - rmtree: /builds/slave/test/build 03:50:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:37 INFO - Running post-action listener: _resource_record_post_action 03:50:37 INFO - ##### 03:50:37 INFO - ##### Running read-buildbot-config step. 03:50:37 INFO - ##### 03:50:37 INFO - Running pre-action listener: _resource_record_pre_action 03:50:37 INFO - Running main action method: read_buildbot_config 03:50:37 INFO - Using buildbot properties: 03:50:37 INFO - { 03:50:37 INFO - "properties": { 03:50:37 INFO - "buildnumber": 115, 03:50:37 INFO - "product": "firefox", 03:50:37 INFO - "script_repo_revision": "production", 03:50:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:50:37 INFO - "repository": "", 03:50:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:50:37 INFO - "buildid": "20151211023735", 03:50:37 INFO - "slavename": "talos-linux64-ix-003", 03:50:37 INFO - "pgo_build": "False", 03:50:37 INFO - "basedir": "/builds/slave/test", 03:50:37 INFO - "project": "", 03:50:37 INFO - "platform": "ubuntu64_hw", 03:50:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:50:37 INFO - "slavebuilddir": "test", 03:50:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:50:37 INFO - "branch": "mozilla-central", 03:50:37 INFO - "repo_path": "mozilla-central", 03:50:37 INFO - "stage_platform": "linux64", 03:50:37 INFO - "builduid": "c14a532d01334282a9f8013f402d58b4", 03:50:37 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:37 INFO - }, 03:50:37 INFO - "sourcestamp": { 03:50:37 INFO - "repository": "", 03:50:37 INFO - "hasPatch": false, 03:50:37 INFO - "project": "", 03:50:37 INFO - "branch": "mozilla-central-linux64-talos", 03:50:37 INFO - "changes": [ 03:50:37 INFO - { 03:50:37 INFO - "category": null, 03:50:37 INFO - "files": [ 03:50:37 INFO - { 03:50:37 INFO - "url": null, 03:50:37 INFO - "name": "https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:50:37 INFO - } 03:50:37 INFO - ], 03:50:37 INFO - "repository": "", 03:50:37 INFO - "rev": "0dd42501bbe65904cf5a4f8b6e37408d60333045", 03:50:37 INFO - "who": "cbook@mozilla.com", 03:50:37 INFO - "when": 1449834570, 03:50:37 INFO - "number": 7326981, 03:50:37 INFO - "comments": "merge fx-team to mozilla-central a=merge", 03:50:37 INFO - "project": "", 03:50:37 INFO - "at": "Fri 11 Dec 2015 03:49:30", 03:50:37 INFO - "branch": "mozilla-central-linux64-talos", 03:50:37 INFO - "revlink": "", 03:50:37 INFO - "properties": [ 03:50:37 INFO - [ 03:50:37 INFO - "buildid", 03:50:37 INFO - "20151211023735", 03:50:37 INFO - "Change" 03:50:37 INFO - ], 03:50:37 INFO - [ 03:50:37 INFO - "builduid", 03:50:37 INFO - "c14a532d01334282a9f8013f402d58b4", 03:50:37 INFO - "Change" 03:50:37 INFO - ], 03:50:37 INFO - [ 03:50:37 INFO - "pgo_build", 03:50:37 INFO - "False", 03:50:37 INFO - "Change" 03:50:37 INFO - ] 03:50:37 INFO - ], 03:50:37 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:37 INFO - } 03:50:37 INFO - ], 03:50:37 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:37 INFO - } 03:50:37 INFO - } 03:50:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:50:37 INFO - Running post-action listener: _resource_record_post_action 03:50:37 INFO - ##### 03:50:37 INFO - ##### Running download-and-extract step. 03:50:37 INFO - ##### 03:50:37 INFO - Running pre-action listener: _resource_record_pre_action 03:50:37 INFO - Running main action method: download_and_extract 03:50:37 INFO - mkdir: /builds/slave/test/build/tests 03:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:37 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:50:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json 03:50:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json 03:50:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:50:38 INFO - Downloaded 1302 bytes. 03:50:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:50:38 INFO - Using the following test package requirements: 03:50:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'jsshell-linux-x86_64.zip'], 03:50:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:50:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:50:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:38 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:41 INFO - Downloaded 21866577 bytes. 03:50:41 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 03:50:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:41 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 03:50:42 INFO - Return code: 0 03:50:42 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 03:50: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')]} 03:50:42 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:48 INFO - Downloaded 21866577 bytes. 03:50:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:50:49 INFO - Return code: 0 03:50: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')]} 03:50:49 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:50 INFO - Downloaded 11132038 bytes. 03:50:50 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 03:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:50 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 03:50:51 INFO - Return code: 0 03:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:51 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/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 03:50:52 INFO - Downloaded 57728978 bytes. 03:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:52 INFO - mkdir: /builds/slave/test/properties 03:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:52 INFO - Contents: 03:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:52 INFO - Running post-action listener: _resource_record_post_action 03:50:52 INFO - Running post-action listener: set_extra_try_arguments 03:50:52 INFO - ##### 03:50:52 INFO - ##### Running populate-webroot step. 03:50:52 INFO - ##### 03:50:52 INFO - Running pre-action listener: _resource_record_pre_action 03:50:52 INFO - Running main action method: populate_webroot 03:50:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:52 INFO - '--tppagecycles', 03:50:52 INFO - '7'], 03:50:52 INFO - 'tests': ['tsvgm']}}, 03:50:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:50:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'tests': ['damp', 'tps']}, 03:50:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['damp', 'tps']}, 03:50:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:50:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:52 INFO - 'other': {'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'other_l64': {'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:50:52 INFO - 'ts_paint', 03:50:52 INFO - 'tpaint', 03:50:52 INFO - 'sessionrestore', 03:50:52 INFO - 'sessionrestore_no_auto_restore']}, 03:50:52 INFO - 'svgr': {'tests': ['tsvgx', 03:50:52 INFO - 'tsvgr_opacity', 03:50:52 INFO - 'tart', 03:50:52 INFO - 'tscrollx', 03:50:52 INFO - 'cart']}, 03:50:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['tsvgx', 03:50:52 INFO - 'tsvgr_opacity', 03:50:52 INFO - 'tart', 03:50:52 INFO - 'tscrollx', 03:50:52 INFO - 'cart']}, 03:50:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'tests': ['tp5o']}, 03:50:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'talos_options': ['--e10s'], 03:50:52 INFO - 'tests': ['tp5o']}, 03:50:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'talos_options': ['--xperf_path', 03:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:52 INFO - 'tests': ['tp5n']}, 03:50:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:52 INFO - 'talos_options': ['--e10s', 03:50:52 INFO - '--xperf_path', 03:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:52 INFO - 'tests': ['tp5n']}}, 03:50:52 INFO - 'talos.zip': {'path': '', 03:50:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:52 INFO - Running post-action listener: _resource_record_post_action 03:50:52 INFO - ##### 03:50:52 INFO - ##### Running create-virtualenv step. 03:50:52 INFO - ##### 03:50:52 INFO - Running pre-action listener: _resource_record_pre_action 03:50:52 INFO - Running main action method: create_virtualenv 03:50:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:52 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 03:50:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:52 INFO - Using real prefix '/usr' 03:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:55 INFO - Installing pip.................done. 03:50:55 INFO - Return code: 0 03:50:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:55 INFO - Using env: {'DISPLAY': ':0', 03:50:55 INFO - 'HOME': '/home/cltbld', 03:50:55 INFO - 'LANG': 'en_US.UTF-8', 03:50:55 INFO - 'LANGUAGE': 'en_US:en', 03:50:55 INFO - 'LOGNAME': 'cltbld', 03:50:55 INFO - 'MAIL': '/var/mail/cltbld', 03:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:55 INFO - 'MOZ_NO_REMOTE': '1', 03:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:55 INFO - 'NO_EM_RESTART': '1', 03:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:55 INFO - 'PWD': '/builds/slave/test', 03:50:55 INFO - 'SHELL': '/bin/bash', 03:50:55 INFO - 'SHLVL': '1', 03:50:55 INFO - 'TERM': 'linux', 03:50:55 INFO - 'TMOUT': '86400', 03:50:55 INFO - 'USER': 'cltbld', 03:50:55 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:55 INFO - '_': '/tools/buildbot/bin/python'} 03:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:55 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 03:50:55 INFO - Cleaning up... 03:50:55 INFO - Return code: 0 03:50:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:50:55 INFO - Using env: {'DISPLAY': ':0', 03:50:55 INFO - 'HOME': '/home/cltbld', 03:50:55 INFO - 'LANG': 'en_US.UTF-8', 03:50:55 INFO - 'LANGUAGE': 'en_US:en', 03:50:55 INFO - 'LOGNAME': 'cltbld', 03:50:55 INFO - 'MAIL': '/var/mail/cltbld', 03:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:55 INFO - 'MOZ_NO_REMOTE': '1', 03:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:55 INFO - 'NO_EM_RESTART': '1', 03:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:55 INFO - 'PWD': '/builds/slave/test', 03:50:55 INFO - 'SHELL': '/bin/bash', 03:50:55 INFO - 'SHLVL': '1', 03:50:55 INFO - 'TERM': 'linux', 03:50:55 INFO - 'TMOUT': '86400', 03:50:55 INFO - 'USER': 'cltbld', 03:50:55 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:55 INFO - '_': '/tools/buildbot/bin/python'} 03:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:55 INFO - Downloading/unpacking psutil>=0.7.1 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:50:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:57 INFO - Installing collected packages: psutil 03:50:57 INFO - Running setup.py install for psutil 03:50:57 INFO - building 'psutil._psutil_linux' extension 03:50:57 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 03:50:57 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 03:50:57 INFO - building 'psutil._psutil_posix' extension 03:50:57 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 03:50:57 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 03:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:57 INFO - Successfully installed psutil 03:50:57 INFO - Cleaning up... 03:50:57 INFO - Return code: 0 03:50:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:50:57 INFO - Using env: {'DISPLAY': ':0', 03:50:57 INFO - 'HOME': '/home/cltbld', 03:50:57 INFO - 'LANG': 'en_US.UTF-8', 03:50:57 INFO - 'LANGUAGE': 'en_US:en', 03:50:57 INFO - 'LOGNAME': 'cltbld', 03:50:57 INFO - 'MAIL': '/var/mail/cltbld', 03:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:57 INFO - 'MOZ_NO_REMOTE': '1', 03:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:57 INFO - 'NO_EM_RESTART': '1', 03:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:57 INFO - 'PWD': '/builds/slave/test', 03:50:57 INFO - 'SHELL': '/bin/bash', 03:50:57 INFO - 'SHLVL': '1', 03:50:57 INFO - 'TERM': 'linux', 03:50:57 INFO - 'TMOUT': '86400', 03:50:57 INFO - 'USER': 'cltbld', 03:50:57 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:57 INFO - '_': '/tools/buildbot/bin/python'} 03:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:50:59 INFO - Installing collected packages: mozsystemmonitor 03:50:59 INFO - Running setup.py install for mozsystemmonitor 03:51:00 INFO - Successfully installed mozsystemmonitor 03:51:00 INFO - Cleaning up... 03:51:00 INFO - Return code: 0 03:51:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:51:00 INFO - Using env: {'DISPLAY': ':0', 03:51:00 INFO - 'HOME': '/home/cltbld', 03:51:00 INFO - 'LANG': 'en_US.UTF-8', 03:51:00 INFO - 'LANGUAGE': 'en_US:en', 03:51:00 INFO - 'LOGNAME': 'cltbld', 03:51:00 INFO - 'MAIL': '/var/mail/cltbld', 03:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:00 INFO - 'MOZ_NO_REMOTE': '1', 03:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:00 INFO - 'NO_EM_RESTART': '1', 03:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:00 INFO - 'PWD': '/builds/slave/test', 03:51:00 INFO - 'SHELL': '/bin/bash', 03:51:00 INFO - 'SHLVL': '1', 03:51:00 INFO - 'TERM': 'linux', 03:51:00 INFO - 'TMOUT': '86400', 03:51:00 INFO - 'USER': 'cltbld', 03:51:00 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:00 INFO - '_': '/tools/buildbot/bin/python'} 03:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51: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 03:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:02 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 03:51:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - Downloading docopt-0.6.1.tar.gz 03:51:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:03 INFO - Running setup.py install for blobuploader 03:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:03 INFO - Running setup.py install for requests 03:51:03 INFO - Running setup.py install for docopt 03:51:04 INFO - Successfully installed blobuploader requests docopt 03:51:04 INFO - Cleaning up... 03:51:04 INFO - Return code: 0 03:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:04 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')]} 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 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')]} 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:04 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 03:51:04 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 03:51:04 INFO - Using env: {'DISPLAY': ':0', 03:51:04 INFO - 'HOME': '/home/cltbld', 03:51:04 INFO - 'LANG': 'en_US.UTF-8', 03:51:04 INFO - 'LANGUAGE': 'en_US:en', 03:51:04 INFO - 'LOGNAME': 'cltbld', 03:51:04 INFO - 'MAIL': '/var/mail/cltbld', 03:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:04 INFO - 'MOZ_NO_REMOTE': '1', 03:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:04 INFO - 'NO_EM_RESTART': '1', 03:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:04 INFO - 'PWD': '/builds/slave/test', 03:51:04 INFO - 'SHELL': '/bin/bash', 03:51:04 INFO - 'SHLVL': '1', 03:51:04 INFO - 'TERM': 'linux', 03:51:04 INFO - 'TMOUT': '86400', 03:51:04 INFO - 'USER': 'cltbld', 03:51:04 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:04 INFO - '_': '/tools/buildbot/bin/python'} 03:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:04 INFO - Running setup.py (path:/tmp/pip-wuKUco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:04 INFO - Running setup.py (path:/tmp/pip-ZnuYW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:04 INFO - Running setup.py (path:/tmp/pip-TiD1pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:04 INFO - Running setup.py (path:/tmp/pip-z4hUus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:04 INFO - Running setup.py (path:/tmp/pip-eTMUlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:04 INFO - Running setup.py (path:/tmp/pip-0qET63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:04 INFO - Running setup.py (path:/tmp/pip-JLRZOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:04 INFO - Running setup.py (path:/tmp/pip-kkHovk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:04 INFO - Running setup.py (path:/tmp/pip-VY90jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:04 INFO - Running setup.py (path:/tmp/pip-uzt926-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:04 INFO - Running setup.py (path:/tmp/pip-j0BP60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:05 INFO - Running setup.py (path:/tmp/pip-O6KZOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:05 INFO - Running setup.py (path:/tmp/pip-shn6jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:05 INFO - Running setup.py (path:/tmp/pip-q5cU0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:05 INFO - Running setup.py (path:/tmp/pip-A5Cyfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:05 INFO - Running setup.py (path:/tmp/pip-KBlGVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:05 INFO - Running setup.py (path:/tmp/pip-jOzv59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:05 INFO - Running setup.py install for manifestparser 03:51:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:05 INFO - Running setup.py install for mozcrash 03:51:05 INFO - Running setup.py install for mozdebug 03:51:05 INFO - Running setup.py install for mozdevice 03:51:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:05 INFO - Running setup.py install for mozfile 03:51:05 INFO - Running setup.py install for mozhttpd 03:51:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozinfo 03:51:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozInstall 03:51:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozleak 03:51:06 INFO - Running setup.py install for mozlog 03:51:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for moznetwork 03:51:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozprocess 03:51:06 INFO - Running setup.py install for mozprofile 03:51:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozrunner 03:51:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:06 INFO - Running setup.py install for mozscreenshot 03:51:07 INFO - Running setup.py install for moztest 03:51:07 INFO - Running setup.py install for mozversion 03:51:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:07 INFO - Cleaning up... 03:51:07 INFO - Return code: 0 03:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 03:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 03:51:07 INFO - Using env: {'DISPLAY': ':0', 03:51:07 INFO - 'HOME': '/home/cltbld', 03:51:07 INFO - 'LANG': 'en_US.UTF-8', 03:51:07 INFO - 'LANGUAGE': 'en_US:en', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MAIL': '/var/mail/cltbld', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SHLVL': '1', 03:51:07 INFO - 'TERM': 'linux', 03:51:07 INFO - 'TMOUT': '86400', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - '_': '/tools/buildbot/bin/python'} 03:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:07 INFO - Running setup.py (path:/tmp/pip-7UWs4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:07 INFO - Running setup.py (path:/tmp/pip-YKVjQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:07 INFO - Running setup.py (path:/tmp/pip-fI_b6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:07 INFO - Running setup.py (path:/tmp/pip-XGAVvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:07 INFO - Running setup.py (path:/tmp/pip-ZIXQOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:07 INFO - Running setup.py (path:/tmp/pip-p3HKQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:07 INFO - Running setup.py (path:/tmp/pip-NE1Lay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:07 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)) 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:07 INFO - Running setup.py (path:/tmp/pip-qMKRIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:08 INFO - Running setup.py (path:/tmp/pip-PPoSlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:08 INFO - Running setup.py (path:/tmp/pip-DLp4pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:08 INFO - Running setup.py (path:/tmp/pip-ciJNp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:08 INFO - Running setup.py (path:/tmp/pip-YsXmsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:08 INFO - Running setup.py (path:/tmp/pip-GWpqdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:08 INFO - Running setup.py (path:/tmp/pip-VuJCJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:08 INFO - Running setup.py (path:/tmp/pip-7_aGBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:08 INFO - Running setup.py (path:/tmp/pip-yF5AIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:08 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)) 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:08 INFO - Running setup.py (path:/tmp/pip-WEeHbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:08 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)) 03:51:08 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)) 03:51:08 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)) 03:51:08 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)) 03:51:08 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)) 03:51:08 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)) 03:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:10 INFO - Downloading blessings-1.5.1.tar.gz 03:51:10 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 03:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:10 INFO - Installing collected packages: blessings 03:51:10 INFO - Running setup.py install for blessings 03:51:10 INFO - Successfully installed blessings 03:51:10 INFO - Cleaning up... 03:51:10 INFO - Return code: 0 03:51:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:10 INFO - Reading from file tmpfile_stdout 03:51:10 INFO - Current package versions: 03:51:10 INFO - argparse == 1.2.1 03:51:10 INFO - blessings == 1.5.1 03:51:10 INFO - blobuploader == 1.2.4 03:51:10 INFO - docopt == 0.6.1 03:51:10 INFO - manifestparser == 1.1 03:51:10 INFO - mozInstall == 1.12 03:51:10 INFO - mozcrash == 0.16 03:51:10 INFO - mozdebug == 0.1 03:51:10 INFO - mozdevice == 0.47 03:51:10 INFO - mozfile == 1.2 03:51:10 INFO - mozhttpd == 0.7 03:51:10 INFO - mozinfo == 0.9 03:51:10 INFO - mozleak == 0.1 03:51:10 INFO - mozlog == 3.1 03:51:10 INFO - moznetwork == 0.27 03:51:10 INFO - mozprocess == 0.22 03:51:10 INFO - mozprofile == 0.27 03:51:10 INFO - mozrunner == 6.11 03:51:10 INFO - mozscreenshot == 0.1 03:51:10 INFO - mozsystemmonitor == 0.0 03:51:10 INFO - moztest == 0.7 03:51:10 INFO - mozversion == 1.4 03:51:10 INFO - psutil == 3.1.1 03:51:10 INFO - requests == 1.2.3 03:51:10 INFO - wsgiref == 0.1.2 03:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:10 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')]} 03:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:10 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')]} 03:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:10 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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:10 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 03:51:10 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 03:51:10 INFO - Using env: {'DISPLAY': ':0', 03:51:10 INFO - 'HOME': '/home/cltbld', 03:51:10 INFO - 'LANG': 'en_US.UTF-8', 03:51:10 INFO - 'LANGUAGE': 'en_US:en', 03:51:10 INFO - 'LOGNAME': 'cltbld', 03:51:10 INFO - 'MAIL': '/var/mail/cltbld', 03:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:10 INFO - 'MOZ_NO_REMOTE': '1', 03:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:10 INFO - 'NO_EM_RESTART': '1', 03:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:10 INFO - 'PWD': '/builds/slave/test', 03:51:10 INFO - 'SHELL': '/bin/bash', 03:51:10 INFO - 'SHLVL': '1', 03:51:10 INFO - 'TERM': 'linux', 03:51:10 INFO - 'TMOUT': '86400', 03:51:10 INFO - 'USER': 'cltbld', 03:51:10 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:10 INFO - '_': '/tools/buildbot/bin/python'} 03:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 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)) 03:51:11 INFO - Cleaning up... 03:51:11 INFO - Return code: 0 03:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:11 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')]} 03:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:11 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')]} 03:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:11 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 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:11 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 03:51:11 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 03:51:11 INFO - Using env: {'DISPLAY': ':0', 03:51:11 INFO - 'HOME': '/home/cltbld', 03:51:11 INFO - 'LANG': 'en_US.UTF-8', 03:51:11 INFO - 'LANGUAGE': 'en_US:en', 03:51:11 INFO - 'LOGNAME': 'cltbld', 03:51:11 INFO - 'MAIL': '/var/mail/cltbld', 03:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:11 INFO - 'MOZ_NO_REMOTE': '1', 03:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:11 INFO - 'NO_EM_RESTART': '1', 03:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:11 INFO - 'PWD': '/builds/slave/test', 03:51:11 INFO - 'SHELL': '/bin/bash', 03:51:11 INFO - 'SHLVL': '1', 03:51:11 INFO - 'TERM': 'linux', 03:51:11 INFO - 'TMOUT': '86400', 03:51:11 INFO - 'USER': 'cltbld', 03:51:11 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:11 INFO - '_': '/tools/buildbot/bin/python'} 03:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:11 INFO - Downloading/unpacking jsonschema 03:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:12 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 03:51:12 INFO - Downloading/unpacking functools32 (from jsonschema) 03:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:13 INFO - warning: no files found matching '*.txt' 03:51:13 INFO - no previously-included directories found matching 'build' 03:51:13 INFO - no previously-included directories found matching 'dist' 03:51:13 INFO - no previously-included directories found matching '.git*' 03:51:13 INFO - Installing collected packages: jsonschema, functools32 03:51:13 INFO - Running setup.py install for functools32 03:51:13 INFO - warning: no files found matching '*.txt' 03:51:13 INFO - no previously-included directories found matching 'build' 03:51:13 INFO - no previously-included directories found matching 'dist' 03:51:13 INFO - no previously-included directories found matching '.git*' 03:51:13 INFO - Successfully installed jsonschema functools32 03:51:13 INFO - Cleaning up... 03:51:13 INFO - Return code: 0 03:51:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1672deaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, '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': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', '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 03:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:51:13 INFO - Using env: {'DISPLAY': ':0', 03:51:13 INFO - 'HOME': '/home/cltbld', 03:51:13 INFO - 'LANG': 'en_US.UTF-8', 03:51:13 INFO - 'LANGUAGE': 'en_US:en', 03:51:13 INFO - 'LOGNAME': 'cltbld', 03:51:13 INFO - 'MAIL': '/var/mail/cltbld', 03:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:13 INFO - 'MOZ_NO_REMOTE': '1', 03:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:13 INFO - 'NO_EM_RESTART': '1', 03:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:13 INFO - 'PWD': '/builds/slave/test', 03:51:13 INFO - 'SHELL': '/bin/bash', 03:51:13 INFO - 'SHLVL': '1', 03:51:13 INFO - 'TERM': 'linux', 03:51:13 INFO - 'TMOUT': '86400', 03:51:13 INFO - 'USER': 'cltbld', 03:51:13 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:13 INFO - '_': '/tools/buildbot/bin/python'} 03:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:13 INFO - Downloading/unpacking flake8 03:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:51:15 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 03:51:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:51:15 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 03:51:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 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 03:51:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:15 INFO - no previously-included directories found matching 'docs/_build' 03:51:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:51:16 INFO - Running setup.py install for pep8 03:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:16 INFO - no previously-included directories found matching 'docs/_build' 03:51:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:51:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:51:16 INFO - Cleaning up... 03:51:16 INFO - Return code: 0 03:51:16 INFO - Running post-action listener: _resource_record_post_action 03:51:16 INFO - Running post-action listener: _start_resource_monitoring 03:51:16 INFO - Starting resource monitoring. 03:51:16 INFO - ##### 03:51:16 INFO - ##### Running install step. 03:51:16 INFO - ##### 03:51:16 INFO - Running pre-action listener: _resource_record_pre_action 03:51:16 INFO - Running main action method: install 03:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:16 INFO - Reading from file tmpfile_stdout 03:51:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:16 INFO - Reading from file tmpfile_stdout 03:51:16 INFO - Output received: 03:51:16 INFO - Usage: mozinstall [options] installer 03:51:16 INFO - Options: 03:51:16 INFO - -h, --help show this help message and exit 03:51:16 INFO - -d DEST, --destination=DEST 03:51:16 INFO - Directory to install application into. [default: 03:51:16 INFO - "/builds/slave/test"] 03:51:16 INFO - --app=APP Application being installed. [default: firefox] 03:51:16 INFO - mkdir: /builds/slave/test/build/application 03:51:16 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'] 03:51:16 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 03:51:31 INFO - Reading from file tmpfile_stdout 03:51:31 INFO - Output received: 03:51:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:31 INFO - Running post-action listener: _resource_record_post_action 03:51:31 INFO - ##### 03:51:31 INFO - ##### Running run-tests step. 03:51:31 INFO - ##### 03:51:31 INFO - Running pre-action listener: _resource_record_pre_action 03:51:31 INFO - Running main action method: run_tests 03:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:31 INFO - Python 2.7.3 03:51:31 INFO - Return code: 0 03:51:31 INFO - grabbing minidump binary from tooltool 03:51: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')]} 03:51:31 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 0x248d0b0>, '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 0x248dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:31 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 03:51:31 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 03:51:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:31 INFO - Return code: 0 03:51:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:51:32 INFO - Return code: 0 03:51:32 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/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] in /builds/slave/test/build 03:51:32 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/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost 03:51:32 INFO - Using env: {'DISPLAY': ':0', 03:51:32 INFO - 'HOME': '/home/cltbld', 03:51:32 INFO - 'LANG': 'en_US.UTF-8', 03:51:32 INFO - 'LANGUAGE': 'en_US:en', 03:51:32 INFO - 'LOGNAME': 'cltbld', 03:51:32 INFO - 'MAIL': '/var/mail/cltbld', 03:51:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:32 INFO - 'MOZ_NO_REMOTE': '1', 03:51:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:32 INFO - 'NO_EM_RESTART': '1', 03:51:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:32 INFO - 'PWD': '/builds/slave/test', 03:51:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:32 INFO - 'SHELL': '/bin/bash', 03:51:32 INFO - 'SHLVL': '1', 03:51:32 INFO - 'TERM': 'linux', 03:51:32 INFO - 'TMOUT': '86400', 03:51:32 INFO - 'USER': 'cltbld', 03:51:32 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449833387.411098-1708323376', 03:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:32 INFO - '_': '/tools/buildbot/bin/python'} 03:51:32 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/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] with output_timeout 3600 03:51:32 INFO - mozversion INFO | application_buildid: 20151211023735 03:51:32 INFO - mozversion INFO | application_changeset: 0dd42501bbe65904cf5a4f8b6e37408d60333045 03:51:32 INFO - mozversion INFO | application_display_name: Nightly 03:51:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:32 INFO - mozversion INFO | application_name: Firefox 03:51:32 INFO - mozversion INFO | application_remotingname: firefox 03:51:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:51:32 INFO - mozversion INFO | application_vendor: Mozilla 03:51:32 INFO - mozversion INFO | application_version: 45.0a1 03:51:32 INFO - mozversion INFO | platform_buildid: 20151211023735 03:51:32 INFO - mozversion INFO | platform_changeset: 0dd42501bbe65904cf5a4f8b6e37408d60333045 03:51:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:51:32 INFO - mozversion INFO | platform_version: 45.0a1 03:51:32 INFO - 2015-12-11 03:51:32,221 DEBUG : using testdate: 1449834692 03:51:32 INFO - 2015-12-11 03:51:32,221 DEBUG : actual date: 1449834692 03:51:33 INFO - 2015-12-11 03:51:33,267 INFO : starting webserver on 'localhost:49444' 03:51:33 INFO - 2015-12-11 03:51:33,268 INFO : Starting test suite talos-linux64-ix-003.e 03:51:33 INFO - 2015-12-11 03:51:33,268 INFO : Starting test dromaeo_css 03:51:33 INFO - 2015-12-11 03:51:33,268 DEBUG : operating with platform_type : linux_ 03:51:33 INFO - 2015-12-11 03:51:33,269 INFO : Initialising browser for dromaeo_css test... 03:51:33 INFO - 2015-12-11 03:51:33,280 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp45jWmR/profile http://localhost:49444/getInfo.html 03:51:39 INFO - 2015-12-11 03:51:39,090 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:51:39 INFO - 2015-12-11 03:51:39,090 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:51:39 INFO - 2015-12-11 03:51:39,090 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:51:39 INFO - 2015-12-11 03:51:39,090 DEBUG : BROWSER_OUTPUT: __metrics 03:51:39 INFO - 2015-12-11 03:51:39,226 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] 03:51:40 INFO - 2015-12-11 03:51:40,172 INFO : Browser initialized. 03:51:40 INFO - 2015-12-11 03:51:40,172 INFO : Running cycle 1/1 for dromaeo_css test... 03:51:40 INFO - 2015-12-11 03:51:40,172 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp45jWmR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:51:52 INFO - 2015-12-11 03:51:52,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 143290368 03:51:52 INFO - 2015-12-11 03:51:52,168 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-12-11 03:52:41,796 DEBUG : BROWSER_OUTPUT: 1449834761793 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] 03:54:53 INFO - 2015-12-11 03:54:53,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49444/tests/dromaeo/cssquery-ext.html) 03:54:54 INFO - 2015-12-11 03:54:54,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 147562496 03:54:54 INFO - 2015-12-11 03:54:54,731 DEBUG : BROWSER_OUTPUT: 03:57:56 INFO - 2015-12-11 03:57:56,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-ext.html (next: http://localhost:49444/tests/dromaeo/cssquery-jquery.html) 03:57:57 INFO - 2015-12-11 03:57:57,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 144576512 03:57:57 INFO - 2015-12-11 03:57:57,426 DEBUG : BROWSER_OUTPUT: 04:00:59 INFO - 2015-12-11 04:00:59,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49444/tests/dromaeo/cssquery-mootools.html) 04:00:59 INFO - 2015-12-11 04:00:59,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 144998400 04:00:59 INFO - 2015-12-11 04:00:59,797 DEBUG : BROWSER_OUTPUT: 04:04:01 INFO - 2015-12-11 04:04:01,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49444/tests/dromaeo/cssquery-prototype.html) 04:04:02 INFO - 2015-12-11 04:04:02,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 144007168 04:04:02 INFO - 2015-12-11 04:04:02,170 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2015-12-11 04:07:04,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49444/tests/dromaeo/cssquery-yui.html) 04:07:05 INFO - 2015-12-11 04:07:05,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 144732160 04:07:05 INFO - 2015-12-11 04:07:05,352 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-yui.html (next: http://localhost:49444/tests/dromaeo/cssquery-dojo.html) 04:10:07 INFO - 2015-12-11 04:10:07,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 147816448 04:10:07 INFO - 2015-12-11 04:10:07,961 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,961 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:10:07 INFO - 2015-12-11 04:10:07,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:10:07 INFO - 2015-12-11 04:10:07,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:10:07 INFO - 2015-12-11 04:10:07,961 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:10:07 INFO - 2015-12-11 04:10:07,965 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2667.053196115379;2703.675558932928;2726.822756520826;2745.9725402745967;2756.2558109310485;4479.104179164164;4742.383490146281;4785.18651829189;4811.206150985087;4827.396575428072;4634.490206077328;4653.092646933849;4667.929981050287;4780.832670856521;4792.592629626477;4335.739855608658;4417.757023363713;4435.622972047372;4444.577765112309;4490.865274041784;4258.425112609789;4387.62705170061;4436.64506839452;4448.199324121673;4467.396901418316;4173.686973477002;4248.1078973415315;4253.064325848309;4265.957340426618;4277.6791740619265;4404.823807047715;4429.579189976947;4431.911361772746;4443.600075993176;4486.057927835159;4193.685473589462;4264.019275566637;4293.656507479394;4399.472063352387;4444.511103778582;4571.3600095986585;4626.86119416418;4646.95353046472;4715.669903106749;4761.2382018876815;5053.8736531587;5066.113430149746;5081.466446023152;5083.466236045199;5127.025865085622;4910.631702622282;4958.776855041496;5029.698218106889;5108.106081435771;5113.693178409308;4723.7874295656775;4744.027474367746;4746.952530474651;4758.048390321949;4798.616110711135;5222.503862133091;5246.291750613695;5248.895022099537;5250.842474725764;5301.284326615934;4885.780139893714;4922.852314430573;4977.178765503651;4979.178435558165;5003.174476211457;5081.110805609003;5100.872478188001;5112.667676601009;5119.462456442095;5182.766775495112;4839.249916262985;5053.84838454847;5066.417362003343;5087.389513258433;5091.3381260436645;4945.826896058621;4996.15065438869;5030.949690503121;5048.495150484922;5073.720945348041;4182.623563879265;4230.048239146229;4233.068724880522;4265;4283;3556.3065202285825;3645.052286405554;3693.556773187181;3699.352613292663;3745.8127093645207;4244.342126970325;4335.82656693735;4338.392625032498;4344.587264209958;4375.606195442426;5111.386633603991;5121.948780512222;5163.432022477525;5166.974165129151;5171.4311425743135;4224.4930608327195;4303.63419109373;4349.521552629209;4424.048829501608;4459.219636563588;4471.8434854779925;4479.395281637003;4527.230370836965;4532.1842068427995;4593.19619066662;4769;4795.616350692006;4799;4805.255185446262;4832.420109586872;4906.63200259989;4977.054359671651;4990.3762029746285;5084;5115.820946266863;4824.107540105092;4829.782659780389;4839;4842.661013729146;4857.441394239708;5012.022655582126;5051.87370315745;5052.1663925451885;5062.265971434195;5094.414142373526;4876.463589005278;4987.750612469289;5010.3737032870895;5063.392392912727;5098.362704661918;4896.461389247252;4949.30709700635;4956.281339205867;4957.380327459067;5005.399352077774;4787.904241915212;4947.925781113214;4953.157963146202;4958.256261560795;5011.749412529286;4774.3315935769715;4782.282657601388;4784.784684689128;4816.638752093677;4847.200211965127;4944.431390390007;4965.677230979974;5002.749862506933;5009.273655319886;5066.746662666926;4660.836870709509;4767.308740232716;4904.485029071896;4920.434150072788;4956.355673762388 04:10:07 INFO - 2015-12-11 04:10:07,965 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.7604192176403;567.8438429431908;570.5635189080355;572.4447286132452;582.7202942587556;36667.4499882502;37538.43692344617;37811.621883781154;37861.81069094654;37870.62129378705;41946.161076778444;42971.14057718844;43006.56993430065;43048.78475607617;43108.13783724324;7824.021997250358;7892.802679933019;7962.1639727828615;7978.561179135145;7981.161977992314;7855.41084418668;7980.281774640282;7985.480943738638;7985.5208687478935;8006.159353267911;7936.642851071716;7952.3638108951145;7956.164602716718;8025.277725004748;8032.3172530335;7917.56453395063;7962.442629015971;7968.521888686697;7982.640781164832;7992.720254791113;7824.921750782476;7869.881951770728;7895.447318687694;7941;7943;38162.23675526502;38549.80725096357;38640;38646;38707;2397.2448678666165;2641.984537603535;2742.314421394651;2759.4205216904475;3052.0691189187287;26581.734182658118;26657;26670.86664566684;26872;26883.19350419471;3334.249793796401;3427.674370934757;3484.407650699387;3520.366334059868;3573.7855728656364;214692;218686.90656546774;220862;222282;222654;48794.756026220355;49122.26316605254;56619.71690141605;56641.43358566362;61860;56449.43550564524;56593.71703141541;56820.43179568234;56828.43171568314;57090;13546.593602191753;13761.243131627656;13770.862291376958;13813.240271784947;13821.308934553232;9614;9679.758006049906;9722.805543889224;9723.513824308757;9725.367851089799;19078.90460547716;19269.036548172535;19356.70964935527;19421.32025379105;19475.610487790163;7715.151333353327;8007.1592482788465;8021.518708877369;8096;8122.106568277485;842.3093063687717;946.3801210207325;987.4766373821886;1023.6914273268266;1037.7457522906784;26116.477670446864;26537.601935970975;26776;26970.460590788076;27003.459930801273;903.4443817052465;955.9235261179089;993.3146129170849;1111.294328101645;1123.5505797680994;12756.61730148097;13456.932715336361;15944.123073231083;16123.193840307938;16202.513924582281;303747;311764;312369;312385;313052;49306.75346623316;50018.49981500211;50021.749891250314;50031;50114;1204.5362535423749;1209.2683926224684;1225.0934308611563;1225.2587184753274;1340.9674550595987;27631.861840690668;27933;28212.858935706012;30252.84873575706;30597.887457655037;43657.56342436535;44300.556994429644;44322.3351649732;44366.556334436245;44565.777171113936;242423;243594;244956;245391;245524;39016.41475377928;42445;43009;43845;43864.12271754483;39017;39322.410163846995;39604.2079158421;40227.3965890506;40490;33565.496517551765;34383.14042148966;34456.13859653529;34527.82736086303;34816.30367392689;34113.14717132092;34199.829000854836;34298;34614;34791;33743.66256337504;33885.32229355448;33904.83047584746;38661.80669096637;39353;29185.41629167447;30229.395412092075;31075;31146.37707245797;31201.223107132373;24185.63721544143;24278.87860560686;24292.878535607208;24348.443413441335;24387.14644987417 04:10:07 INFO - 2015-12-11 04:10:07,966 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.59350373056077;341.81200339813114;345.16814477110154;345.4938515075415;348.4842433198866;12962.870371296296;14832.555023349303;15017.249137543135;15896.443624473146;16674.833251667478;10455.424951627658;10842.620508282213;15174.241287935587;15635.765463518057;15662.295196716146;4044.1084624493483;4493.213687604664;4606.700564463299;4724;4751.5010923853015;4687.250039993602;4707.811687532495;4731.9763401182945;4733.242681171013;4739.123262196487;4716.882077948062;4721.716696998174;4952.702837829742;5218.895622087556;5230.163173892178;5098.59211263098;5117.897642047157;5119.257707632372;5128.102582048145;5291.576673866081;5268.262443257947;5273.920891186635;5331.680099194022;5339.145736682151;5350.732463376816;11548.133889958286;11692.123090768226;15774.29015694285;18558.907205463885;18658.06709664525;1773.494554052089;1808.2315016118098;1827.2964908510319;1840.0615686000103;1876.1557299215272;9110.362274640778;9154.633814647406;9268.25853931684;9330.300227482965;9369.578368973413;1754.1141723429587;1765.841074303319;1787.9642407151784;1819.3541292841117;1858.135966775456;53681.731591342184;54653.72673136609;57979.710101449644;58055.419445805426;58592.414075859546;9660.855087173699;9810.558524866397;9930.404175749478;9946.602135914482;9970.351927124859;12546.247225166519;12555.372231388394;12568.183068100545;12594.496220151092;12670.80993785094;6659.6670166491485;6689.230738465041;6711.731530738716;6944.826379340456;6957.373836354753;6478.352164783484;6597.373249541286;6632.767853125118;6637.037629543689;6660.500462465335;4186.937195942063;4190.790460476964;4191.350340697197;4194.098268872146;4245.384419259251;1780.3590707345345;1785.3572713823014;1793.1482545790645;1797.8471829894345;1799.7570328005813;713.9393151582174;890.225503811688;895.7223260789176;899.6851102114339;918.3479729392072;14541.27293635314;14586.781198281822;14913.105213686997;15068;15238.847611523965;791.6764296788942;812.8618134917078;829.618375547255;839.1105428245957;855.7689423855525;8655.956720216485;9007.964084130277;9011.414258073204;9205.493697846683;9283.814323713488;490660;501414;505851;506458;509277;69295.3070469299;72031;72497.6375118121;72917.6354118226;74330.62834685792;1058.571278632155;1075.9515821787882;1100.2353364411817;1127.0589058136547;1132.2413982631492;13867.167969921837;13975.231362275172;14043.36804843764;14064.859351406763;14074.225917574631;32987.505187421724;33574.49638255477;33770.324593508485;33836;34638;43600.56399435965;44243.77878110589;44821;44914;47257;8905.332100092648;9020.233280170996;9063.728088157366;9084.818303633758;9108.453492790453;10412.375257484575;12993.610191694264;16089;16151.838481615034;16179.43371981975;13281.535146269835;13457.394417251444;13768.96732745028;13822;14082.084664496775;12997.15518491295;13090.280034598189;13194.868051319363;13322.933385333012;13850.16898986064;12989.28558929268;13244.668883277995;13272.203667779579;13284.53504127351;14358.56924292273;8566.229039386486;8841.027486976298;8944.37389382737;9056.592453339746;9068.365214434927;9407.905920940702;9567.473788941676;12255.264684118982;13353.265570393722;13718.65703357424 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1473.3664524254566;1661.950141495755;1694.466243133413;1725.1805392438594;1750.9387171448998;6709.094272273242;6941.479389045817;7092.148942126945;7134.821629459266;7147.642617869105;7110.253423390547;7162.749303774369;7244.96377518113;7245.058142441475;7263.0921134858145;2067.1834625323027;2103.9368818935454;2105.0632468551503;2106.0207003743258;2109.8839563823985;2123.936281911545;2128.7871212878745;2154.4183070571016;2168.186929901287;2168.3928500019942;1793.4081753021537;1819.945401637953;2022.5752591955634;2032.4613977296028;2062.6287268291703;2025.959480810383;2032.0550943811124;2035.1350675962656;2037.2258541754186;2039.867408618435;1984.2559040359865;2030.2893987104544;2089.1643342662906;2089.226986015184;2092.110852887532;6970.442364610819;6979.89530157048;7009.334113259232;7009.7897063088185;7026.683799228996;4224.429701990222;4296.033392486696;4297.247981603207;4313.590208930146;4327.675424343187;2632.118240389472;2646.7088620251757;2678.6116013178175;2684.315499547603;2692.232713676593;882.056199866137;890.3900827932887;894.727108231989;915.3501014279869;930.3115694386173;9342.766430839216;9445.952770236105;9478.715638530855;9489.766330377075;9496.002919693401;3721.9441708373856;3788.4696142539515;3838.5201849768778;3842.058695619591;3864.942025869614;7761.8447631047065;7762.107357653829;7763.417743669134;7772.455928085093;7774;4190;4198.286291330481;4204.075103477291;4207.684423668237;4215.662746980234;3871.399933010388;3881.223755248905;3883.262180185756;3900.1029763154634;3907.96092039076;3130.1861516005547;3155.3216058547523;3158.9052328430184;3165.3352795913115;3167.6357218919657;909.3180114913814;909.736176508805;914.0539541574439;914.5153068873508;914.7438717159206;902.5757893789909;902.6479672927563;927.3415874729018;968.970930872075;1185.6324539392815;6659.234188068434;6670.966645166744;6734.494912881553;6763.5941843489545;6765.2896445872475;1038.8857225705167;1044.498640652491;1048.984265236022;1056.1075890872355;1079.0827796373178;5324.440933701905;5363.865903352369;5366.570674346043;5368.597355198376;5424.077906755861;8197;8355.498670079814;8533.829323413496;8604.182602652738;8672.523011234443;8460.196281353261;8482.872756908651;8539.231469167804;8542.487450752975;8565.528895910784;6266.717997690206;6652.268250492442;6743.561668491532;6747.966260168668;6768.680107379014;6654.234763002123;6770.4922130839395;6809.625470598967;6825.146856642919;6838.452923766186;7568.962155189409;7702.653380597999;7703.499272547267;7781.2218778124;7815.726449574237;7642.197569255371;7887.605619719106;8088.9595552021865;8101.473404228706;8140.918590814016;6179.073139029181;6219.129321894848;6270.686465676789;6299.307076221704;6314.116023756769;6844.93155068443;7005.614691192033;7055.153381594037;7063.611501367474;7078.362947334765;6534.346565343428;6568.408843204134;6631.0716499689115;6673.232578253563;6709.563878347892;5212.374515058065;6026.246719160105;6114.663693496723;6167;6265.655388953652;6322.304546499973;6325.462335701517;6326.493880489642;6372.299047104908;6387.968060159669;6021;6040.939590604038;6045.697715114315;6072.483838873745;6076.90884636722;5897.144913987534;6027.668478233739;6027.849303767265;6040.546958978006;6045.667488288186 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.12275934282366;321.6012144940275;325.85825166052786;328.804361404964;330.73541167066355;5496.972515137429;5526.640768350065;5584.664920104791;5597.776088956447;5690.089585666295;5519.420460851613;5548.944510554893;5559.833205003846;5567.081431563787;5577.581681373893;4269.210196113713;4282.100758840647;4286.5284818669925;4291.356296555526;4292.699511034229;4276.786160691969;4286.978565107186;4305.22505948929;4310.094880075172;4313.1158112587;4173.707840451169;4227.6617870570435;4253.702240843142;4255.914881702364;4262.531121576624;4246.532881383046;4247.384129301265;4257.403963445105;4264.23243816113;4276.187524370391;3708.0173753955223;3714.53568303962;3714.572824125233;3715.2198038411966;3734.2158146789207;5354.43778403266;5381.354237491487;5381.7578208980685;5387.1111266640955;5399.919001214985;4747.572718455321;4916.680415772963;4917.852464426073;4919.581835543983;4933.1860243059855;5653.123765816305;5817.534597232254;5819.447152520504;5826.446487583673;5831.970840145815;4012.538558065831;4013.2976729072298;4019.1760689058965;4022.4971878515184;4025.7383270087644;6044.939550604482;6120.051392034242;6122.4183702548635;6131.3868613138775;6135.631862088289;4022.9195416091516;4088.448059511987;4095.9590404096175;4113.465249517603;4117.97941010299;4174.624283814472;4176.686748493875;4177.060161463646;4206.074663574009;4245.469316335458;4861.683990540603;4867.537583929521;4870.780814863339;4876.122297986326;4888;5845.941540584539;5847.795327163529;5852.7658893643775;5862.824115276549;5869.882602347929;1441.1929319581068;1466.5160497035952;1467.8238611366492;1468.6034770611875;1472.6097584140211;998.6804222648828;1012.3498697123641;1021.8467229915424;1028.4703377760459;1030.9690709278734;5009.524095210949;5051.974740126276;5056.64603477753;5066.923996140061;5075.822346217865;6008.969955150196;6009.849753756103;6053.182820319201;6053.485453736482;6072.089186621954;4992.375953005874;5028.79884804611;5052.1663925451885;5055.51972562606;5067.239914012854;3215.5208604042405;3224.790388624732;3262.13553408347;3288.9804160709778;3292.3415316936707;5649.152627105967;5656.717164141776;5679.77280908759;5681.602287839812;5691;6219.067139929047;6233.407826256498;6233.470155036873;6245.156903817927;6248.156498872594;5620.5503559715125;5688.544916406678;5689.374168841424;5700.657960522382;5720.2849643794525;6086.178365920544;6110.908336375047;6126.938730612636;6126.938730612816;6129;5925.866687992233;5949.3455719871645;5970.850728731642;5983.55123365758;5987.2815262168815;5606.523445507178;5701.087825947829;5718.8848174605555;5726.0838265877255;5737.741801618854;4162.812673429642;4213.789310534522;4216.388623649615;4220.89447763796;4225.640820530167;6085.756569737338;6120.816375508742;6121.877562448815;6131.448169664752;6138.785142519991;5855.151003104611;5860.589758716849;5873;5878.764849405976;5894.616849904743;5701.857453563694;5858.736356864037;5869.383714709894;5869.882602347844;5882.794102206402;5739.196512488338;5746.9712651436475;5749;5755.165501002415;5758.1650660654805;5905.43898329658;5907.734151963086;5911.970440147944;5916.083007133901;5921.2006379138265;5615.444972537567;5751.424857514216;5758.1650660654805;5759.94240057594;5763.942360576509 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.7400457848906;794.4756460735914;806.1535387842764;806.548332933557;833.7957200485882;12038.81941770873;12313.322767247797;13946.86053139467;14066.578002659911;14175.078619889726;12371.814422783666;12526.373681315921;12548;12549.247045177295;12609.054320925921;807.3420162567503;813.6704634622987;818.4639061414783;819.1358117186365;821.0270829067574;770.7572114783853;815.2703330519182;831.1397703377006;832.0473058348218;835.8955130608674;841.3017195727532;846.196113691992;846.9745907622781;851.9062903080656;855.341387131908;841.4026041510535;846.0777752250046;846.4667259626458;848.2492993700557;849.8725191221336;621.9004959206505;624.2103738770459;625.0624063904144;626.1546911669255;626.4268194601934;12638.49446022158;12758.04314676403;12777.488900443972;12782.233066015975;12791.48834046637;10777.83833242502;10870.61952831655;11283.66149015531;11482.540698372055;12094;9047.411918225294;9234.215091717213;9244.197381510608;9259.166674999215;9277.35058545902;3181.522771584258;3210.2776875203126;3240.708336249725;3265.6081270247487;3292.0453068610072;40835.120663537215;41143.588564114274;41239.38140927888;41385.586144138775;41617;9413.952930235306;9596.840710840004;9678.854817177747;9688.70933871971;9759.609615615296;16238.269277882524;16248.918755406385;16317.265723042492;16383.09892955875;16404.6719065618;6104.236970378703;6166.568340216142;6239.532035097386;6286.591371560834;6393.840153996094;3686.8525258989876;3709.3694072007825;3715.071232191952;3724.9068773280883;3729.9627003730157;2755.3662657588866;2782.5130602144545;2786.651668541432;2787.3449739311245;2787.9860600696866;452.19509273493236;454.6181207785476;460.7350773305296;460.8962983328791;466.126013724267;431.51454613559747;431.92225399428406;458.95181005994556;460.9331646911246;535.5394360849666;6597.47220222381;6890.621015844076;7054.417228636009;7095;7202.279772022755;449.36414972813105;486.46488862251243;512.5259135299833;544.7793643574358;549.3599956051156;3247.967520324814;3474.42671959129;3565.982170089133;3582.0686621478603;3883.126296583246;47889;47941.04117917622;47948.760256199195;53358.199627005626;55700.16449753257;45915.311270330974;46652.3002154968;46849;46908.76545617318;47287.290690638976;42705;43445.13109737851;44357.556424435985;44572.55427445749;44635.33047004297;7407.407407407502;7521.05986751656;7639.236076392316;7692.7692169235015;7909.129995700353;29605.25986850346;29891.402171956874;30141.397172056873;30217.848910755307;30546.694533054386;38954.2209155821;39207.80396098001;39322.410163846995;39772;40324.3951340736;10566.682999510027;10625.840612390975;10691.358518488916;10723.839142413026;10815.945920270347;11440.942795286302;11535.134864885335;11600.361980091177;11602.88397116018;11682;9386.15524602789;9542.379745316532;10681.092107170978;10682.946585267024;10717.9464102679;10608.257421980696;10915;11144.2199046066;11311.547538098714;11411.54353825871;10103.7474063149;10274.794504110025;10490.580376784843;10496.265261431627;10500.159987200852;9254.629814807333;9424.434533927712;9466;9570.282228832726;9593.472359020041;8031.437799353989;8358.289545388467;8428.241458268785;8607.784805379915;8712.433691810265 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:10:07 INFO - 2015-12-11 04:10:07,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835807960__endTimestamp 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4678.05 Median:4805.26 stddev:493.18 (10.3%) stddev-sans-first:468.78 04:10:07 INFO - 2015-12-11 04:10:07,971 DEBUG : BROWSER_OUTPUT: Values: 2667.1 2703.7 2726.8 2746.0 2756.3 4479.1 4742.4 4785.2 4811.2 4827.4 4634.5 4653.1 4667.9 4780.8 4792.6 4335.7 4417.8 4435.6 4444.6 4490.9 4258.4 4387.6 4436.6 4448.2 4467.4 4173.7 4248.1 4253.1 4266.0 4277.7 4404.8 4429.6 4431.9 4443.6 4486.1 4193.7 4264.0 4293.7 4399.5 4444.5 4571.4 4626.9 4647.0 4715.7 4761.2 5053.9 5066.1 5081.5 5083.5 5127.0 4910.6 4958.8 5029.7 5108.1 5113.7 4723.8 4744.0 4747.0 4758.0 4798.6 5222.5 5246.3 5248.9 5250.8 5301.3 4885.8 4922.9 4977.2 4979.2 5003.2 5081.1 5100.9 5112.7 5119.5 5182.8 4839.2 5053.8 5066.4 5087.4 5091.3 4945.8 4996.2 5030.9 5048.5 5073.7 4182.6 4230.0 4233.1 4265.0 4283.0 3556.3 3645.1 3693.6 3699.4 3745.8 4244.3 4335.8 4338.4 4344.6 4375.6 5111.4 5121.9 5163.4 5167.0 5171.4 4224.5 4303.6 4349.5 4424.0 4459.2 4471.8 4479.4 4527.2 4532.2 4593.2 4769.0 4795.6 4799.0 4805.3 4832.4 4906.6 4977.1 4990.4 5084.0 5115.8 4824.1 4829.8 4839.0 4842.7 4857.4 5012.0 5051.9 5052.2 5062.3 5094.4 4876.5 4987.8 5010.4 5063.4 5098.4 4896.5 4949.3 4956.3 4957.4 5005.4 4787.9 4947.9 4953.2 4958.3 5011.7 4774.3 4782.3 4784.8 4816.6 4847.2 4944.4 4965.7 5002.7 5009.3 5066.7 4660.8 4767.3 4904.5 4920.4 4956.4 04:10:07 INFO - 2015-12-11 04:10:07,972 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,972 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42741.17 Median:37866.22 stddev:68163.80 (180.0%) stddev-sans-first:68281.40 04:10:07 INFO - 2015-12-11 04:10:07,973 DEBUG : BROWSER_OUTPUT: Values: 550.8 567.8 570.6 572.4 582.7 36667.4 37538.4 37811.6 37861.8 37870.6 41946.2 42971.1 43006.6 43048.8 43108.1 7824.0 7892.8 7962.2 7978.6 7981.2 7855.4 7980.3 7985.5 7985.5 8006.2 7936.6 7952.4 7956.2 8025.3 8032.3 7917.6 7962.4 7968.5 7982.6 7992.7 7824.9 7869.9 7895.4 7941.0 7943.0 38162.2 38549.8 38640.0 38646.0 38707.0 2397.2 2642.0 2742.3 2759.4 3052.1 26581.7 26657.0 26670.9 26872.0 26883.2 3334.2 3427.7 3484.4 3520.4 3573.8 214692.0 218686.9 220862.0 222282.0 222654.0 48794.8 49122.3 56619.7 56641.4 61860.0 56449.4 56593.7 56820.4 56828.4 57090.0 13546.6 13761.2 13770.9 13813.2 13821.3 9614.0 9679.8 9722.8 9723.5 9725.4 19078.9 19269.0 19356.7 19421.3 19475.6 7715.2 8007.2 8021.5 8096.0 8122.1 842.3 946.4 987.5 1023.7 1037.7 26116.5 26537.6 26776.0 26970.5 27003.5 903.4 955.9 993.3 1111.3 1123.6 12756.6 13456.9 15944.1 16123.2 16202.5 303747.0 311764.0 312369.0 312385.0 313052.0 49306.8 50018.5 50021.7 50031.0 50114.0 1204.5 1209.3 1225.1 1225.3 1341.0 27631.9 27933.0 28212.9 30252.8 30597.9 43657.6 44300.6 44322.3 44366.6 44565.8 242423.0 243594.0 244956.0 245391.0 245524.0 39016.4 42445.0 43009.0 43845.0 43864.1 39017.0 39322.4 39604.2 40227.4 40490.0 33565.5 34383.1 34456.1 34527.8 34816.3 34113.1 34199.8 34298.0 34614.0 34791.0 33743.7 33885.3 33904.8 38661.8 39353.0 29185.4 30229.4 31075.0 31146.4 31201.2 24185.6 24278.9 24292.9 24348.4 24387.1 04:10:07 INFO - 2015-12-11 04:10:07,973 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,973 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26636.89 Median:44532.39 stddev:82154.48 (184.5%) stddev-sans-first:82361.22 04:10:07 INFO - 2015-12-11 04:10:07,973 DEBUG : BROWSER_OUTPUT: Values: 341.6 341.8 345.2 345.5 348.5 12962.9 14832.6 15017.2 15896.4 16674.8 10455.4 10842.6 15174.2 15635.8 15662.3 4044.1 4493.2 4606.7 4724.0 4751.5 4687.3 4707.8 4732.0 4733.2 4739.1 4716.9 4721.7 4952.7 5218.9 5230.2 5098.6 5117.9 5119.3 5128.1 5291.6 5268.3 5273.9 5331.7 5339.1 5350.7 11548.1 11692.1 15774.3 18558.9 18658.1 1773.5 1808.2 1827.3 1840.1 1876.2 9110.4 9154.6 9268.3 9330.3 9369.6 1754.1 1765.8 1788.0 1819.4 1858.1 53681.7 54653.7 57979.7 58055.4 58592.4 9660.9 9810.6 9930.4 9946.6 9970.4 12546.2 12555.4 12568.2 12594.5 12670.8 6659.7 6689.2 6711.7 6944.8 6957.4 6478.4 6597.4 6632.8 6637.0 6660.5 4186.9 4190.8 4191.4 4194.1 4245.4 1780.4 1785.4 1793.1 1797.8 1799.8 713.9 890.2 895.7 899.7 918.3 14541.3 14586.8 14913.1 15068.0 15238.8 791.7 812.9 829.6 839.1 855.8 8656.0 9008.0 9011.4 9205.5 9283.8 490660.0 501414.0 505851.0 506458.0 509277.0 69295.3 72031.0 72497.6 72917.6 74330.6 1058.6 1076.0 1100.2 1127.1 1132.2 13867.2 13975.2 14043.4 14064.9 14074.2 32987.5 33574.5 33770.3 33836.0 34638.0 43600.6 44243.8 44821.0 44914.0 47257.0 8905.3 9020.2 9063.7 9084.8 9108.5 10412.4 12993.6 16089.0 16151.8 16179.4 13281.5 13457.4 13769.0 13822.0 14082.1 12997.2 13090.3 13194.9 13322.9 13850.2 12989.3 13244.7 13272.2 13284.5 14358.6 8566.2 8841.0 8944.4 9056.6 9068.4 9407.9 9567.5 12255.3 13353.3 13718.7 04:10:07 INFO - 2015-12-11 04:10:07,973 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,974 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4963.03 Median:6306.71 stddev:2565.83 (40.7%) stddev-sans-first:2559.63 04:10:07 INFO - 2015-12-11 04:10:07,975 DEBUG : BROWSER_OUTPUT: Values: 1473.4 1662.0 1694.5 1725.2 1750.9 6709.1 6941.5 7092.1 7134.8 7147.6 7110.3 7162.7 7245.0 7245.1 7263.1 2067.2 2103.9 2105.1 2106.0 2109.9 2123.9 2128.8 2154.4 2168.2 2168.4 1793.4 1819.9 2022.6 2032.5 2062.6 2026.0 2032.1 2035.1 2037.2 2039.9 1984.3 2030.3 2089.2 2089.2 2092.1 6970.4 6979.9 7009.3 7009.8 7026.7 4224.4 4296.0 4297.2 4313.6 4327.7 2632.1 2646.7 2678.6 2684.3 2692.2 882.1 890.4 894.7 915.4 930.3 9342.8 9446.0 9478.7 9489.8 9496.0 3721.9 3788.5 3838.5 3842.1 3864.9 7761.8 7762.1 7763.4 7772.5 7774.0 4190.0 4198.3 4204.1 4207.7 4215.7 3871.4 3881.2 3883.3 3900.1 3908.0 3130.2 3155.3 3158.9 3165.3 3167.6 909.3 909.7 914.1 914.5 914.7 902.6 902.6 927.3 969.0 1185.6 6659.2 6671.0 6734.5 6763.6 6765.3 1038.9 1044.5 1049.0 1056.1 1079.1 5324.4 5363.9 5366.6 5368.6 5424.1 8197.0 8355.5 8533.8 8604.2 8672.5 8460.2 8482.9 8539.2 8542.5 8565.5 6266.7 6652.3 6743.6 6748.0 6768.7 6654.2 6770.5 6809.6 6825.1 6838.5 7569.0 7702.7 7703.5 7781.2 7815.7 7642.2 7887.6 8089.0 8101.5 8140.9 6179.1 6219.1 6270.7 6299.3 6314.1 6844.9 7005.6 7055.2 7063.6 7078.4 6534.3 6568.4 6631.1 6673.2 6709.6 5212.4 6026.2 6114.7 6167.0 6265.7 6322.3 6325.5 6326.5 6372.3 6388.0 6021.0 6040.9 6045.7 6072.5 6076.9 5897.1 6027.7 6027.8 6040.5 6045.7 04:10:07 INFO - 2015-12-11 04:10:07,975 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,975 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4836.61 Median:5523.03 stddev:1432.16 (25.9%) stddev-sans-first:1395.41 04:10:07 INFO - 2015-12-11 04:10:07,975 DEBUG : BROWSER_OUTPUT: Values: 316.1 321.6 325.9 328.8 330.7 5497.0 5526.6 5584.7 5597.8 5690.1 5519.4 5548.9 5559.8 5567.1 5577.6 4269.2 4282.1 4286.5 4291.4 4292.7 4276.8 4287.0 4305.2 4310.1 4313.1 4173.7 4227.7 4253.7 4255.9 4262.5 4246.5 4247.4 4257.4 4264.2 4276.2 3708.0 3714.5 3714.6 3715.2 3734.2 5354.4 5381.4 5381.8 5387.1 5399.9 4747.6 4916.7 4917.9 4919.6 4933.2 5653.1 5817.5 5819.4 5826.4 5832.0 4012.5 4013.3 4019.2 4022.5 4025.7 6044.9 6120.1 6122.4 6131.4 6135.6 4022.9 4088.4 4096.0 4113.5 4118.0 4174.6 4176.7 4177.1 4206.1 4245.5 4861.7 4867.5 4870.8 4876.1 4888.0 5845.9 5847.8 5852.8 5862.8 5869.9 1441.2 1466.5 1467.8 1468.6 1472.6 998.7 1012.3 1021.8 1028.5 1031.0 5009.5 5052.0 5056.6 5066.9 5075.8 6009.0 6009.8 6053.2 6053.5 6072.1 4992.4 5028.8 5052.2 5055.5 5067.2 3215.5 3224.8 3262.1 3289.0 3292.3 5649.2 5656.7 5679.8 5681.6 5691.0 6219.1 6233.4 6233.5 6245.2 6248.2 5620.6 5688.5 5689.4 5700.7 5720.3 6086.2 6110.9 6126.9 6126.9 6129.0 5925.9 5949.3 5970.9 5983.6 5987.3 5606.5 5701.1 5718.9 5726.1 5737.7 4162.8 4213.8 4216.4 4220.9 4225.6 6085.8 6120.8 6121.9 6131.4 6138.8 5855.2 5860.6 5873.0 5878.8 5894.6 5701.9 5858.7 5869.4 5869.9 5882.8 5739.2 5747.0 5749.0 5755.2 5758.2 5905.4 5907.7 5912.0 5916.1 5921.2 5615.4 5751.4 5758.2 5759.9 5763.9 04:10:07 INFO - 2015-12-11 04:10:07,975 DEBUG : BROWSER_OUTPUT: 04:10:07 INFO - 2015-12-11 04:10:07,976 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12478.44 Median:450.78 stddev:14233.47 (3157.5%) stddev-sans-first:14246.33 04:10:07 INFO - 2015-12-11 04:10:07,977 DEBUG : BROWSER_OUTPUT: Values: 787.7 794.5 806.2 806.5 833.8 12038.8 12313.3 13946.9 14066.6 14175.1 12371.8 12526.4 12548.0 12549.2 12609.1 807.3 813.7 818.5 819.1 821.0 770.8 815.3 831.1 832.0 835.9 841.3 846.2 847.0 851.9 855.3 841.4 846.1 846.5 848.2 849.9 621.9 624.2 625.1 626.2 626.4 12638.5 12758.0 12777.5 12782.2 12791.5 10777.8 10870.6 11283.7 11482.5 12094.0 9047.4 9234.2 9244.2 9259.2 9277.4 3181.5 3210.3 3240.7 3265.6 3292.0 40835.1 41143.6 41239.4 41385.6 41617.0 9414.0 9596.8 9678.9 9688.7 9759.6 16238.3 16248.9 16317.3 16383.1 16404.7 6104.2 6166.6 6239.5 6286.6 6393.8 3686.9 3709.4 3715.1 3724.9 3730.0 2755.4 2782.5 2786.7 2787.3 2788.0 452.2 454.6 460.7 460.9 466.1 431.5 431.9 459.0 460.9 535.5 6597.5 6890.6 7054.4 7095.0 7202.3 449.4 486.5 512.5 544.8 549.4 3248.0 3474.4 3566.0 3582.1 3883.1 47889.0 47941.0 47948.8 53358.2 55700.2 45915.3 46652.3 46849.0 46908.8 47287.3 42705.0 43445.1 44357.6 44572.6 44635.3 7407.4 7521.1 7639.2 7692.8 7909.1 29605.3 29891.4 30141.4 30217.8 30546.7 38954.2 39207.8 39322.4 39772.0 40324.4 10566.7 10625.8 10691.4 10723.8 10815.9 11440.9 11535.1 11600.4 11602.9 11682.0 9386.2 9542.4 10681.1 10682.9 10717.9 10608.3 10915.0 11144.2 11311.5 11411.5 10103.7 10274.8 10490.6 10496.3 10500.2 9254.6 9424.4 9466.0 9570.3 9593.5 8031.4 8358.3 8428.2 8607.8 8712.4 04:10:07 INFO - 2015-12-11 04:10:07,977 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:10:07 INFO - 2015-12-11 04:10:07,977 DEBUG : BROWSER_OUTPUT: 04:10:08 INFO - 2015-12-11 04:10:08,696 INFO : Browser exited with error code: 0 04:10:08 INFO - 2015-12-11 04:10:08,717 INFO : Completed test dromaeo_css (00:18:35) 04:10:08 INFO - 2015-12-11 04:10:08,717 INFO : Starting test kraken 04:10:08 INFO - 2015-12-11 04:10:08,717 DEBUG : operating with platform_type : linux_ 04:10:08 INFO - 2015-12-11 04:10:08,717 INFO : Initialising browser for kraken test... 04:10:08 INFO - 2015-12-11 04:10:08,724 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxvXFaR/profile http://localhost:49444/getInfo.html 04:10:13 INFO - 2015-12-11 04:10:13,618 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:13 INFO - 2015-12-11 04:10:13,618 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:13 INFO - 2015-12-11 04:10:13,618 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:13 INFO - 2015-12-11 04:10:13,618 DEBUG : BROWSER_OUTPUT: __metrics 04:10:13 INFO - 2015-12-11 04:10:13,767 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:10:14 INFO - 2015-12-11 04:10:14,716 INFO : Browser initialized. 04:10:14 INFO - 2015-12-11 04:10:14,716 INFO : Running cycle 1/1 for kraken test... 04:10:14 INFO - 2015-12-11 04:10:14,717 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxvXFaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:26 INFO - 2015-12-11 04:10:26,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 143667200 04:10:26 INFO - 2015-12-11 04:10:26,684 DEBUG : BROWSER_OUTPUT: 04:10:29 INFO - 2015-12-11 04:10:29,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:29 INFO - 2015-12-11 04:10:29,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 142168064 04:10:29 INFO - 2015-12-11 04:10:29,906 DEBUG : BROWSER_OUTPUT: 04:10:32 INFO - 2015-12-11 04:10:32,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-dft) 04:10:33 INFO - 2015-12-11 04:10:33,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 143003648 04:10:33 INFO - 2015-12-11 04:10:33,317 DEBUG : BROWSER_OUTPUT: 04:10:36 INFO - 2015-12-11 04:10:36,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-fft) 04:10:36 INFO - 2015-12-11 04:10:36,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 137715712 04:10:36 INFO - 2015-12-11 04:10:36,804 DEBUG : BROWSER_OUTPUT: 04:10:38 INFO - 2015-12-11 04:10:38,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator) 04:10:39 INFO - 2015-12-11 04:10:39,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 04:10:39 INFO - 2015-12-11 04:10:39,459 DEBUG : BROWSER_OUTPUT: 04:10:41 INFO - 2015-12-11 04:10:41,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:42 INFO - 2015-12-11 04:10:42,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 04:10:42 INFO - 2015-12-11 04:10:42,347 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2015-12-11 04:10:45,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:46 INFO - 2015-12-11 04:10:46,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 140111872 04:10:46 INFO - 2015-12-11 04:10:46,007 DEBUG : BROWSER_OUTPUT: 04:10:49 INFO - 2015-12-11 04:10:49,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:50 INFO - 2015-12-11 04:10:50,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 137838592 04:10:50 INFO - 2015-12-11 04:10:50,095 DEBUG : BROWSER_OUTPUT: 04:10:53 INFO - 2015-12-11 04:10:53,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial) 04:10:53 INFO - 2015-12-11 04:10:53,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 04:10:53 INFO - 2015-12-11 04:10:53,614 DEBUG : BROWSER_OUTPUT: 04:10:55 INFO - 2015-12-11 04:10:55,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:56 INFO - 2015-12-11 04:10:56,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 04:10:56 INFO - 2015-12-11 04:10:56,006 DEBUG : BROWSER_OUTPUT: 04:10:57 INFO - 2015-12-11 04:10:57,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:58 INFO - 2015-12-11 04:10:58,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 140713984 04:10:58 INFO - 2015-12-11 04:10:58,491 DEBUG : BROWSER_OUTPUT: 04:11:00 INFO - 2015-12-11 04:11:00,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:01 INFO - 2015-12-11 04:11:01,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 04:11:01 INFO - 2015-12-11 04:11:01,266 DEBUG : BROWSER_OUTPUT: 04:11:03 INFO - 2015-12-11 04:11:03,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:04 INFO - 2015-12-11 04:11:04,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 140283904 04:11:04 INFO - 2015-12-11 04:11:04,451 DEBUG : BROWSER_OUTPUT: 04:11:07 INFO - 2015-12-11 04:11:07,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:07 INFO - 2015-12-11 04:11:07,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 140062720 04:11:07 INFO - 2015-12-11 04:11:07,673 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49444/tests/kraken/driver.html?testName=ai-astar) 04:11:09 INFO - 2015-12-11 04:11:09,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 04:11:09 INFO - 2015-12-11 04:11:09,685 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,685 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:09 INFO - 2015-12-11 04:11:09,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:09 INFO - 2015-12-11 04:11:09,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:09 INFO - 2015-12-11 04:11:09,686 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;119;114;112;114;125;113;112;113;114 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;166;164;142;164;163;131;171;136 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;165;162;163;165;165;160;164;162 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;75;75;132;72;72;72;72;88 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;136;94;94;95;143;96;95;127 04:11:09 INFO - 2015-12-11 04:11:09,687 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;109;109;111;110 04:11:09 INFO - 2015-12-11 04:11:09,688 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;147;148;147;149;147;147;148;148;146 04:11:09 INFO - 2015-12-11 04:11:09,688 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;96 04:11:09 INFO - 2015-12-11 04:11:09,688 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;75;75;74;76;74;74;75;76;78 04:11:09 INFO - 2015-12-11 04:11:09,688 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;68;68;68;68;68;68;68 04:11:09 INFO - 2015-12-11 04:11:09,688 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;91;85;82;83;85;83;84;83 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;126;123;127;124;128;128;130;129;138 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;148;149;146;156;149;147;149;148;134 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;73;69;69;69;68;70;68;73 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,810 04:11:09 INFO - 2015-12-11 04:11:09,689 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:11:09 INFO - 2015-12-11 04:11:09,690 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835869684__endTimestamp 04:11:09 INFO - 2015-12-11 04:11:09,690 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:09 INFO - 2015-12-11 04:11:09,693 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:11:09 INFO - 2015-12-11 04:11:09,694 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,694 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.13 (3.6%) stddev-sans-first:4.26 04:11:09 INFO - 2015-12-11 04:11:09,694 DEBUG : BROWSER_OUTPUT: Values: 112.0 119.0 114.0 112.0 114.0 125.0 113.0 112.0 113.0 114.0 04:11:09 INFO - 2015-12-11 04:11:09,694 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,695 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.50 Median:163.50 stddev:15.73 (9.6%) stddev-sans-first:16.60 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 166.0 164.0 142.0 164.0 163.0 131.0 171.0 136.0 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.79 (1.1%) stddev-sans-first:1.76 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 165.0 162.0 163.0 165.0 165.0 160.0 164.0 162.0 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:74.00 stddev:18.69 (25.3%) stddev-sans-first:19.72 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 75.0 75.0 132.0 72.0 72.0 72.0 72.0 88.0 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:95.00 stddev:19.92 (21.0%) stddev-sans-first:20.65 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 136.0 94.0 94.0 95.0 143.0 96.0 95.0 127.0 04:11:09 INFO - 2015-12-11 04:11:09,696 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 111.0 110.0 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:0.88 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: Values: 150.0 147.0 148.0 147.0 149.0 147.0 147.0 148.0 148.0 146.0 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,697 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:75.50 stddev:1.35 (1.8%) stddev-sans-first:1.30 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: Values: 77.0 75.0 75.0 74.0 76.0 74.0 74.0 75.0 76.0 78.0 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:2.57 (3.1%) stddev-sans-first:2.69 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 91.0 85.0 82.0 83.0 85.0 83.0 84.0 83.0 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:4.30 (3.4%) stddev-sans-first:4.34 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: Values: 124.0 126.0 123.0 127.0 124.0 128.0 128.0 130.0 129.0 138.0 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.50 stddev:6.33 (4.3%) stddev-sans-first:5.74 04:11:09 INFO - 2015-12-11 04:11:09,698 DEBUG : BROWSER_OUTPUT: Values: 137.0 148.0 149.0 146.0 156.0 149.0 147.0 149.0 148.0 134.0 04:11:09 INFO - 2015-12-11 04:11:09,699 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,699 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:1.90 (2.7%) stddev-sans-first:2.00 04:11:09 INFO - 2015-12-11 04:11:09,699 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 73.0 69.0 69.0 69.0 68.0 70.0 68.0 73.0 04:11:09 INFO - 2015-12-11 04:11:09,699 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:09 INFO - 2015-12-11 04:11:09,699 DEBUG : BROWSER_OUTPUT: 04:11:10 INFO - 2015-12-11 04:11:10,628 INFO : Browser exited with error code: 0 04:11:10 INFO - 2015-12-11 04:11:10,681 INFO : Completed test kraken (00:01:01) 04:11:10 INFO - 2015-12-11 04:11:10,681 INFO : Starting test v8_7 04:11:10 INFO - 2015-12-11 04:11:10,681 DEBUG : operating with platform_type : linux_ 04:11:10 INFO - 2015-12-11 04:11:10,682 INFO : Initialising browser for v8_7 test... 04:11:10 INFO - 2015-12-11 04:11:10,688 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09Pfbv/profile http://localhost:49444/getInfo.html 04:11:15 INFO - 2015-12-11 04:11:15,490 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:11:15 INFO - 2015-12-11 04:11:15,490 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:11:15 INFO - 2015-12-11 04:11:15,490 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:11:15 INFO - 2015-12-11 04:11:15,490 DEBUG : BROWSER_OUTPUT: __metrics 04:11:15 INFO - 2015-12-11 04:11:15,647 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:11:16 INFO - 2015-12-11 04:11:16,600 INFO : Browser initialized. 04:11:16 INFO - 2015-12-11 04:11:16,600 INFO : Running cycle 1/1 for v8_7 test... 04:11:16 INFO - 2015-12-11 04:11:16,601 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp09Pfbv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:11:28 INFO - 2015-12-11 04:11:28,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 143073280 04:11:28 INFO - 2015-12-11 04:11:28,623 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49444/tests/v8_7/run.html (next: http://localhost:49444/tests/v8_7/run.html) 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:50 INFO - 2015-12-11 04:11:50,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |0;Richards;167.2800267648043 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.29782528566162 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |5;Earley;714.2857142857143 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 04:11:50 INFO - 2015-12-11 04:11:50,398 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: |8;Splay;614.1104294478528 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835910391__endTimestamp 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:50 INFO - 2015-12-11 04:11:50,399 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: Values: 167.3 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.30 Median:184.30 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: Values: 184.3 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: Values: 278.9 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: Values: 5154.6 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,400 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: Values: 1058.2 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: Values: 714.3 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: Values: 12370.4 04:11:50 INFO - 2015-12-11 04:11:50,401 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: Values: 26076.9 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.11 Median:614.11 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: Values: 614.1 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: 04:11:50 INFO - 2015-12-11 04:11:50,402 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:11:50 INFO - 2015-12-11 04:11:50,403 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:11:50 INFO - 2015-12-11 04:11:50,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:50 INFO - 2015-12-11 04:11:50,403 DEBUG : BROWSER_OUTPUT: 04:11:51 INFO - 2015-12-11 04:11:51,324 INFO : Browser exited with error code: 0 04:11:51 INFO - 2015-12-11 04:11:51,341 INFO : Completed test v8_7 (00:00:40) 04:11:51 INFO - 2015-12-11 04:11:51,376 INFO : Completed test suite (00:20:18) 04:11:51 INFO - 2015-12-11 04:11:51,377 DEBUG : Working with test: dromaeo_css 04:11:51 INFO - 2015-12-11 04:11:51,377 DEBUG : Generating results file: dromaeo_css 04:11:51 INFO - 2015-12-11 04:11:51,378 DEBUG : Working with test: kraken 04:11:51 INFO - 2015-12-11 04:11:51,378 DEBUG : Generating results file: kraken 04:11:51 INFO - 2015-12-11 04:11:51,378 INFO : javascript benchmark 04:11:51 INFO - 2015-12-11 04:11:51,378 DEBUG : Working with test: v8_7 04:11:51 INFO - 2015-12-11 04:11:51,379 DEBUG : Generating results file: v8_7 04:11:51 INFO - 2015-12-11 04:11:51,379 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:51 INFO - 2015-12-11 04:11:51,431 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:11:51 INFO - 2015-12-11 04:11:51,431 DEBUG : process_Request line: dromaeo_css 6380.55 graph.html#tests=[[72,94,43]] 04:11:51 INFO - 2015-12-11 04:11:51,431 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:51 INFO - 2015-12-11 04:11:51,464 DEBUG : process_Request line: kraken 1541.90 graph.html#tests=[[232,94,43]] 04:11:51 INFO - 2015-12-11 04:11:51,464 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:51 INFO - 2015-12-11 04:11:51,494 DEBUG : process_Request line: v8_7 21323.44 graph.html#tests=[[230,94,43]] 04:11:51 INFO - 2015-12-11 04:11:51,495 INFO : javascript benchmark 04:11:51 INFO - 2015-12-11 04:11:51,499 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2667.053196115379, 2703.675558932928, 2726.822756520826, 2745.9725402745967, 2756.2558109310485, 4479.104179164164, 4742.383490146281, 4785.18651829189, 4811.206150985087, 4827.396575428072, 4634.490206077328, 4653.092646933849, 4667.929981050287, 4780.832670856521, 4792.592629626477, 4335.739855608658, 4417.757023363713, 4435.622972047372, 4444.577765112309, 4490.865274041784, 4258.425112609789, 4387.62705170061, 4436.64506839452, 4448.199324121673, 4467.396901418316, 4173.686973477002, 4248.1078973415315, 4253.064325848309, 4265.957340426618, 4277.6791740619265, 4404.823807047715, 4429.579189976947, 4431.911361772746, 4443.600075993176, 4486.057927835159, 4193.685473589462, 4264.019275566637, 4293.656507479394, 4399.472063352387, 4444.511103778582, 4571.3600095986585, 4626.86119416418, 4646.95353046472, 4715.669903106749, 4761.2382018876815, 5053.8736531587, 5066.113430149746, 5081.466446023152, 5083.466236045199, 5127.025865085622, 4910.631702622282, 4958.776855041496, 5029.698218106889, 5108.106081435771, 5113.693178409308, 4723.7874295656775, 4744.027474367746, 4746.952530474651, 4758.048390321949, 4798.616110711135, 5222.503862133091, 5246.291750613695, 5248.895022099537, 5250.842474725764, 5301.284326615934, 4885.780139893714, 4922.852314430573, 4977.178765503651, 4979.178435558165, 5003.174476211457, 5081.110805609003, 5100.872478188001, 5112.667676601009, 5119.462456442095, 5182.766775495112, 4839.249916262985, 5053.84838454847, 5066.417362003343, 5087.389513258433, 5091.3381260436645, 4945.826896058621, 4996.15065438869, 5030.949690503121, 5048.495150484922, 5073.720945348041, 4182.623563879265, 4230.048239146229, 4233.068724880522, 4265.0, 4283.0, 3556.3065202285825, 3645.052286405554, 3693.556773187181, 3699.352613292663, 3745.8127093645207, 4244.342126970325, 4335.82656693735, 4338.392625032498, 4344.587264209958, 4375.606195442426, 5111.386633603991, 5121.948780512222, 5163.432022477525, 5166.974165129151, 5171.4311425743135, 4224.4930608327195, 4303.63419109373, 4349.521552629209, 4424.048829501608, 4459.219636563588, 4471.8434854779925, 4479.395281637003, 4527.230370836965, 4532.1842068427995, 4593.19619066662, 4769.0, 4795.616350692006, 4799.0, 4805.255185446262, 4832.420109586872, 4906.63200259989, 4977.054359671651, 4990.3762029746285, 5084.0, 5115.820946266863, 4824.107540105092, 4829.782659780389, 4839.0, 4842.661013729146, 4857.441394239708, 5012.022655582126, 5051.87370315745, 5052.1663925451885, 5062.265971434195, 5094.414142373526, 4876.463589005278, 4987.750612469289, 5010.3737032870895, 5063.392392912727, 5098.362704661918, 4896.461389247252, 4949.30709700635, 4956.281339205867, 4957.380327459067, 5005.399352077774, 4787.904241915212, 4947.925781113214, 4953.157963146202, 4958.256261560795, 5011.749412529286, 4774.3315935769715, 4782.282657601388, 4784.784684689128, 4816.638752093677, 4847.200211965127, 4944.431390390007, 4965.677230979974, 5002.749862506933, 5009.273655319886, 5066.746662666926, 4660.836870709509, 4767.308740232716, 4904.485029071896, 4920.434150072788, 4956.355673762388], "unit": "ms", "name": "dojo.html", "value": 4647.198315762465}, {"lowerIsBetter": false, "replicates": [550.7604192176403, 567.8438429431908, 570.5635189080355, 572.4447286132452, 582.7202942587556, 36667.4499882502, 37538.43692344617, 37811.621883781154, 37861.81069094654, 37870.62129378705, 41946.161076778444, 42971.14057718844, 43006.56993430065, 43048.78475607617, 43108.13783724324, 7824.021997250358, 7892.802679933019, 7962.1639727828615, 7978.561179135145, 7981.161977992314, 7855.41084418668, 7980.281774640282, 7985.480943738638, 7985.5208687478935, 8006.159353267911, 7936.642851071716, 7952.3638108951145, 7956.164602716718, 8025.277725004748, 8032.3172530335, 7917.56453395063, 7962.442629015971, 7968.521888686697, 7982.640781164832, 7992.720254791113, 7824.921750782476, 7869.881951770728, 7895.447318687694, 7941.0, 7943.0, 38162.23675526502, 38549.80725096357, 38640.0, 38646.0, 38707.0, 2397.2448678666165, 2641.984537603535, 2742.314421394651, 2759.4205216904475, 3052.0691189187287, 26581.734182658118, 26657.0, 26670.86664566684, 26872.0, 26883.19350419471, 3334.249793796401, 3427.674370934757, 3484.407650699387, 3520.366334059868, 3573.7855728656364, 214692.0, 218686.90656546774, 220862.0, 222282.0, 222654.0, 48794.756026220355, 49122.26316605254, 56619.71690141605, 56641.43358566362, 61860.0, 56449.43550564524, 56593.71703141541, 56820.43179568234, 56828.43171568314, 57090.0, 13546.593602191753, 13761.243131627656, 13770.862291376958, 13813.240271784947, 13821.308934553232, 9614.0, 9679.758006049906, 9722.805543889224, 9723.513824308757, 9725.367851089799, 19078.90460547716, 19269.036548172535, 19356.70964935527, 19421.32025379105, 19475.610487790163, 7715.151333353327, 8007.1592482788465, 8021.518708877369, 8096.0, 8122.106568277485, 842.3093063687717, 946.3801210207325, 987.4766373821886, 1023.6914273268266, 1037.7457522906784, 26116.477670446864, 26537.601935970975, 26776.0, 26970.460590788076, 27003.459930801273, 903.4443817052465, 955.9235261179089, 993.3146129170849, 1111.294328101645, 1123.5505797680994, 12756.61730148097, 13456.932715336361, 15944.123073231083, 16123.193840307938, 16202.513924582281, 303747.0, 311764.0, 312369.0, 312385.0, 313052.0, 49306.75346623316, 50018.49981500211, 50021.749891250314, 50031.0, 50114.0, 1204.5362535423749, 1209.2683926224684, 1225.0934308611563, 1225.2587184753274, 1340.9674550595987, 27631.861840690668, 27933.0, 28212.858935706012, 30252.84873575706, 30597.887457655037, 43657.56342436535, 44300.556994429644, 44322.3351649732, 44366.556334436245, 44565.777171113936, 242423.0, 243594.0, 244956.0, 245391.0, 245524.0, 39016.41475377928, 42445.0, 43009.0, 43845.0, 43864.12271754483, 39017.0, 39322.410163846995, 39604.2079158421, 40227.3965890506, 40490.0, 33565.496517551765, 34383.14042148966, 34456.13859653529, 34527.82736086303, 34816.30367392689, 34113.14717132092, 34199.829000854836, 34298.0, 34614.0, 34791.0, 33743.66256337504, 33885.32229355448, 33904.83047584746, 38661.80669096637, 39353.0, 29185.41629167447, 30229.395412092075, 31075.0, 31146.37707245797, 31201.223107132373, 24185.63721544143, 24278.87860560686, 24292.878535607208, 24348.443413441335, 24387.14644987417], "unit": "ms", "name": "ext.html", "value": 17439.58379925363}, {"lowerIsBetter": false, "replicates": [341.59350373056077, 341.81200339813114, 345.16814477110154, 345.4938515075415, 348.4842433198866, 12962.870371296296, 14832.555023349303, 15017.249137543135, 15896.443624473146, 16674.833251667478, 10455.424951627658, 10842.620508282213, 15174.241287935587, 15635.765463518057, 15662.295196716146, 4044.1084624493483, 4493.213687604664, 4606.700564463299, 4724.0, 4751.5010923853015, 4687.250039993602, 4707.811687532495, 4731.9763401182945, 4733.242681171013, 4739.123262196487, 4716.882077948062, 4721.716696998174, 4952.702837829742, 5218.895622087556, 5230.163173892178, 5098.59211263098, 5117.897642047157, 5119.257707632372, 5128.102582048145, 5291.576673866081, 5268.262443257947, 5273.920891186635, 5331.680099194022, 5339.145736682151, 5350.732463376816, 11548.133889958286, 11692.123090768226, 15774.29015694285, 18558.907205463885, 18658.06709664525, 1773.494554052089, 1808.2315016118098, 1827.2964908510319, 1840.0615686000103, 1876.1557299215272, 9110.362274640778, 9154.633814647406, 9268.25853931684, 9330.300227482965, 9369.578368973413, 1754.1141723429587, 1765.841074303319, 1787.9642407151784, 1819.3541292841117, 1858.135966775456, 53681.731591342184, 54653.72673136609, 57979.710101449644, 58055.419445805426, 58592.414075859546, 9660.855087173699, 9810.558524866397, 9930.404175749478, 9946.602135914482, 9970.351927124859, 12546.247225166519, 12555.372231388394, 12568.183068100545, 12594.496220151092, 12670.80993785094, 6659.6670166491485, 6689.230738465041, 6711.731530738716, 6944.826379340456, 6957.373836354753, 6478.352164783484, 6597.373249541286, 6632.767853125118, 6637.037629543689, 6660.500462465335, 4186.937195942063, 4190.790460476964, 4191.350340697197, 4194.098268872146, 4245.384419259251, 1780.3590707345345, 1785.3572713823014, 1793.1482545790645, 1797.8471829894345, 1799.7570328005813, 713.9393151582174, 890.225503811688, 895.7223260789176, 899.6851102114339, 918.3479729392072, 14541.27293635314, 14586.781198281822, 14913.105213686997, 15068.0, 15238.847611523965, 791.6764296788942, 812.8618134917078, 829.618375547255, 839.1105428245957, 855.7689423855525, 8655.956720216485, 9007.964084130277, 9011.414258073204, 9205.493697846683, 9283.814323713488, 490660.0, 501414.0, 505851.0, 506458.0, 509277.0, 69295.3070469299, 72031.0, 72497.6375118121, 72917.6354118226, 74330.62834685792, 1058.571278632155, 1075.9515821787882, 1100.2353364411817, 1127.0589058136547, 1132.2413982631492, 13867.167969921837, 13975.231362275172, 14043.36804843764, 14064.859351406763, 14074.225917574631, 32987.505187421724, 33574.49638255477, 33770.324593508485, 33836.0, 34638.0, 43600.56399435965, 44243.77878110589, 44821.0, 44914.0, 47257.0, 8905.332100092648, 9020.233280170996, 9063.728088157366, 9084.818303633758, 9108.453492790453, 10412.375257484575, 12993.610191694264, 16089.0, 16151.838481615034, 16179.43371981975, 13281.535146269835, 13457.394417251444, 13768.96732745028, 13822.0, 14082.084664496775, 12997.15518491295, 13090.280034598189, 13194.868051319363, 13322.933385333012, 13850.16898986064, 12989.28558929268, 13244.668883277995, 13272.203667779579, 13284.53504127351, 14358.56924292273, 8566.229039386486, 8841.027486976298, 8944.37389382737, 9056.592453339746, 9068.365214434927, 9407.905920940702, 9567.473788941676, 12255.264684118982, 13353.265570393722, 13718.65703357424], "unit": "ms", "name": "jquery.html", "value": 8138.686077395505}, {"lowerIsBetter": false, "replicates": [1473.3664524254566, 1661.950141495755, 1694.466243133413, 1725.1805392438594, 1750.9387171448998, 6709.094272273242, 6941.479389045817, 7092.148942126945, 7134.821629459266, 7147.642617869105, 7110.253423390547, 7162.749303774369, 7244.96377518113, 7245.058142441475, 7263.0921134858145, 2067.1834625323027, 2103.9368818935454, 2105.0632468551503, 2106.0207003743258, 2109.8839563823985, 2123.936281911545, 2128.7871212878745, 2154.4183070571016, 2168.186929901287, 2168.3928500019942, 1793.4081753021537, 1819.945401637953, 2022.5752591955634, 2032.4613977296028, 2062.6287268291703, 2025.959480810383, 2032.0550943811124, 2035.1350675962656, 2037.2258541754186, 2039.867408618435, 1984.2559040359865, 2030.2893987104544, 2089.1643342662906, 2089.226986015184, 2092.110852887532, 6970.442364610819, 6979.89530157048, 7009.334113259232, 7009.7897063088185, 7026.683799228996, 4224.429701990222, 4296.033392486696, 4297.247981603207, 4313.590208930146, 4327.675424343187, 2632.118240389472, 2646.7088620251757, 2678.6116013178175, 2684.315499547603, 2692.232713676593, 882.056199866137, 890.3900827932887, 894.727108231989, 915.3501014279869, 930.3115694386173, 9342.766430839216, 9445.952770236105, 9478.715638530855, 9489.766330377075, 9496.002919693401, 3721.9441708373856, 3788.4696142539515, 3838.5201849768778, 3842.058695619591, 3864.942025869614, 7761.8447631047065, 7762.107357653829, 7763.417743669134, 7772.455928085093, 7774.0, 4190.0, 4198.286291330481, 4204.075103477291, 4207.684423668237, 4215.662746980234, 3871.399933010388, 3881.223755248905, 3883.262180185756, 3900.1029763154634, 3907.96092039076, 3130.1861516005547, 3155.3216058547523, 3158.9052328430184, 3165.3352795913115, 3167.6357218919657, 909.3180114913814, 909.736176508805, 914.0539541574439, 914.5153068873508, 914.7438717159206, 902.5757893789909, 902.6479672927563, 927.3415874729018, 968.970930872075, 1185.6324539392815, 6659.234188068434, 6670.966645166744, 6734.494912881553, 6763.5941843489545, 6765.2896445872475, 1038.8857225705167, 1044.498640652491, 1048.984265236022, 1056.1075890872355, 1079.0827796373178, 5324.440933701905, 5363.865903352369, 5366.570674346043, 5368.597355198376, 5424.077906755861, 8197.0, 8355.498670079814, 8533.829323413496, 8604.182602652738, 8672.523011234443, 8460.196281353261, 8482.872756908651, 8539.231469167804, 8542.487450752975, 8565.528895910784, 6266.717997690206, 6652.268250492442, 6743.561668491532, 6747.966260168668, 6768.680107379014, 6654.234763002123, 6770.4922130839395, 6809.625470598967, 6825.146856642919, 6838.452923766186, 7568.962155189409, 7702.653380597999, 7703.499272547267, 7781.2218778124, 7815.726449574237, 7642.197569255371, 7887.605619719106, 8088.9595552021865, 8101.473404228706, 8140.918590814016, 6179.073139029181, 6219.129321894848, 6270.686465676789, 6299.307076221704, 6314.116023756769, 6844.93155068443, 7005.614691192033, 7055.153381594037, 7063.611501367474, 7078.362947334765, 6534.346565343428, 6568.408843204134, 6631.0716499689115, 6673.232578253563, 6709.563878347892, 5212.374515058065, 6026.246719160105, 6114.663693496723, 6167.0, 6265.655388953652, 6322.304546499973, 6325.462335701517, 6326.493880489642, 6372.299047104908, 6387.968060159669, 6021.0, 6040.939590604038, 6045.697715114315, 6072.483838873745, 6076.90884636722, 5897.144913987534, 6027.668478233739, 6027.849303767265, 6040.546958978006, 6045.667488288186], "unit": "ms", "name": "mootools.html", "value": 4068.532874790628}, {"lowerIsBetter": false, "replicates": [316.12275934282366, 321.6012144940275, 325.85825166052786, 328.804361404964, 330.73541167066355, 5496.972515137429, 5526.640768350065, 5584.664920104791, 5597.776088956447, 5690.089585666295, 5519.420460851613, 5548.944510554893, 5559.833205003846, 5567.081431563787, 5577.581681373893, 4269.210196113713, 4282.100758840647, 4286.5284818669925, 4291.356296555526, 4292.699511034229, 4276.786160691969, 4286.978565107186, 4305.22505948929, 4310.094880075172, 4313.1158112587, 4173.707840451169, 4227.6617870570435, 4253.702240843142, 4255.914881702364, 4262.531121576624, 4246.532881383046, 4247.384129301265, 4257.403963445105, 4264.23243816113, 4276.187524370391, 3708.0173753955223, 3714.53568303962, 3714.572824125233, 3715.2198038411966, 3734.2158146789207, 5354.43778403266, 5381.354237491487, 5381.7578208980685, 5387.1111266640955, 5399.919001214985, 4747.572718455321, 4916.680415772963, 4917.852464426073, 4919.581835543983, 4933.1860243059855, 5653.123765816305, 5817.534597232254, 5819.447152520504, 5826.446487583673, 5831.970840145815, 4012.538558065831, 4013.2976729072298, 4019.1760689058965, 4022.4971878515184, 4025.7383270087644, 6044.939550604482, 6120.051392034242, 6122.4183702548635, 6131.3868613138775, 6135.631862088289, 4022.9195416091516, 4088.448059511987, 4095.9590404096175, 4113.465249517603, 4117.97941010299, 4174.624283814472, 4176.686748493875, 4177.060161463646, 4206.074663574009, 4245.469316335458, 4861.683990540603, 4867.537583929521, 4870.780814863339, 4876.122297986326, 4888.0, 5845.941540584539, 5847.795327163529, 5852.7658893643775, 5862.824115276549, 5869.882602347929, 1441.1929319581068, 1466.5160497035952, 1467.8238611366492, 1468.6034770611875, 1472.6097584140211, 998.6804222648828, 1012.3498697123641, 1021.8467229915424, 1028.4703377760459, 1030.9690709278734, 5009.524095210949, 5051.974740126276, 5056.64603477753, 5066.923996140061, 5075.822346217865, 6008.969955150196, 6009.849753756103, 6053.182820319201, 6053.485453736482, 6072.089186621954, 4992.375953005874, 5028.79884804611, 5052.1663925451885, 5055.51972562606, 5067.239914012854, 3215.5208604042405, 3224.790388624732, 3262.13553408347, 3288.9804160709778, 3292.3415316936707, 5649.152627105967, 5656.717164141776, 5679.77280908759, 5681.602287839812, 5691.0, 6219.067139929047, 6233.407826256498, 6233.470155036873, 6245.156903817927, 6248.156498872594, 5620.5503559715125, 5688.544916406678, 5689.374168841424, 5700.657960522382, 5720.2849643794525, 6086.178365920544, 6110.908336375047, 6126.938730612636, 6126.938730612816, 6129.0, 5925.866687992233, 5949.3455719871645, 5970.850728731642, 5983.55123365758, 5987.2815262168815, 5606.523445507178, 5701.087825947829, 5718.8848174605555, 5726.0838265877255, 5737.741801618854, 4162.812673429642, 4213.789310534522, 4216.388623649615, 4220.89447763796, 4225.640820530167, 6085.756569737338, 6120.816375508742, 6121.877562448815, 6131.448169664752, 6138.785142519991, 5855.151003104611, 5860.589758716849, 5873.0, 5878.764849405976, 5894.616849904743, 5701.857453563694, 5858.736356864037, 5869.383714709894, 5869.882602347844, 5882.794102206402, 5739.196512488338, 5746.9712651436475, 5749.0, 5755.165501002415, 5758.1650660654805, 5905.43898329658, 5907.734151963086, 5911.970440147944, 5916.083007133901, 5921.2006379138265, 5615.444972537567, 5751.424857514216, 5758.1650660654805, 5759.94240057594, 5763.942360576509], "unit": "ms", "name": "prototype.html", "value": 4378.311367664871}, {"lowerIsBetter": false, "replicates": [787.7400457848906, 794.4756460735914, 806.1535387842764, 806.548332933557, 833.7957200485882, 12038.81941770873, 12313.322767247797, 13946.86053139467, 14066.578002659911, 14175.078619889726, 12371.814422783666, 12526.373681315921, 12548.0, 12549.247045177295, 12609.054320925921, 807.3420162567503, 813.6704634622987, 818.4639061414783, 819.1358117186365, 821.0270829067574, 770.7572114783853, 815.2703330519182, 831.1397703377006, 832.0473058348218, 835.8955130608674, 841.3017195727532, 846.196113691992, 846.9745907622781, 851.9062903080656, 855.341387131908, 841.4026041510535, 846.0777752250046, 846.4667259626458, 848.2492993700557, 849.8725191221336, 621.9004959206505, 624.2103738770459, 625.0624063904144, 626.1546911669255, 626.4268194601934, 12638.49446022158, 12758.04314676403, 12777.488900443972, 12782.233066015975, 12791.48834046637, 10777.83833242502, 10870.61952831655, 11283.66149015531, 11482.540698372055, 12094.0, 9047.411918225294, 9234.215091717213, 9244.197381510608, 9259.166674999215, 9277.35058545902, 3181.522771584258, 3210.2776875203126, 3240.708336249725, 3265.6081270247487, 3292.0453068610072, 40835.120663537215, 41143.588564114274, 41239.38140927888, 41385.586144138775, 41617.0, 9413.952930235306, 9596.840710840004, 9678.854817177747, 9688.70933871971, 9759.609615615296, 16238.269277882524, 16248.918755406385, 16317.265723042492, 16383.09892955875, 16404.6719065618, 6104.236970378703, 6166.568340216142, 6239.532035097386, 6286.591371560834, 6393.840153996094, 3686.8525258989876, 3709.3694072007825, 3715.071232191952, 3724.9068773280883, 3729.9627003730157, 2755.3662657588866, 2782.5130602144545, 2786.651668541432, 2787.3449739311245, 2787.9860600696866, 452.19509273493236, 454.6181207785476, 460.7350773305296, 460.8962983328791, 466.126013724267, 431.51454613559747, 431.92225399428406, 458.95181005994556, 460.9331646911246, 535.5394360849666, 6597.47220222381, 6890.621015844076, 7054.417228636009, 7095.0, 7202.279772022755, 449.36414972813105, 486.46488862251243, 512.5259135299833, 544.7793643574358, 549.3599956051156, 3247.967520324814, 3474.42671959129, 3565.982170089133, 3582.0686621478603, 3883.126296583246, 47889.0, 47941.04117917622, 47948.760256199195, 53358.199627005626, 55700.16449753257, 45915.311270330974, 46652.3002154968, 46849.0, 46908.76545617318, 47287.290690638976, 42705.0, 43445.13109737851, 44357.556424435985, 44572.55427445749, 44635.33047004297, 7407.407407407502, 7521.05986751656, 7639.236076392316, 7692.7692169235015, 7909.129995700353, 29605.25986850346, 29891.402171956874, 30141.397172056873, 30217.848910755307, 30546.694533054386, 38954.2209155821, 39207.80396098001, 39322.410163846995, 39772.0, 40324.3951340736, 10566.682999510027, 10625.840612390975, 10691.358518488916, 10723.839142413026, 10815.945920270347, 11440.942795286302, 11535.134864885335, 11600.361980091177, 11602.88397116018, 11682.0, 9386.15524602789, 9542.379745316532, 10681.092107170978, 10682.946585267024, 10717.9464102679, 10608.257421980696, 10915.0, 11144.2199046066, 11311.547538098714, 11411.54353825871, 10103.7474063149, 10274.794504110025, 10490.580376784843, 10496.265261431627, 10500.159987200852, 9254.629814807333, 9424.434533927712, 9466.0, 9570.282228832726, 9593.472359020041, 8031.437799353989, 8358.289545388467, 8428.241458268785, 8607.784805379915, 8712.433691810265], "unit": "ms", "name": "yui.html", "value": 5742.207865080358}], "name": "dromaeo_css", "value": 6380.552904181524}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 119.0, 114.0, 112.0, 114.0, 125.0, 113.0, 112.0, 113.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 166.0, 164.0, 142.0, 164.0, 163.0, 131.0, 171.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 165.0, 162.0, 163.0, 165.0, 165.0, 160.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 75.0, 132.0, 72.0, 72.0, 72.0, 72.0, 88.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 136.0, 94.0, 94.0, 95.0, 143.0, 96.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 148.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 75.0, 74.0, 76.0, 74.0, 74.0, 75.0, 76.0, 78.0], "unit": "ms", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 91.0, 85.0, 82.0, 83.0, 85.0, 83.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 123.0, 127.0, 124.0, 128.0, 128.0, 130.0, 129.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 149.0, 146.0, 156.0, 149.0, 147.0, 149.0, 148.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 73.0, 69.0, 69.0, 69.0, 68.0, 70.0, 68.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1541.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [184.29782528566162], "unit": "score", "name": "DeltaBlue", "value": 358.7562680000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [614.1104294478528], "unit": "score", "name": "Splay", "value": 132.69763236763237}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21323.44197531661}]} 04:11:51 INFO - RETURN: dromaeo_css: 6380.55 04:11:51 INFO - RETURN: kraken: 1541.90 04:11:51 INFO - RETURN: v8_7: 21323.44 04:11:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21323.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1541.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6380.55"}}} 04:11:51 INFO - Return code: 0 04:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:11:51 INFO - # TBPL SUCCESS # 04:11:51 INFO - Running post-action listener: _resource_record_post_action 04:11:51 INFO - Running post-run listener: _resource_record_post_run 04:11:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 3153920; Write bytes: 277467136; Read time: 1240; Write time: 128496 04:11:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4661248; Read time: 0; Write time: 304 04:11:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 3153920; Write bytes: 271941632; Read time: 1240; Write time: 128188 04:11:52 INFO - Running post-run listener: _upload_blobber_files 04:11:52 INFO - Blob upload gear active. 04:11:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:11:52 INFO - Copying logs to upload dir... 04:11:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.621784 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-11 04:11:52.683061) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:52.686980) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009955 build_url: 'https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/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-11 04:11:52.741462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:52.741929) ========= 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=21869f6c619b95355032545b000001da-1449833387.411098-1708323376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:52.793682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:11:52.794147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:11:52.794470) ========= ========= Total master_lag: 0.28 =========