builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1448558686.25 results: success (0) buildid: 20151126075510 builduid: f477684d07c94501a41f725dcaef228f revision: 74c7941a9e22d50057800771ebae07f69deecc9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.251226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.251645) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.251925) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.269870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.270164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.277797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.278079) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004173 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.326039) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.326341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.326680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.326941) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 09:24:46-- 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% 33.4M=0s 2015-11-26 09:24:46 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.438124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.438440) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020342 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:46.488421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 09:24:46.488764) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 74c7941a9e22d50057800771ebae07f69deecc9f --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 74c7941a9e22d50057800771ebae07f69deecc9f --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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 09:24:47,016 truncating revision to first 12 chars 2015-11-26 09:24:47,016 Setting DEBUG logging. 2015-11-26 09:24:47,016 attempt 1/10 2015-11-26 09:24:47,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/74c7941a9e22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 09:24:48,276 unpacking tar archive at: mozilla-central-74c7941a9e22/testing/mozharness/ program finished with exit code 0 elapsedTime=1.854780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 09:24:48.356285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:48.356612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:48.364133) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:48.364403) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:24:48.364796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-26 09:24:48.365070) ========= /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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:48 INFO - MultiFileLogger online at 20151126 09:24:48 in /builds/slave/test 09:24:48 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 09:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:48 INFO - {'append_to_log': False, 09:24:48 INFO - 'base_work_dir': '/builds/slave/test', 09:24:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:48 INFO - 'branch': 'Firefox-Non-PGO', 09:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:48 INFO - 'config_files': ('talos/linux_config.py',), 09:24:48 INFO - 'default_actions': ('clobber', 09:24:48 INFO - 'read-buildbot-config', 09:24:48 INFO - 'download-and-extract', 09:24:48 INFO - 'populate-webroot', 09:24:48 INFO - 'create-virtualenv', 09:24:48 INFO - 'install', 09:24:48 INFO - 'run-tests'), 09:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:48 INFO - 'download_minidump_stackwalk': True, 09:24:48 INFO - 'download_symbols': 'ondemand', 09:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:48 INFO - 'installer_path': 'installer.exe', 09:24:48 INFO - 'log_level': 'info', 09:24:48 INFO - 'log_name': 'talos', 09:24:48 INFO - 'log_to_console': True, 09:24:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:48 INFO - 'opt_config_files': (), 09:24:48 INFO - 'pip_index': False, 09:24:48 INFO - 'sps_profile': False, 09:24:48 INFO - 'sps_profile_interval': 0, 09:24:48 INFO - 'suite': 'dromaeojs-e10s', 09:24:48 INFO - 'system_bits': '64', 09:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:48 INFO - 'title': 'talos-linux64-ix-037', 09:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:48 INFO - 'use_talos_json': True, 09:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:48 INFO - 'work_dir': 'build'} 09:24:48 INFO - ##### 09:24:48 INFO - ##### Running clobber step. 09:24:48 INFO - ##### 09:24:48 INFO - Running pre-action listener: _resource_record_pre_action 09:24:48 INFO - Running main action method: clobber 09:24:48 INFO - rmtree: /builds/slave/test/build 09:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:49 INFO - Running post-action listener: _resource_record_post_action 09:24:49 INFO - ##### 09:24:49 INFO - ##### Running read-buildbot-config step. 09:24:49 INFO - ##### 09:24:49 INFO - Running pre-action listener: _resource_record_pre_action 09:24:49 INFO - Running main action method: read_buildbot_config 09:24:49 INFO - Using buildbot properties: 09:24:49 INFO - { 09:24:49 INFO - "properties": { 09:24:49 INFO - "buildnumber": 104, 09:24:49 INFO - "product": "firefox", 09:24:49 INFO - "script_repo_revision": "production", 09:24:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:24:49 INFO - "repository": "", 09:24:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:24:49 INFO - "buildid": "20151126075510", 09:24:49 INFO - "slavename": "talos-linux64-ix-037", 09:24:49 INFO - "pgo_build": "False", 09:24:49 INFO - "basedir": "/builds/slave/test", 09:24:49 INFO - "project": "", 09:24:49 INFO - "platform": "ubuntu64_hw", 09:24:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:24:49 INFO - "slavebuilddir": "test", 09:24:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:24:49 INFO - "branch": "mozilla-central", 09:24:49 INFO - "repo_path": "mozilla-central", 09:24:49 INFO - "stage_platform": "linux64", 09:24:49 INFO - "builduid": "f477684d07c94501a41f725dcaef228f", 09:24:49 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:24:49 INFO - }, 09:24:49 INFO - "sourcestamp": { 09:24:49 INFO - "repository": "", 09:24:49 INFO - "hasPatch": false, 09:24:49 INFO - "project": "", 09:24:49 INFO - "branch": "mozilla-central-linux64-talos", 09:24:49 INFO - "changes": [ 09:24:49 INFO - { 09:24:49 INFO - "category": null, 09:24:49 INFO - "files": [ 09:24:49 INFO - { 09:24:49 INFO - "url": null, 09:24:49 INFO - "name": "https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:24:49 INFO - } 09:24:49 INFO - ], 09:24:49 INFO - "repository": "", 09:24:49 INFO - "rev": "74c7941a9e22d50057800771ebae07f69deecc9f", 09:24:49 INFO - "who": "cbook@mozilla.com", 09:24:49 INFO - "when": 1448558386, 09:24:49 INFO - "number": 6711725, 09:24:49 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 09:24:49 INFO - "project": "", 09:24:49 INFO - "at": "Thu 26 Nov 2015 09:19:46", 09:24:49 INFO - "branch": "mozilla-central-linux64-talos", 09:24:49 INFO - "revlink": "", 09:24:49 INFO - "properties": [ 09:24:49 INFO - [ 09:24:49 INFO - "buildid", 09:24:49 INFO - "20151126075510", 09:24:49 INFO - "Change" 09:24:49 INFO - ], 09:24:49 INFO - [ 09:24:49 INFO - "builduid", 09:24:49 INFO - "f477684d07c94501a41f725dcaef228f", 09:24:49 INFO - "Change" 09:24:49 INFO - ], 09:24:49 INFO - [ 09:24:49 INFO - "pgo_build", 09:24:49 INFO - "False", 09:24:49 INFO - "Change" 09:24:49 INFO - ] 09:24:49 INFO - ], 09:24:49 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:24:49 INFO - } 09:24:49 INFO - ], 09:24:49 INFO - "revision": "74c7941a9e22d50057800771ebae07f69deecc9f" 09:24:49 INFO - } 09:24:49 INFO - } 09:24:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:24:49 INFO - Running post-action listener: _resource_record_post_action 09:24:49 INFO - ##### 09:24:49 INFO - ##### Running download-and-extract step. 09:24:49 INFO - ##### 09:24:49 INFO - Running pre-action listener: _resource_record_pre_action 09:24:49 INFO - Running main action method: download_and_extract 09:24:49 INFO - mkdir: /builds/slave/test/build/tests 09:24: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')]} 09:24:49 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json 09:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json 09:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:24:50 INFO - Downloaded 1302 bytes. 09:24:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:24:50 INFO - Using the following test package requirements: 09:24:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'jsshell-linux-x86_64.zip'], 09:24:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:24:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:24:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:50 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')]} 09:24:50 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:51 INFO - Downloaded 21515050 bytes. 09:24:51 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 09:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:51 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 09:24:52 INFO - Return code: 0 09:24:52 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 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:53 INFO - Downloaded 21515050 bytes. 09:24:53 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 09:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:24:53 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 09:24:54 INFO - Return code: 0 09:24:54 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')]} 09:24:54 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:55 INFO - Downloaded 11131728 bytes. 09:24:55 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 09:24:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:55 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 09:24:55 INFO - Return code: 0 09:24: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')]} 09:24:55 INFO - https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oawcYVwyQDqGhph_EZhpJg/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 09:24:57 INFO - Downloaded 56868239 bytes. 09:24:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:24:57 INFO - mkdir: /builds/slave/test/properties 09:24:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:57 INFO - Contents: 09:24:57 INFO - build_url:https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:24:57 INFO - Running post-action listener: _resource_record_post_action 09:24:57 INFO - Running post-action listener: set_extra_try_arguments 09:24:57 INFO - ##### 09:24:57 INFO - ##### Running populate-webroot step. 09:24:57 INFO - ##### 09:24:57 INFO - Running pre-action listener: _resource_record_pre_action 09:24:57 INFO - Running main action method: populate_webroot 09:24:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:24:57 INFO - '../fennec_ids.txt'], 09:24:57 INFO - 'tests': ['tcheck2']}, 09:24:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:57 INFO - '--tppagecycles', 09:24:57 INFO - '7'], 09:24:57 INFO - 'tests': ['tsvgm']}}, 09:24:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:24:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:24:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:24:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'tests': ['damp', 'tps']}, 09:24:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['damp', 'tps']}, 09:24:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:24:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:57 INFO - 'other': {'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'other_l64': {'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:24:57 INFO - 'ts_paint', 09:24:57 INFO - 'tpaint', 09:24:57 INFO - 'sessionrestore', 09:24:57 INFO - 'sessionrestore_no_auto_restore']}, 09:24:57 INFO - 'svgr': {'tests': ['tsvgx', 09:24:57 INFO - 'tsvgr_opacity', 09:24:57 INFO - 'tart', 09:24:57 INFO - 'tscrollx', 09:24:57 INFO - 'cart']}, 09:24:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['tsvgx', 09:24:57 INFO - 'tsvgr_opacity', 09:24:57 INFO - 'tart', 09:24:57 INFO - 'tscrollx', 09:24:57 INFO - 'cart']}, 09:24:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'tests': ['tp5o']}, 09:24:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'talos_options': ['--e10s'], 09:24:57 INFO - 'tests': ['tp5o']}, 09:24:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'talos_options': ['--xperf_path', 09:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:57 INFO - 'tests': ['tp5n']}, 09:24:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:57 INFO - 'talos_options': ['--e10s', 09:24:57 INFO - '--xperf_path', 09:24:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:57 INFO - 'tests': ['tp5n']}}, 09:24:57 INFO - 'talos.zip': {'path': '', 09:24:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:57 INFO - Running post-action listener: _resource_record_post_action 09:24:57 INFO - ##### 09:24:57 INFO - ##### Running create-virtualenv step. 09:24:57 INFO - ##### 09:24:57 INFO - Running pre-action listener: _resource_record_pre_action 09:24:57 INFO - Running main action method: create_virtualenv 09:24:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:57 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 09:24:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:57 INFO - Using real prefix '/usr' 09:24:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:59 INFO - Installing pip.................done. 09:24:59 INFO - Return code: 0 09:24:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:24:59 INFO - Using env: {'DISPLAY': ':0', 09:24:59 INFO - 'HOME': '/home/cltbld', 09:24:59 INFO - 'LANG': 'en_US.UTF-8', 09:24:59 INFO - 'LANGUAGE': 'en_US:en', 09:24:59 INFO - 'LOGNAME': 'cltbld', 09:24:59 INFO - 'MAIL': '/var/mail/cltbld', 09:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:59 INFO - 'MOZ_NO_REMOTE': '1', 09:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:59 INFO - 'NO_EM_RESTART': '1', 09:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:59 INFO - 'PWD': '/builds/slave/test', 09:24:59 INFO - 'SHELL': '/bin/bash', 09:24:59 INFO - 'SHLVL': '1', 09:24:59 INFO - 'TERM': 'linux', 09:24:59 INFO - 'TMOUT': '86400', 09:24:59 INFO - 'USER': 'cltbld', 09:24:59 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:59 INFO - '_': '/tools/buildbot/bin/python'} 09:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:59 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 09:24:59 INFO - Cleaning up... 09:24:59 INFO - Return code: 0 09:24:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:24:59 INFO - Using env: {'DISPLAY': ':0', 09:24:59 INFO - 'HOME': '/home/cltbld', 09:24:59 INFO - 'LANG': 'en_US.UTF-8', 09:24:59 INFO - 'LANGUAGE': 'en_US:en', 09:24:59 INFO - 'LOGNAME': 'cltbld', 09:24:59 INFO - 'MAIL': '/var/mail/cltbld', 09:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:59 INFO - 'MOZ_NO_REMOTE': '1', 09:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:59 INFO - 'NO_EM_RESTART': '1', 09:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:59 INFO - 'PWD': '/builds/slave/test', 09:24:59 INFO - 'SHELL': '/bin/bash', 09:24:59 INFO - 'SHLVL': '1', 09:24:59 INFO - 'TERM': 'linux', 09:24:59 INFO - 'TMOUT': '86400', 09:24:59 INFO - 'USER': 'cltbld', 09:24:59 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:59 INFO - '_': '/tools/buildbot/bin/python'} 09:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:00 INFO - Downloading/unpacking psutil>=0.7.1 09:25:00 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 09:25:00 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 09:25:00 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 09:25:00 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 09:25:00 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 09:25:00 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 09:25:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:01 INFO - Installing collected packages: psutil 09:25:01 INFO - Running setup.py install for psutil 09:25:01 INFO - building 'psutil._psutil_linux' extension 09:25:01 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 09:25:02 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 09:25:02 INFO - building 'psutil._psutil_posix' extension 09:25:02 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 09:25:02 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 09:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:02 INFO - Successfully installed psutil 09:25:02 INFO - Cleaning up... 09:25:02 INFO - Return code: 0 09:25:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:25:02 INFO - Using env: {'DISPLAY': ':0', 09:25:02 INFO - 'HOME': '/home/cltbld', 09:25:02 INFO - 'LANG': 'en_US.UTF-8', 09:25:02 INFO - 'LANGUAGE': 'en_US:en', 09:25:02 INFO - 'LOGNAME': 'cltbld', 09:25:02 INFO - 'MAIL': '/var/mail/cltbld', 09:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:02 INFO - 'MOZ_NO_REMOTE': '1', 09:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:02 INFO - 'NO_EM_RESTART': '1', 09:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:02 INFO - 'PWD': '/builds/slave/test', 09:25:02 INFO - 'SHELL': '/bin/bash', 09:25:02 INFO - 'SHLVL': '1', 09:25:02 INFO - 'TERM': 'linux', 09:25:02 INFO - 'TMOUT': '86400', 09:25:02 INFO - 'USER': 'cltbld', 09:25:02 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:02 INFO - '_': '/tools/buildbot/bin/python'} 09:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:25:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:25:04 INFO - Installing collected packages: mozsystemmonitor 09:25:04 INFO - Running setup.py install for mozsystemmonitor 09:25:04 INFO - Successfully installed mozsystemmonitor 09:25:04 INFO - Cleaning up... 09:25:04 INFO - Return code: 0 09:25:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:04 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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:04 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 09:25:04 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 09:25:04 INFO - Using env: {'DISPLAY': ':0', 09:25:04 INFO - 'HOME': '/home/cltbld', 09:25:04 INFO - 'LANG': 'en_US.UTF-8', 09:25:04 INFO - 'LANGUAGE': 'en_US:en', 09:25:04 INFO - 'LOGNAME': 'cltbld', 09:25:04 INFO - 'MAIL': '/var/mail/cltbld', 09:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:04 INFO - 'MOZ_NO_REMOTE': '1', 09:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:04 INFO - 'NO_EM_RESTART': '1', 09:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:04 INFO - 'PWD': '/builds/slave/test', 09:25:04 INFO - 'SHELL': '/bin/bash', 09:25:04 INFO - 'SHLVL': '1', 09:25:04 INFO - 'TERM': 'linux', 09:25:04 INFO - 'TMOUT': '86400', 09:25:04 INFO - 'USER': 'cltbld', 09:25:04 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:04 INFO - '_': '/tools/buildbot/bin/python'} 09:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:07 INFO - Downloading docopt-0.6.1.tar.gz 09:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:07 INFO - Running setup.py install for blobuploader 09:25:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:07 INFO - Running setup.py install for requests 09:25:07 INFO - Running setup.py install for docopt 09:25:07 INFO - Successfully installed blobuploader requests docopt 09:25:07 INFO - Cleaning up... 09:25:07 INFO - Return code: 0 09:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:07 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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:07 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 09:25:07 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 09:25:07 INFO - Using env: {'DISPLAY': ':0', 09:25:07 INFO - 'HOME': '/home/cltbld', 09:25:07 INFO - 'LANG': 'en_US.UTF-8', 09:25:07 INFO - 'LANGUAGE': 'en_US:en', 09:25:07 INFO - 'LOGNAME': 'cltbld', 09:25:07 INFO - 'MAIL': '/var/mail/cltbld', 09:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:07 INFO - 'MOZ_NO_REMOTE': '1', 09:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:07 INFO - 'NO_EM_RESTART': '1', 09:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:07 INFO - 'PWD': '/builds/slave/test', 09:25:07 INFO - 'SHELL': '/bin/bash', 09:25:07 INFO - 'SHLVL': '1', 09:25:07 INFO - 'TERM': 'linux', 09:25:07 INFO - 'TMOUT': '86400', 09:25:07 INFO - 'USER': 'cltbld', 09:25:07 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:07 INFO - '_': '/tools/buildbot/bin/python'} 09:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:07 INFO - Running setup.py (path:/tmp/pip-N7v_7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:08 INFO - Running setup.py (path:/tmp/pip-f5uBlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:08 INFO - Running setup.py (path:/tmp/pip-1uqAAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:08 INFO - Running setup.py (path:/tmp/pip-pAuWzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:08 INFO - Running setup.py (path:/tmp/pip-XtiGUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:08 INFO - Running setup.py (path:/tmp/pip-5bAsBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:08 INFO - Running setup.py (path:/tmp/pip-hqJ1fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:08 INFO - Running setup.py (path:/tmp/pip-O6IeJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:08 INFO - Running setup.py (path:/tmp/pip-jegWUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:08 INFO - Running setup.py (path:/tmp/pip-spjcRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:08 INFO - Running setup.py (path:/tmp/pip-xf2xUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:08 INFO - Running setup.py (path:/tmp/pip-WZYJyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:08 INFO - Running setup.py (path:/tmp/pip-JFvhTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:08 INFO - Running setup.py (path:/tmp/pip-OX_veR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:08 INFO - Running setup.py (path:/tmp/pip-NNX0Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:09 INFO - Running setup.py (path:/tmp/pip-sv4gno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:09 INFO - Running setup.py (path:/tmp/pip-Qc2I0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:09 INFO - Running setup.py install for manifestparser 09:25:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozcrash 09:25:09 INFO - Running setup.py install for mozdebug 09:25:09 INFO - Running setup.py install for mozdevice 09:25:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozfile 09:25:09 INFO - Running setup.py install for mozhttpd 09:25:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozinfo 09:25:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozInstall 09:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:09 INFO - Running setup.py install for mozleak 09:25:10 INFO - Running setup.py install for mozlog 09:25:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for moznetwork 09:25:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for mozprocess 09:25:10 INFO - Running setup.py install for mozprofile 09:25:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for mozrunner 09:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Running setup.py install for mozscreenshot 09:25:10 INFO - Running setup.py install for moztest 09:25:10 INFO - Running setup.py install for mozversion 09:25:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:10 INFO - Cleaning up... 09:25:10 INFO - Return code: 0 09:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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/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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25: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/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 09:25: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/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 09:25:10 INFO - Using env: {'DISPLAY': ':0', 09:25:10 INFO - 'HOME': '/home/cltbld', 09:25:10 INFO - 'LANG': 'en_US.UTF-8', 09:25:10 INFO - 'LANGUAGE': 'en_US:en', 09:25:10 INFO - 'LOGNAME': 'cltbld', 09:25:10 INFO - 'MAIL': '/var/mail/cltbld', 09:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:10 INFO - 'MOZ_NO_REMOTE': '1', 09:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:10 INFO - 'NO_EM_RESTART': '1', 09:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:10 INFO - 'PWD': '/builds/slave/test', 09:25:10 INFO - 'SHELL': '/bin/bash', 09:25:10 INFO - 'SHLVL': '1', 09:25:10 INFO - 'TERM': 'linux', 09:25:10 INFO - 'TMOUT': '86400', 09:25:10 INFO - 'USER': 'cltbld', 09:25:10 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:10 INFO - '_': '/tools/buildbot/bin/python'} 09:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:11 INFO - Running setup.py (path:/tmp/pip-vQ7KUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:11 INFO - Running setup.py (path:/tmp/pip-U1espA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:11 INFO - Running setup.py (path:/tmp/pip-WMcm0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:11 INFO - Running setup.py (path:/tmp/pip-yw4w3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:11 INFO - Running setup.py (path:/tmp/pip-Tho3Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:11 INFO - Running setup.py (path:/tmp/pip-EzEvo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:11 INFO - Running setup.py (path:/tmp/pip-WXFSNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:11 INFO - Running setup.py (path:/tmp/pip-lqlJrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:11 INFO - Running setup.py (path:/tmp/pip-wSuEW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:11 INFO - Running setup.py (path:/tmp/pip-gJDbyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:11 INFO - Running setup.py (path:/tmp/pip-N1m0Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:11 INFO - Running setup.py (path:/tmp/pip-n7h_CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:11 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)) 09:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:12 INFO - Running setup.py (path:/tmp/pip-Xn0l9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:12 INFO - Running setup.py (path:/tmp/pip-BEtkZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:12 INFO - Running setup.py (path:/tmp/pip-SH0jPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:12 INFO - Running setup.py (path:/tmp/pip-Yd0NPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:12 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)) 09:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:12 INFO - Running setup.py (path:/tmp/pip-jtq2F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:12 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)) 09:25:12 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)) 09:25:12 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)) 09:25:12 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)) 09:25:12 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)) 09:25:12 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)) 09:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:14 INFO - Downloading blessings-1.5.1.tar.gz 09:25:14 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 09:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:14 INFO - Installing collected packages: blessings 09:25:14 INFO - Running setup.py install for blessings 09:25:14 INFO - Successfully installed blessings 09:25:14 INFO - Cleaning up... 09:25:14 INFO - Return code: 0 09:25:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:14 INFO - Reading from file tmpfile_stdout 09:25:14 INFO - Current package versions: 09:25:14 INFO - argparse == 1.2.1 09:25:14 INFO - blessings == 1.5.1 09:25:14 INFO - blobuploader == 1.2.4 09:25:14 INFO - docopt == 0.6.1 09:25:14 INFO - manifestparser == 1.1 09:25:14 INFO - mozInstall == 1.12 09:25:14 INFO - mozcrash == 0.16 09:25:14 INFO - mozdebug == 0.1 09:25:14 INFO - mozdevice == 0.47 09:25:14 INFO - mozfile == 1.2 09:25:14 INFO - mozhttpd == 0.7 09:25:14 INFO - mozinfo == 0.9 09:25:14 INFO - mozleak == 0.1 09:25:14 INFO - mozlog == 3.1 09:25:14 INFO - moznetwork == 0.27 09:25:14 INFO - mozprocess == 0.22 09:25:14 INFO - mozprofile == 0.27 09:25:14 INFO - mozrunner == 6.11 09:25:14 INFO - mozscreenshot == 0.1 09:25:14 INFO - mozsystemmonitor == 0.0 09:25:14 INFO - moztest == 0.7 09:25:14 INFO - mozversion == 1.4 09:25:14 INFO - psutil == 3.1.1 09:25:14 INFO - requests == 1.2.3 09:25:14 INFO - wsgiref == 0.1.2 09:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:14 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')]} 09:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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')]} 09:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:14 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 09:25:14 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 09:25:14 INFO - Using env: {'DISPLAY': ':0', 09:25:14 INFO - 'HOME': '/home/cltbld', 09:25:14 INFO - 'LANG': 'en_US.UTF-8', 09:25:14 INFO - 'LANGUAGE': 'en_US:en', 09:25:14 INFO - 'LOGNAME': 'cltbld', 09:25:14 INFO - 'MAIL': '/var/mail/cltbld', 09:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:14 INFO - 'MOZ_NO_REMOTE': '1', 09:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:14 INFO - 'NO_EM_RESTART': '1', 09:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:14 INFO - 'PWD': '/builds/slave/test', 09:25:14 INFO - 'SHELL': '/bin/bash', 09:25:14 INFO - 'SHLVL': '1', 09:25:14 INFO - 'TERM': 'linux', 09:25:14 INFO - 'TMOUT': '86400', 09:25:14 INFO - 'USER': 'cltbld', 09:25:14 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:14 INFO - '_': '/tools/buildbot/bin/python'} 09:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 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)) 09:25:14 INFO - Cleaning up... 09:25:14 INFO - Return code: 0 09:25:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:14 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')]} 09:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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')]} 09:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:14 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 09:25:14 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 09:25:14 INFO - Using env: {'DISPLAY': ':0', 09:25:14 INFO - 'HOME': '/home/cltbld', 09:25:14 INFO - 'LANG': 'en_US.UTF-8', 09:25:14 INFO - 'LANGUAGE': 'en_US:en', 09:25:14 INFO - 'LOGNAME': 'cltbld', 09:25:14 INFO - 'MAIL': '/var/mail/cltbld', 09:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:14 INFO - 'MOZ_NO_REMOTE': '1', 09:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:14 INFO - 'NO_EM_RESTART': '1', 09:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:14 INFO - 'PWD': '/builds/slave/test', 09:25:14 INFO - 'SHELL': '/bin/bash', 09:25:14 INFO - 'SHLVL': '1', 09:25:14 INFO - 'TERM': 'linux', 09:25:14 INFO - 'TMOUT': '86400', 09:25:14 INFO - 'USER': 'cltbld', 09:25:14 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:14 INFO - '_': '/tools/buildbot/bin/python'} 09:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:14 INFO - Downloading/unpacking jsonschema 09:25:14 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 09:25:14 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 09:25:14 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 09:25:14 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 09:25:14 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 09:25:14 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 09:25:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:16 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 09:25:16 INFO - Downloading/unpacking functools32 (from jsonschema) 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 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 09:25:16 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:16 INFO - warning: no files found matching '*.txt' 09:25:16 INFO - no previously-included directories found matching 'build' 09:25:16 INFO - no previously-included directories found matching 'dist' 09:25:16 INFO - no previously-included directories found matching '.git*' 09:25:16 INFO - Installing collected packages: jsonschema, functools32 09:25:16 INFO - Running setup.py install for functools32 09:25:17 INFO - warning: no files found matching '*.txt' 09:25:17 INFO - no previously-included directories found matching 'build' 09:25:17 INFO - no previously-included directories found matching 'dist' 09:25:17 INFO - no previously-included directories found matching '.git*' 09:25:17 INFO - Successfully installed jsonschema functools32 09:25:17 INFO - Cleaning up... 09:25:17 INFO - Return code: 0 09:25:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:17 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 0x7f5d8e8c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', '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 09:25:17 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 09:25:17 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 09:25:17 INFO - Using env: {'DISPLAY': ':0', 09:25:17 INFO - 'HOME': '/home/cltbld', 09:25:17 INFO - 'LANG': 'en_US.UTF-8', 09:25:17 INFO - 'LANGUAGE': 'en_US:en', 09:25:17 INFO - 'LOGNAME': 'cltbld', 09:25:17 INFO - 'MAIL': '/var/mail/cltbld', 09:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:17 INFO - 'MOZ_NO_REMOTE': '1', 09:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:17 INFO - 'NO_EM_RESTART': '1', 09:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:17 INFO - 'PWD': '/builds/slave/test', 09:25:17 INFO - 'SHELL': '/bin/bash', 09:25:17 INFO - 'SHLVL': '1', 09:25:17 INFO - 'TERM': 'linux', 09:25:17 INFO - 'TMOUT': '86400', 09:25:17 INFO - 'USER': 'cltbld', 09:25:17 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:17 INFO - '_': '/tools/buildbot/bin/python'} 09:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:17 INFO - Downloading/unpacking flake8 09:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:25:18 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 09:25:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:25:19 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 09:25:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 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 09:25:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:19 INFO - no previously-included directories found matching 'docs/_build' 09:25:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:25:19 INFO - Running setup.py install for pep8 09:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:19 INFO - no previously-included directories found matching 'docs/_build' 09:25:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:25:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:25:19 INFO - Cleaning up... 09:25:19 INFO - Return code: 0 09:25:19 INFO - Running post-action listener: _resource_record_post_action 09:25:19 INFO - Running post-action listener: _start_resource_monitoring 09:25:19 INFO - Starting resource monitoring. 09:25:19 INFO - ##### 09:25:19 INFO - ##### Running install step. 09:25:19 INFO - ##### 09:25:19 INFO - Running pre-action listener: _resource_record_pre_action 09:25:19 INFO - Running main action method: install 09:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:20 INFO - Reading from file tmpfile_stdout 09:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:20 INFO - Reading from file tmpfile_stdout 09:25:20 INFO - Output received: 09:25:20 INFO - Usage: mozinstall [options] installer 09:25:20 INFO - Options: 09:25:20 INFO - -h, --help show this help message and exit 09:25:20 INFO - -d DEST, --destination=DEST 09:25:20 INFO - Directory to install application into. [default: 09:25:20 INFO - "/builds/slave/test"] 09:25:20 INFO - --app=APP Application being installed. [default: firefox] 09:25:20 INFO - mkdir: /builds/slave/test/build/application 09:25:20 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'] 09:25:20 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 09:25:34 INFO - Reading from file tmpfile_stdout 09:25:34 INFO - Output received: 09:25:34 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:34 INFO - Running post-action listener: _resource_record_post_action 09:25:34 INFO - ##### 09:25:34 INFO - ##### Running run-tests step. 09:25:34 INFO - ##### 09:25:34 INFO - Running pre-action listener: _resource_record_pre_action 09:25:34 INFO - Running main action method: run_tests 09:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:34 INFO - Python 2.7.3 09:25:34 INFO - Return code: 0 09:25:34 INFO - grabbing minidump binary from tooltool 09:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:34 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 0x26850b0>, '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 0x2685fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2686440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:34 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 09:25:34 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 09:25:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:34 INFO - Return code: 0 09:25:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:25:35 INFO - Return code: 0 09:25:35 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/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test/build 09:25:35 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/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 09:25:35 INFO - Using env: {'DISPLAY': ':0', 09:25:35 INFO - 'HOME': '/home/cltbld', 09:25:35 INFO - 'LANG': 'en_US.UTF-8', 09:25:35 INFO - 'LANGUAGE': 'en_US:en', 09:25:35 INFO - 'LOGNAME': 'cltbld', 09:25:35 INFO - 'MAIL': '/var/mail/cltbld', 09:25:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:35 INFO - 'MOZ_NO_REMOTE': '1', 09:25:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:35 INFO - 'NO_EM_RESTART': '1', 09:25:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:35 INFO - 'PWD': '/builds/slave/test', 09:25:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:35 INFO - 'SHELL': '/bin/bash', 09:25:35 INFO - 'SHLVL': '1', 09:25:35 INFO - 'TERM': 'linux', 09:25:35 INFO - 'TMOUT': '86400', 09:25:35 INFO - 'USER': 'cltbld', 09:25:35 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732', 09:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:35 INFO - '_': '/tools/buildbot/bin/python'} 09:25:35 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/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 09:25:35 INFO - mozversion INFO | application_buildid: 20151126075510 09:25:35 INFO - mozversion INFO | application_changeset: 74c7941a9e22d50057800771ebae07f69deecc9f 09:25:35 INFO - mozversion INFO | application_display_name: Nightly 09:25:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:35 INFO - mozversion INFO | application_name: Firefox 09:25:35 INFO - mozversion INFO | application_remotingname: firefox 09:25:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:25:35 INFO - mozversion INFO | application_vendor: Mozilla 09:25:35 INFO - mozversion INFO | application_version: 45.0a1 09:25:35 INFO - mozversion INFO | platform_buildid: 20151126075510 09:25:35 INFO - mozversion INFO | platform_changeset: 74c7941a9e22d50057800771ebae07f69deecc9f 09:25:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:25:35 INFO - mozversion INFO | platform_version: 45.0a1 09:25:35 INFO - 2015-11-26 09:25:35,677 DEBUG : using testdate: 1448558735 09:25:35 INFO - 2015-11-26 09:25:35,677 DEBUG : actual date: 1448558735 09:25:35 INFO - 2015-11-26 09:25:35,768 INFO : starting webserver on 'localhost:39707' 09:25:35 INFO - 2015-11-26 09:25:35,769 INFO : Starting test suite talos-linux64-ix-037.e 09:25:35 INFO - 2015-11-26 09:25:35,770 INFO : Starting test dromaeo_css 09:25:35 INFO - 2015-11-26 09:25:35,770 DEBUG : operating with platform_type : linux_ 09:25:35 INFO - 2015-11-26 09:25:35,770 INFO : Initialising browser for dromaeo_css test... 09:25:35 INFO - 2015-11-26 09:25:35,787 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjR98k/profile http://localhost:39707/getInfo.html 09:25:40 INFO - 2015-11-26 09:25:40,338 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:25:40 INFO - 2015-11-26 09:25:40,338 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:25:40 INFO - 2015-11-26 09:25:40,338 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:25:40 INFO - 2015-11-26 09:25:40,338 DEBUG : BROWSER_OUTPUT: __metrics 09:25:41 INFO - 2015-11-26 09:25:41,425 INFO : Browser initialized. 09:25:41 INFO - 2015-11-26 09:25:41,426 INFO : Running cycle 1/1 for dromaeo_css test... 09:25:41 INFO - 2015-11-26 09:25:41,426 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjR98k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:25:53 INFO - 2015-11-26 09:25:53,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 139960320 09:25:53 INFO - 2015-11-26 09:25:53,299 DEBUG : BROWSER_OUTPUT: 09:26:42 INFO - 2015-11-26 09:26:42,936 DEBUG : BROWSER_OUTPUT: 1448558802930 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] 09:28:54 INFO - 2015-11-26 09:28:54,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39707/tests/dromaeo/cssquery-ext.html) 09:28:55 INFO - 2015-11-26 09:28:55,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 145211392 09:28:55 INFO - 2015-11-26 09:28:55,916 DEBUG : BROWSER_OUTPUT: 09:31:57 INFO - 2015-11-26 09:31:57,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-ext.html (next: http://localhost:39707/tests/dromaeo/cssquery-jquery.html) 09:31:58 INFO - 2015-11-26 09:31:58,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 144613376 09:31:58 INFO - 2015-11-26 09:31:58,524 DEBUG : BROWSER_OUTPUT: 09:35:00 INFO - 2015-11-26 09:35:00,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39707/tests/dromaeo/cssquery-mootools.html) 09:35:00 INFO - 2015-11-26 09:35:00,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 09:35:00 INFO - 2015-11-26 09:35:00,888 DEBUG : BROWSER_OUTPUT: 09:38:02 INFO - 2015-11-26 09:38:02,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39707/tests/dromaeo/cssquery-prototype.html) 09:38:03 INFO - 2015-11-26 09:38:03,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 142036992 09:38:03 INFO - 2015-11-26 09:38:03,215 DEBUG : BROWSER_OUTPUT: 09:41:05 INFO - 2015-11-26 09:41:05,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39707/tests/dromaeo/cssquery-yui.html) 09:41:06 INFO - 2015-11-26 09:41:06,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 09:41:06 INFO - 2015-11-26 09:41:06,417 DEBUG : BROWSER_OUTPUT: 09:44:08 INFO - 2015-11-26 09:44:08,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/dromaeo/cssquery-yui.html (next: http://localhost:39707/tests/dromaeo/cssquery-dojo.html) 09:44:08 INFO - 2015-11-26 09:44:08,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 145215488 09:44:08 INFO - 2015-11-26 09:44:08,989 DEBUG : BROWSER_OUTPUT: 09:44:08 INFO - 2015-11-26 09:44:08,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:08 INFO - 2015-11-26 09:44:08,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:08 INFO - 2015-11-26 09:44:08,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:08 INFO - 2015-11-26 09:44:08,991 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:08 INFO - 2015-11-26 09:44:08,992 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2706.445178738358;2738.3838636306823;2777.3334399744067;2779.680336761272;2810.466011457823;4604.930926036104;4801.6398770092255;4807.062622788558;4830.323754674344;4858.125537403266;4766.118268120392;4774.9761251193695;4784.712917224969;4940.308356830046;4951.331570238017;4340.414044104053;4424.557544245582;4472.776361181945;4489.977550112245;4542.772861356935;4368.934465983013;4387.341898715186;4470.105978804236;4505.053938672882;4538.8865278367975;4303.160883627694;4372.978135109336;4396.978015109936;4412.338149277602;4435.1573201092015;4395.912081758347;4401.889952751175;4415.801288942005;4434.379186913835;4434.955650443487;4379.562043795627;4382.496012958487;4388.319810429389;4401.361802538646;4430;4564.612007979325;4669.859904202879;4689.249720044811;4759.048190361941;4804.567588917014;5177.948220517785;5180.093483640386;5187.507186817246;5204.9479505204845;5207.270982062514;5204.219367094928;5213.348331458567;5219.660722053054;5235.136202526579;5253.106971814763;4616.6537509686905;4756.025014871978;4769;4858.80564777412;4920.6309526785635;5244.056069907453;5250.264962905197;5267.341582302212;5298.655587386807;5376.677399356051;4862.246351815475;5101.20931255656;5104.770285337095;5108.846734597968;5114.488551144856;5103;5123.97438012815;5219.034478621467;5238.5023422774775;5305.973470132624;5117.948820511747;5122.564582010571;5129.512696293846;5135.178371460548;5176.559992400688;4905.460399356068;5050.166722490748;5096.770645320969;5101.693898366036;5103.387593488731;4172.70791044624;4243.766592837424;4248.192843359751;4258.425112609758;4265;3763.5483741951143;3782.2813665403487;3785.5740554797953;3805.4101614249835;3816.1413681921345;4280.657547396201;4462.129884672458;4463.308187230984;4473.1277400907165;4496.3705081288645;5113.948860511347;5145.716985565829;5173.456787037307;5213.530782229617;5234.13636749932;4415.116976604628;4420.425344705168;4445.533219012022;4457.9331310030375;4495.505494395614;4399.38408622793;4550.249208880564;4576.084783043338;4590.97704511482;4600.4479462464715;4795.688280261842;4842.83050093245;4851.902961940812;4882.633802464758;4923.630727695366;5129.794808207779;5131.846044618667;5177.7670004849115;5195.220716892345;5236.423993360651;4657.231556793226;4754.976225118852;4901.5588597026435;4916.455947245859;4921.9015619688125;4927.876803079952;4966.205407134841;4997.625178111583;5004.099262132851;5045.974770126126;5135.614828887774;5185.170372740344;5186.611004174627;5195.064888320138;5234.1102012657175;4773.594244489257;4926.901461970812;4931.679440836478;5017.448080711046;5031.6226283029655;5022.171341728574;5040.899182016413;5055.317532133115;5056.873578160576;5062.063518249136;4907.754612269301;4908.190148625579;4950.282209079592;4968.304437378698;4993.126202914548;4819.518048195152;4929.950700493093;4962.975185124052;5057.620678449058;5126.307948426915;4948.851534453972;4951.158303088556;4961.404631444249;4964.975175124101;5023.623228257822 09:44:08 INFO - 2015-11-26 09:44:08,993 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.9888402231956;569.5301376364499;571.7055716306103;573.211833728623;575.7150210645726;36376.81811590945;36644.633553664455;36689.26621467569;36727.63272367275;36827.815860920695;39052.21895562087;39892.60107398925;39919.800400997956;39990;40007.59992400075;7802.726904558327;8010.39922005849;8037.598120094001;8046.678132874707;8070.677172913076;7823.960880195591;7872.645730942121;7889.5266284022855;7898.368130549542;7902.723404680837;7939.325157361631;7979.521228726295;7996.240357166089;8020.197980201962;8025.036995560541;7901.565413902233;7938.086125836231;7972.162922893071;7972.681092756283;7978.601069946509;7680.923190768077;7851.332636725885;7872.409569282269;7872.5670088145125;7884.802879928047;36321;36848.63151368505;36882.44676329857;37264.627353726384;37319.81340093309;2855.5002874497086;3089.073278016586;3132.859021344045;3255.202475393544;3649.902827906224;27216.72783272162;27628.723712762818;27653.170404887886;27735;27874.303142421602;3391.7795343302605;3419;3423.7774544654517;3501.684848363634;3567.7502574819773;215515;216497;216951;217330;217501;50872.23691644628;51762.22356664653;54808.451915481135;59660.701696492106;60863.39136608666;56315.71842140763;56323.71838140783;56329.71835140798;56553;56689.716551416976;13279.73440531184;13401.731965360834;13450.327483625779;13467.86532134666;13469.191848489121;10357.533910973874;10391.220658450495;10409.9479502602;10424.270301078852;10501.789964200825;18611.162497687637;18865.81134188668;18879.52801179954;19009.429717108233;19050.52373690669;7708.884366734504;7771.572563508948;7876.448648594544;7881.862022438266;7962.084360298524;797.968081276754;808.3533173461208;818.6807145213371;821.34292565947;875.487839613833;21739.891300543397;21742.782572174077;21840.89079554592;22189.556208875732;29361.265968350534;890.670451932789;946.5030858799048;966.5505539923829;966.8163049020663;1025.7692019295748;13301.866981330257;13521.59435216945;13592.524261650993;13690.04169708111;13753.243571603458;328692;330922;335356;335847;335851;44881.55118448839;45635;45668.77165614151;45913.01565398239;46010.539894601294;1217.178404576907;1220.1580909172642;1237.2452803789681;1248.6628610275357;1249.3066348176667;25569.616455752806;25714.614280786176;25752.742472575785;25786;26025;37913.4312985311;38005.61994380021;38238.6176138235;38243.617563824;38388.61611383851;253243;255129;255908;256041;256288;28539.714602853706;41119.03532122811;42531;42558.148837023706;42567;38420.231595367375;38811;38878.41682374823;39334.40998384969;39916;32947.67052329446;33251.33497329991;33360.1659958503;33548.329033418704;34061.82969085139;33310.333793324484;33641.327173456884;34103.82948085244;34114.31771364609;34469.82765086158;33151.66848331486;33380.165495861824;33818.49272260967;33839.66160338464;33944;28411.573826392207;29376.26559336034;30083.398332033674;30341.544876826425;30407.239819004702;23499.41251468727;23512.88243558771;24330.14844480435;24334.391640209138;24586.385340366633 09:44:08 INFO - 2015-11-26 09:44:08,995 DEBUG : BROWSER_OUTPUT: |2;jquery.html;300.5161689679617;319.5207189216176;320.8748588050661;323.97084262416377;328.3826406356051;14833.332500037497;15163.317650705718;15236.466723664675;15808.13055281959;16409;9501.857472137906;9690.176335011533;12457.68855778606;14551.563453096398;14620.415183392652;4537.205988951937;4565.132624801294;4602.148602508547;4637.1189474;4644.744539050351;4579.175748365293;4623.676342656016;4629.8148074077;4646.303054541812;4647.581717645411;4688.109259240733;4702.106599746055;4829.51704829516;5011.749412529377;5017.122003649347;4866;4951.43058548268;4958.181899986498;4964.553190212862;4974.303597496353;5025.7235852028125;5114.744262786846;5146.536811686929;5153.098207813655;5166.276721259027;18089.276428942827;18116.90941545284;18209.908950455163;18698.252069917187;18748.34380796679;1642.2938136601256;1650.7688923550713;1765.0821572782081;1856.3966710819038;1882.2000649723814;8742.737717868475;8910.910890891073;9164.175224229852;9441.575129119206;12781.744365112738;1752.9386471473438;1799.5860951980987;1822.070743920597;1825.4432398118568;1846.8522518198513;53596;53674.73162634201;54166.729166353914;54227.728861355834;54700;9247.676331328372;9335.906640933505;9731.9026809731;9753.414795112316;9757.707268781947;12235.69410764738;12260.080493962989;12328.137030407965;12344.074194435454;12388.752224955631;6997.440204783605;7005.649717514104;7009.684564194624;7053.753118640823;7146.964265178744;6590.439812615981;6594.604323740591;6649.933500664932;6652.368025037614;6671.899921501182;4120;4124.463819703419;4143.3370660694145;4153.68847336451;4175.498940127204;1695.9406420775213;1715.9742603860952;1729.9827001730073;1734.37562477508;1747.8077411484726;355.6141586378808;356.09906935453347;357.1072319201995;378.9052736815796;380.209164936936;9083;9112;9384;9574.569144388519;9581.568829402693;385.9498265225559;394.4773175542418;395.9980200098981;399.98800035998966;409.32257114475;5199.298094757235;5301.231321458444;5324.334458192726;5328.147496400557;5358.16948372995;475278;479816;482407;483180;497847;71376;72474.63762681153;73265.63367183237;73883;75164.62417687986;406.5934065934066;407.991840163201;409.7951024487756;410.0180068735362;410.3168224905499;9143.588538515916;9383.85924211151;9396.248300136109;9400.811983760423;9439;29873.850630747576;31555.68444315619;31569.52645710362;32269;33079.50380744242;45233.32150017686;45779.31331030104;45903;45961;46878.76560617175;8722.781930451789;8851.601677924638;8915.108489151033;8923.553822308988;8962.86555701652;15366.308516116578;15668.216589170725;15924.363025478851;15993.8400615997;16175.352985880432;12736.808947865604;13072;13261.602151935458;13322.866771332163;13722.862771372158;13505.12216705911;13801.861981380058;13933.51232706891;13936.79094813599;14288.857111429168;13206.339683016004;13385.866141338462;13805.24071176095;14421.278936053366;14637.341319640855;8754.69358572447;8997.145271199226;9000.63997440095;12429.813552796897;12438.502459901865;14147.36336864823;14558.854411456174;14846.925765371105;14893.553193404216;14961.177135257665 09:44:08 INFO - 2015-11-26 09:44:08,996 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1469.5664778890227;1604.8876578639497;1650.6368598908236;1652.3968751405741;1673.5314112048623;5707.971460142704;6070;6766.864662706749;6935.861282774342;6939.09791727076;6421.711023003964;6532.281449040614;6573.605583664984;6575.605463672171;6612.504062195342;1937.4284586047079;1967.5769709512451;1968.5865968146707;1975.9901200494048;1977.6934575140876;1970.6452838489067;1991.522034711666;1999.2502811445709;2037.2360364863177;2040.4490787487443;1978.277928556081;1990.164131064949;2001.179516398277;2009.889456079915;2018.6770116781317;1932.478230877662;1953.6971769375768;1957.0508303472805;1958.8726732762468;1968.9212431502795;1956.491312258823;1982.6629472989482;1994.9601007979904;2009.4775358406919;2011.1553147677864;6626.304238054983;6686.1642294713165;6709.2284387295595;6738.865222695567;6749.696263668097;3883.805809709503;3965.286248475273;3977.8011099445202;3980.3432433648413;3983.063979964706;2562.5899856022947;2623.3835048763526;2641.32646175226;2645.179994201784;2656.53510635638;799.808046068945;816.9591520423955;821.6179476543376;828.7845160258316;843.8270154618289;8759.036505984337;8878.378513504058;8885.600147993357;8896.37725359225;8917.777055573597;3537.46937959303;3553.662402071799;3662.4689420033947;3668.6514781095752;3674.228412033503;7459.216782237895;7459.216782237895;7467.775966721007;7473.813154671068;7494.737684181027;4006;4017.799110044486;4018.216447792652;4025.4766880305374;4034.072163402434;3714.257148570297;3715.9442608360896;3723.832427540767;3738.719596030309;3743.7192210584317;2976.6725660177362;3020.9395812083635;3026.8183908965534;3029.8485075746125;3035.7723170762283;900.9459432434074;906.5965645287783;907.3376435202339;915.6749353979375;919.3794188922451;896.462122726359;908.7455512456522;909.4679612426804;910.2035718746097;1121.198343184627;6314.17915670969;6323.241211054611;6325.240971083499;6336.968315158487;6338.207724034496;419.4274814877731;421.2543797478507;421.90085329947436;423.50238469797864;430.69205518054116;4830.058138662997;4890.193118135468;4905.386826646669;4905.632077594195;4911.435184953704;7119.715211391486;7355.264473552709;7605.847883042308;7800.375969922393;7883.802904927423;7118;7157.284271572905;7210.603416812126;7226.819329516804;7248.855022899513;6366.331535188739;6375.71309291083;6453.225612926479;6477.708503117371;6481.546291759626;6321;6331.936680633319;6366.64983425916;6373.139626150411;6390.616563006234;7114.644267786486;7253.782386528413;7275.090613673291;7279.854402911807;7337.339639432476;7344.375728062961;7442.404607631268;7485.625718713934;7490.5880176588635;7501.699932002659;6518.380753828379;6554.213494380705;6598.505112116706;6606.306337834458;6609.041688954979;6284.120223168668;6321.778737744157;6340.7463701451425;6369.20384951881;6384.521160913043;6136.8772624548155;6143.754249830135;6188.783392581238;6228.408301211378;6255.906161407492;6027.517798576191;6081.665508397081;6081.939180608138;6188.535859810442;6190.41191086846;6063.605865618721;6076.817695469143;6108.602940808833;6153.630782153085;6201.627902325875;5671.149327600728;5672.376038635664;5703.344115426779;5719.714014299351;5734.5125664319;5810.796622118206;5828.59199856006;5831.0378787499585;5833.4749872511675;5854.063349864001 09:44:09 INFO - 2015-11-26 09:44:08,999 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.52681602172436;290.0486404592936;294.858467935391;296.76852055396796;299.48040150339165;5461.617686761923;5507.256520369749;5513.889722205554;5538.446155384459;5538.6122971392015;5502.779888804453;5520.861978450531;5521.5306698930535;5527.419620939793;5527.50252477277;4253.255680255958;4254.319308910575;4254.489461264652;4255.872323830275;4258.574142585748;4091;4138.52406973199;4173.269677806372;4174.31123864562;4179.456670632813;4110.486189226347;4133.318002529594;4136.482939632546;4191.958080419187;4193.454850869382;4192.161567686459;4193.559676233997;4198.097409057067;4203.684723645739;4217.093324935154;3641.089727568108;3650.251698401848;3653.1415117447377;3654.4152935530187;3661.1030297577263;5118.61610379223;5172.353455818023;5274.971380580789;5331.067063263913;5340.91988620171;4764.499727528629;4810.989692164615;4811.855644330676;4821.22860342347;4824.541668541518;5769.105788602773;5787.421257874221;5798.1302804579655;5806.216160818278;5809.564282678816;3950.308695978221;3955.3869150281753;3970.007498125469;3974.423708562242;3978.0651546886456;5856.648601083906;6122.234720659918;6125.479334256594;6126.846828829315;6139;4087.693422993228;4095.1195492969155;4098.139390727981;4101.323281658493;4101.364288535282;4153.356229784388;4163.7293575917465;4164.354525048622;4166.583341665809;4169.666426685858;4779.091972525279;4799.952000480021;4813.15769740301;4816.566509014206;4816.903661926742;5587.217789509472;5791.0734282514595;5793.246877905845;5850.765969361263;5856.1508581255475;1445.7975883376337;1468.8163979502563;1469.4489566412594;1469.8824094072663;1469.992650036743;970.6408628807386;972.8054389122204;978.0708327089152;997.3168379659957;1000.8748906386702;5061.519155680205;5063;5075.187969924795;5085.74571271435;5096.439391666913;6060.575759696779;6066.423689749467;6072.848178795565;6075.848103797441;6083.178770865965;5053.292539044537;5054.292399064134;5058.114829904752;5072.163093089673;5078.796848126108;3208.1498402923244;3244.4971029490466;3285.737141028712;3290.8190049547507;3293.2919422323835;5715.914261286084;5717.2281741965135;5718.856228754265;5725.541956643542;5731.398203188689;6113.908291375633;6212.875742485125;6247.937520624827;6255.718492667841;6305.085762564494;5753.33836608787;5764.308283005982;5777.711114444261;5783.797567085132;5786.739596718157;6067.120267561268;6118.082287656709;6124.877502449837;6126.356732543197;6127.234095738033;5808.283134019796;5896;5912.73392697321;5964.075568286922;5978.222831031938;5749.885002299847;5753.137029445449;5766.077427611562;5769.336526299361;5773.653580785166;4027.9194416110927;4044.373122166069;4078.653314468185;4090.4273401724377;4092.631663150331;6010.368911264254;6103.786367477117;6123.938760612336;6132.846678833065;6142.447179753665;5822.126680997884;5844.094165404369;5870.765169393177;5878.971180043561;5885.73514191871;5876.1773351731645;5885.793997210077;5889.322727886348;5889.793857214977;5894.852628684145;5754.367019627922;5762.366139724543;5767.653940763567;5770.624909381045;5770.653760774367;5757.91363129545;5888.676122813286;5913.900565299429;5931.228940237914;5931.792387266425;5786.739596718242;5787.39232380594;5800.332961709458;5808.099744539603;5808.941910581009 09:44:09 INFO - 2015-11-26 09:44:09,000 DEBUG : BROWSER_OUTPUT: |5;yui.html;636.6593872278329;688.7520492622655;702.7364738223166;777.1218523068932;780.1106738318316;10694.786104277919;10903.781924361509;10950.178736594757;10996.725081872957;11010.559577616887;10537.52581133849;10549.6307629233;10561.471926403668;10603.363798172115;10720.249582529226;756.9772906812791;766.6741634805213;774.1600363605495;790.9485883417589;791.0151860933146;767.194445831877;767.45510687412;770.3182683325269;770.7687693691898;773.9342155916726;768.5657603454058;775.8603451378749;776.7242628866755;776.9728059517918;778.5601135358532;767.6507189228887;768.5542385416474;773.4701729315381;773.7098588029489;774.5546310871243;578.5747475605426;579.1399771339558;581.7527550790896;582.1035605168037;583.8686295583502;11416.54333826646;11515.424228788526;11518.942405288004;11519.884801151966;11523.48144333507;9370.953145234298;10661.84007239892;10885.346879187275;11205.943970280096;11410.54357825686;8856.601452934634;9218.58516366765;9255.814883702289;9353.76615584609;9364.484953327565;3196.105090574643;3206.8075915444915;3226.774125811194;3252.0569034979826;3279.5244689520123;41939.790301048604;42303.78848105771;42379;42411.78794106041;42427.57572424298;8985.820283594292;9029.954850225839;9171.77070573241;9265.629374824932;9290.860637090449;15529.301181446863;15741.921290393704;15754.448594299145;16220.107894065939;16257.268422920997;6209.534284928648;6214.5960512566535;6276.372362763778;6440.806775796734;6497.18785151856;3544.91137721559;3565.16218688608;3577.83899724513;3612.837422316002;3641.9271614568092;2696.6224728538023;2731.6995130535624;2740.8081434299806;2742.122520793327;2746.8489233092373;483.51406836130167;493.38573476022583;499.3533374280316;504.44511037858064;505.3026822984332;460.4536910882823;473.812843926647;516.3958168942271;531.5880192850494;538.1201735162958;7871.921280787234;7928.643211055516;8645.95677021611;8754.781130471662;8963.865542016874;451.3838610296921;467.81988934259874;539.8380485854228;566.9206311116448;636.5480508838684;3815.4276858471453;3864.8450622791165;3865.246276976019;3876.5541962674088;3968.146848427602;48419;49690;49904;50827.72930676689;51390.48609513932;40587;40881.59118408837;40896.38655420171;41179;45049.77475112669;42071;42270.78864605657;42613.786931065144;43115.13769724588;43340.56659433428;8087.150849160754;8100.622894107898;8535.573221339033;8566.443181193203;8691.652333906573;29749.851250743606;29759.10722678323;29858.850705746332;29969.100926972227;30180.84909575438;35483;37800.62199377971;38301.42547861728;38559.80720096494;38705.6129438702;10126.341787783771;10251.7437064074;10314.484275786332;10319.122874555747;10530.157587393143;11528.654140375802;11723.531058757895;11735.706607334885;11786.646400607995;11855.288682678722;10683.679489615324;10748;10827.891721083004;10953.671389858317;11098.50056747432;10455.581776728846;10527;10907.781844363228;11031.393273370042;11245.606403776155;9678.225741940769;10938.484148646015;11050.115990720884;11052;11053.502592383202;8907.599158038034;9036.174652781256;9203.815923681355;9274.814503710022;9336.06639336061;8300.169983001651;8826.470411775314;8880.600372983103;9157.221636161;9161.358704890594 09:44:09 INFO - 2015-11-26 09:44:09,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:09 INFO - 2015-11-26 09:44:09,000 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:44:09 INFO - 2015-11-26 09:44:09,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 09:44:09 INFO - 2015-11-26 09:44:09,001 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559848989__endTimestamp 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4747.56 Median:4905.46 stddev:499.58 (10.2%) stddev-sans-first:474.75 09:44:09 INFO - 2015-11-26 09:44:09,002 DEBUG : BROWSER_OUTPUT: Values: 2706.4 2738.4 2777.3 2779.7 2810.5 4604.9 4801.6 4807.1 4830.3 4858.1 4766.1 4775.0 4784.7 4940.3 4951.3 4340.4 4424.6 4472.8 4490.0 4542.8 4368.9 4387.3 4470.1 4505.1 4538.9 4303.2 4373.0 4397.0 4412.3 4435.2 4395.9 4401.9 4415.8 4434.4 4435.0 4379.6 4382.5 4388.3 4401.4 4430.0 4564.6 4669.9 4689.2 4759.0 4804.6 5177.9 5180.1 5187.5 5204.9 5207.3 5204.2 5213.3 5219.7 5235.1 5253.1 4616.7 4756.0 4769.0 4858.8 4920.6 5244.1 5250.3 5267.3 5298.7 5376.7 4862.2 5101.2 5104.8 5108.8 5114.5 5103.0 5124.0 5219.0 5238.5 5306.0 5117.9 5122.6 5129.5 5135.2 5176.6 4905.5 5050.2 5096.8 5101.7 5103.4 4172.7 4243.8 4248.2 4258.4 4265.0 3763.5 3782.3 3785.6 3805.4 3816.1 4280.7 4462.1 4463.3 4473.1 4496.4 5113.9 5145.7 5173.5 5213.5 5234.1 4415.1 4420.4 4445.5 4457.9 4495.5 4399.4 4550.2 4576.1 4591.0 4600.4 4795.7 4842.8 4851.9 4882.6 4923.6 5129.8 5131.8 5177.8 5195.2 5236.4 4657.2 4755.0 4901.6 4916.5 4921.9 4927.9 4966.2 4997.6 5004.1 5046.0 5135.6 5185.2 5186.6 5195.1 5234.1 4773.6 4926.9 4931.7 5017.4 5031.6 5022.2 5040.9 5055.3 5056.9 5062.1 4907.8 4908.2 4950.3 4968.3 4993.1 4819.5 4930.0 4963.0 5057.6 5126.3 4948.9 4951.2 4961.4 4965.0 5023.6 09:44:09 INFO - 2015-11-26 09:44:09,003 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,003 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42740.79 Median:19944.38 stddev:71465.45 (358.3%) stddev-sans-first:71595.75 09:44:09 INFO - 2015-11-26 09:44:09,003 DEBUG : BROWSER_OUTPUT: Values: 558.0 569.5 571.7 573.2 575.7 36376.8 36644.6 36689.3 36727.6 36827.8 39052.2 39892.6 39919.8 39990.0 40007.6 7802.7 8010.4 8037.6 8046.7 8070.7 7824.0 7872.6 7889.5 7898.4 7902.7 7939.3 7979.5 7996.2 8020.2 8025.0 7901.6 7938.1 7972.2 7972.7 7978.6 7680.9 7851.3 7872.4 7872.6 7884.8 36321.0 36848.6 36882.4 37264.6 37319.8 2855.5 3089.1 3132.9 3255.2 3649.9 27216.7 27628.7 27653.2 27735.0 27874.3 3391.8 3419.0 3423.8 3501.7 3567.8 215515.0 216497.0 216951.0 217330.0 217501.0 50872.2 51762.2 54808.5 59660.7 60863.4 56315.7 56323.7 56329.7 56553.0 56689.7 13279.7 13401.7 13450.3 13467.9 13469.2 10357.5 10391.2 10409.9 10424.3 10501.8 18611.2 18865.8 18879.5 19009.4 19050.5 7708.9 7771.6 7876.4 7881.9 7962.1 798.0 808.4 818.7 821.3 875.5 21739.9 21742.8 21840.9 22189.6 29361.3 890.7 946.5 966.6 966.8 1025.8 13301.9 13521.6 13592.5 13690.0 13753.2 328692.0 330922.0 335356.0 335847.0 335851.0 44881.6 45635.0 45668.8 45913.0 46010.5 1217.2 1220.2 1237.2 1248.7 1249.3 25569.6 25714.6 25752.7 25786.0 26025.0 37913.4 38005.6 38238.6 38243.6 38388.6 253243.0 255129.0 255908.0 256041.0 256288.0 28539.7 41119.0 42531.0 42558.1 42567.0 38420.2 38811.0 38878.4 39334.4 39916.0 32947.7 33251.3 33360.2 33548.3 34061.8 33310.3 33641.3 34103.8 34114.3 34469.8 33151.7 33380.2 33818.5 33839.7 33944.0 28411.6 29376.3 30083.4 30341.5 30407.2 23499.4 23512.9 24330.1 24334.4 24586.4 09:44:09 INFO - 2015-11-26 09:44:09,003 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,003 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25827.73 Median:24704.41 stddev:79127.12 (320.3%) stddev-sans-first:79325.88 09:44:09 INFO - 2015-11-26 09:44:09,004 DEBUG : BROWSER_OUTPUT: Values: 300.5 319.5 320.9 324.0 328.4 14833.3 15163.3 15236.5 15808.1 16409.0 9501.9 9690.2 12457.7 14551.6 14620.4 4537.2 4565.1 4602.1 4637.1 4644.7 4579.2 4623.7 4629.8 4646.3 4647.6 4688.1 4702.1 4829.5 5011.7 5017.1 4866.0 4951.4 4958.2 4964.6 4974.3 5025.7 5114.7 5146.5 5153.1 5166.3 18089.3 18116.9 18209.9 18698.3 18748.3 1642.3 1650.8 1765.1 1856.4 1882.2 8742.7 8910.9 9164.2 9441.6 12781.7 1752.9 1799.6 1822.1 1825.4 1846.9 53596.0 53674.7 54166.7 54227.7 54700.0 9247.7 9335.9 9731.9 9753.4 9757.7 12235.7 12260.1 12328.1 12344.1 12388.8 6997.4 7005.6 7009.7 7053.8 7147.0 6590.4 6594.6 6649.9 6652.4 6671.9 4120.0 4124.5 4143.3 4153.7 4175.5 1695.9 1716.0 1730.0 1734.4 1747.8 355.6 356.1 357.1 378.9 380.2 9083.0 9112.0 9384.0 9574.6 9581.6 385.9 394.5 396.0 400.0 409.3 5199.3 5301.2 5324.3 5328.1 5358.2 475278.0 479816.0 482407.0 483180.0 497847.0 71376.0 72474.6 73265.6 73883.0 75164.6 406.6 408.0 409.8 410.0 410.3 9143.6 9383.9 9396.2 9400.8 9439.0 29873.9 31555.7 31569.5 32269.0 33079.5 45233.3 45779.3 45903.0 45961.0 46878.8 8722.8 8851.6 8915.1 8923.6 8962.9 15366.3 15668.2 15924.4 15993.8 16175.4 12736.8 13072.0 13261.6 13322.9 13722.9 13505.1 13801.9 13933.5 13936.8 14288.9 13206.3 13385.9 13805.2 14421.3 14637.3 8754.7 8997.1 9000.6 12429.8 12438.5 14147.4 14558.9 14846.9 14893.6 14961.2 09:44:09 INFO - 2015-11-26 09:44:09,004 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,004 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4666.62 Median:6148.69 stddev:2399.08 (39.0%) stddev-sans-first:2393.78 09:44:09 INFO - 2015-11-26 09:44:09,004 DEBUG : BROWSER_OUTPUT: Values: 1469.6 1604.9 1650.6 1652.4 1673.5 5708.0 6070.0 6766.9 6935.9 6939.1 6421.7 6532.3 6573.6 6575.6 6612.5 1937.4 1967.6 1968.6 1976.0 1977.7 1970.6 1991.5 1999.3 2037.2 2040.4 1978.3 1990.2 2001.2 2009.9 2018.7 1932.5 1953.7 1957.1 1958.9 1968.9 1956.5 1982.7 1995.0 2009.5 2011.2 6626.3 6686.2 6709.2 6738.9 6749.7 3883.8 3965.3 3977.8 3980.3 3983.1 2562.6 2623.4 2641.3 2645.2 2656.5 799.8 817.0 821.6 828.8 843.8 8759.0 8878.4 8885.6 8896.4 8917.8 3537.5 3553.7 3662.5 3668.7 3674.2 7459.2 7459.2 7467.8 7473.8 7494.7 4006.0 4017.8 4018.2 4025.5 4034.1 3714.3 3715.9 3723.8 3738.7 3743.7 2976.7 3020.9 3026.8 3029.8 3035.8 900.9 906.6 907.3 915.7 919.4 896.5 908.7 909.5 910.2 1121.2 6314.2 6323.2 6325.2 6337.0 6338.2 419.4 421.3 421.9 423.5 430.7 4830.1 4890.2 4905.4 4905.6 4911.4 7119.7 7355.3 7605.8 7800.4 7883.8 7118.0 7157.3 7210.6 7226.8 7248.9 6366.3 6375.7 6453.2 6477.7 6481.5 6321.0 6331.9 6366.6 6373.1 6390.6 7114.6 7253.8 7275.1 7279.9 7337.3 7344.4 7442.4 7485.6 7490.6 7501.7 6518.4 6554.2 6598.5 6606.3 6609.0 6284.1 6321.8 6340.7 6369.2 6384.5 6136.9 6143.8 6188.8 6228.4 6255.9 6027.5 6081.7 6081.9 6188.5 6190.4 6063.6 6076.8 6108.6 6153.6 6201.6 5671.1 5672.4 5703.3 5719.7 5734.5 5810.8 5828.6 5831.0 5833.5 5854.1 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4812.96 Median:5521.20 stddev:1444.69 (26.2%) stddev-sans-first:1408.27 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: Values: 288.5 290.0 294.9 296.8 299.5 5461.6 5507.3 5513.9 5538.4 5538.6 5502.8 5520.9 5521.5 5527.4 5527.5 4253.3 4254.3 4254.5 4255.9 4258.6 4091.0 4138.5 4173.3 4174.3 4179.5 4110.5 4133.3 4136.5 4192.0 4193.5 4192.2 4193.6 4198.1 4203.7 4217.1 3641.1 3650.3 3653.1 3654.4 3661.1 5118.6 5172.4 5275.0 5331.1 5340.9 4764.5 4811.0 4811.9 4821.2 4824.5 5769.1 5787.4 5798.1 5806.2 5809.6 3950.3 3955.4 3970.0 3974.4 3978.1 5856.6 6122.2 6125.5 6126.8 6139.0 4087.7 4095.1 4098.1 4101.3 4101.4 4153.4 4163.7 4164.4 4166.6 4169.7 4779.1 4800.0 4813.2 4816.6 4816.9 5587.2 5791.1 5793.2 5850.8 5856.2 1445.8 1468.8 1469.4 1469.9 1470.0 970.6 972.8 978.1 997.3 1000.9 5061.5 5063.0 5075.2 5085.7 5096.4 6060.6 6066.4 6072.8 6075.8 6083.2 5053.3 5054.3 5058.1 5072.2 5078.8 3208.1 3244.5 3285.7 3290.8 3293.3 5715.9 5717.2 5718.9 5725.5 5731.4 6113.9 6212.9 6247.9 6255.7 6305.1 5753.3 5764.3 5777.7 5783.8 5786.7 6067.1 6118.1 6124.9 6126.4 6127.2 5808.3 5896.0 5912.7 5964.1 5978.2 5749.9 5753.1 5766.1 5769.3 5773.7 4027.9 4044.4 4078.7 4090.4 4092.6 6010.4 6103.8 6123.9 6132.8 6142.4 5822.1 5844.1 5870.8 5879.0 5885.7 5876.2 5885.8 5889.3 5889.8 5894.9 5754.4 5762.4 5767.7 5770.6 5770.7 5757.9 5888.7 5913.9 5931.2 5931.8 5786.7 5787.4 5800.3 5808.1 5808.9 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12149.94 Median:43227.85 stddev:13738.52 (31.8%) stddev-sans-first:13749.86 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: Values: 636.7 688.8 702.7 777.1 780.1 10694.8 10903.8 10950.2 10996.7 11010.6 10537.5 10549.6 10561.5 10603.4 10720.2 757.0 766.7 774.2 790.9 791.0 767.2 767.5 770.3 770.8 773.9 768.6 775.9 776.7 777.0 778.6 767.7 768.6 773.5 773.7 774.6 578.6 579.1 581.8 582.1 583.9 11416.5 11515.4 11518.9 11519.9 11523.5 9371.0 10661.8 10885.3 11205.9 11410.5 8856.6 9218.6 9255.8 9353.8 9364.5 3196.1 3206.8 3226.8 3252.1 3279.5 41939.8 42303.8 42379.0 42411.8 42427.6 8985.8 9030.0 9171.8 9265.6 9290.9 15529.3 15741.9 15754.4 16220.1 16257.3 6209.5 6214.6 6276.4 6440.8 6497.2 3544.9 3565.2 3577.8 3612.8 3641.9 2696.6 2731.7 2740.8 2742.1 2746.8 483.5 493.4 499.4 504.4 505.3 460.5 473.8 516.4 531.6 538.1 7871.9 7928.6 8646.0 8754.8 8963.9 451.4 467.8 539.8 566.9 636.5 3815.4 3864.8 3865.2 3876.6 3968.1 48419.0 49690.0 49904.0 50827.7 51390.5 40587.0 40881.6 40896.4 41179.0 45049.8 42071.0 42270.8 42613.8 43115.1 43340.6 8087.2 8100.6 8535.6 8566.4 8691.7 29749.9 29759.1 29858.9 29969.1 30180.8 35483.0 37800.6 38301.4 38559.8 38705.6 10126.3 10251.7 10314.5 10319.1 10530.2 11528.7 11723.5 11735.7 11786.6 11855.3 10683.7 10748.0 10827.9 10953.7 11098.5 10455.6 10527.0 10907.8 11031.4 11245.6 9678.2 10938.5 11050.1 11052.0 11053.5 8907.6 9036.2 9203.8 9274.8 9336.1 8300.2 8826.5 8880.6 9157.2 9161.4 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:09 INFO - 2015-11-26 09:44:09,005 DEBUG : BROWSER_OUTPUT: 09:44:09 INFO - 2015-11-26 09:44:09,716 INFO : Browser exited with error code: 0 09:44:09 INFO - 2015-11-26 09:44:09,731 INFO : Completed test dromaeo_css (00:18:33) 09:44:09 INFO - 2015-11-26 09:44:09,731 INFO : Starting test kraken 09:44:09 INFO - 2015-11-26 09:44:09,731 DEBUG : operating with platform_type : linux_ 09:44:09 INFO - 2015-11-26 09:44:09,731 INFO : Initialising browser for kraken test... 09:44:09 INFO - 2015-11-26 09:44:09,737 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPGLg0/profile http://localhost:39707/getInfo.html 09:44:14 INFO - 2015-11-26 09:44:14,335 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:14 INFO - 2015-11-26 09:44:14,335 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:14 INFO - 2015-11-26 09:44:14,335 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:44:14 INFO - 2015-11-26 09:44:14,335 DEBUG : BROWSER_OUTPUT: __metrics 09:44:15 INFO - 2015-11-26 09:44:15,349 INFO : Browser initialized. 09:44:15 INFO - 2015-11-26 09:44:15,350 INFO : Running cycle 1/1 for kraken test... 09:44:15 INFO - 2015-11-26 09:44:15,350 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPGLg0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:27 INFO - 2015-11-26 09:44:27,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 138579968 09:44:27 INFO - 2015-11-26 09:44:27,282 DEBUG : BROWSER_OUTPUT: 09:44:29 INFO - 2015-11-26 09:44:29,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39707/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:30 INFO - 2015-11-26 09:44:30,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 140341248 09:44:30 INFO - 2015-11-26 09:44:30,520 DEBUG : BROWSER_OUTPUT: 09:44:33 INFO - 2015-11-26 09:44:33,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39707/tests/kraken/driver.html?testName=audio-dft) 09:44:33 INFO - 2015-11-26 09:44:33,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 140800000 09:44:33 INFO - 2015-11-26 09:44:33,872 DEBUG : BROWSER_OUTPUT: 09:44:36 INFO - 2015-11-26 09:44:36,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39707/tests/kraken/driver.html?testName=audio-fft) 09:44:37 INFO - 2015-11-26 09:44:37,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 135057408 09:44:37 INFO - 2015-11-26 09:44:37,383 DEBUG : BROWSER_OUTPUT: 09:44:39 INFO - 2015-11-26 09:44:39,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39707/tests/kraken/driver.html?testName=audio-oscillator) 09:44:40 INFO - 2015-11-26 09:44:40,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 135524352 09:44:40 INFO - 2015-11-26 09:44:40,007 DEBUG : BROWSER_OUTPUT: 09:44:42 INFO - 2015-11-26 09:44:42,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:42 INFO - 2015-11-26 09:44:42,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 137805824 09:44:42 INFO - 2015-11-26 09:44:42,863 DEBUG : BROWSER_OUTPUT: 09:44:45 INFO - 2015-11-26 09:44:45,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39707/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:46 INFO - 2015-11-26 09:44:46,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 09:44:46 INFO - 2015-11-26 09:44:46,574 DEBUG : BROWSER_OUTPUT: 09:44:50 INFO - 2015-11-26 09:44:50,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39707/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:50 INFO - 2015-11-26 09:44:50,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 135254016 09:44:50 INFO - 2015-11-26 09:44:50,722 DEBUG : BROWSER_OUTPUT: 09:44:53 INFO - 2015-11-26 09:44:53,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39707/tests/kraken/driver.html?testName=json-parse-financial) 09:44:54 INFO - 2015-11-26 09:44:54,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 09:44:54 INFO - 2015-11-26 09:44:54,261 DEBUG : BROWSER_OUTPUT: 09:44:56 INFO - 2015-11-26 09:44:56,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:56 INFO - 2015-11-26 09:44:56,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 137768960 09:44:56 INFO - 2015-11-26 09:44:56,615 DEBUG : BROWSER_OUTPUT: 09:44:58 INFO - 2015-11-26 09:44:58,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:59 INFO - 2015-11-26 09:44:59,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 138194944 09:44:59 INFO - 2015-11-26 09:44:59,115 DEBUG : BROWSER_OUTPUT: 09:45:01 INFO - 2015-11-26 09:45:01,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:01 INFO - 2015-11-26 09:45:01,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 137732096 09:45:01 INFO - 2015-11-26 09:45:01,888 DEBUG : BROWSER_OUTPUT: 09:45:04 INFO - 2015-11-26 09:45:04,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:05 INFO - 2015-11-26 09:45:05,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 09:45:05 INFO - 2015-11-26 09:45:05,061 DEBUG : BROWSER_OUTPUT: 09:45:07 INFO - 2015-11-26 09:45:07,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:08 INFO - 2015-11-26 09:45:08,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 137781248 09:45:08 INFO - 2015-11-26 09:45:08,284 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39707/tests/kraken/driver.html?testName=ai-astar) 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 137650176 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:45:10 INFO - 2015-11-26 09:45:10,332 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;114;112;115;126;114;113;112;114 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;136;160;168;131;156;154;147;165;136 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;164;161;162;163;171;161;167;166 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;73;73;139;72;78;73;74 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;127;94;95;95;132;93;95;141 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;109;110;110;110 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;148;149;148;147;148;148;147;152 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;98;96;96;96;96;96;95;96;95 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;75;76;78;75;73;75;74;77;73 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;70;69;69;69;70;69 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;85;84;85;92;84;84;87 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;121;124;126;127;121;126;133;136;124 09:45:10 INFO - 2015-11-26 09:45:10,333 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;152;148;150;149;147;153;139;147;150 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;69;70;71;70;72;69;74;70 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,809 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559910327__endTimestamp 09:45:10 INFO - 2015-11-26 09:45:10,334 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:45:10 INFO - 2015-11-26 09:45:10,335 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:45:10 INFO - 2015-11-26 09:45:10,335 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,335 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.75 (4.2%) stddev-sans-first:5.04 09:45:10 INFO - 2015-11-26 09:45:10,335 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 114.0 112.0 115.0 126.0 114.0 113.0 112.0 114.0 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.00 stddev:12.97 (8.3%) stddev-sans-first:13.52 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: Values: 158.0 136.0 160.0 168.0 131.0 156.0 154.0 147.0 165.0 136.0 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.29 (2.0%) stddev-sans-first:3.43 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 164.0 161.0 162.0 163.0 171.0 161.0 167.0 166.0 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:20.80 (28.5%) stddev-sans-first:21.91 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 139.0 72.0 78.0 73.0 74.0 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,336 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:94.50 stddev:19.10 (20.2%) stddev-sans-first:19.83 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 127.0 94.0 95.0 95.0 132.0 93.0 95.0 141.0 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 148.0 149.0 148.0 147.0 148.0 148.0 147.0 152.0 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: Values: 97.0 98.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:75.50 stddev:1.62 (2.1%) stddev-sans-first:1.69 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: Values: 76.0 75.0 76.0 78.0 75.0 73.0 75.0 74.0 77.0 73.0 09:45:10 INFO - 2015-11-26 09:45:10,337 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 70.0 69.0 69.0 69.0 70.0 69.0 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:2.58 (3.0%) stddev-sans-first:2.60 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 85.0 84.0 85.0 92.0 84.0 84.0 87.0 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:126.50 stddev:4.85 (3.8%) stddev-sans-first:5.08 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: Values: 129.0 121.0 124.0 126.0 127.0 121.0 126.0 133.0 136.0 124.0 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.00 stddev:4.10 (2.7%) stddev-sans-first:4.06 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: Values: 153.0 152.0 148.0 150.0 149.0 147.0 153.0 139.0 147.0 150.0 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.57 (2.2%) stddev-sans-first:1.64 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 69.0 70.0 71.0 70.0 72.0 69.0 74.0 70.0 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:45:10 INFO - 2015-11-26 09:45:10,338 DEBUG : BROWSER_OUTPUT: 09:45:11 INFO - 2015-11-26 09:45:11,205 INFO : Browser exited with error code: 0 09:45:11 INFO - 2015-11-26 09:45:11,259 INFO : Completed test kraken (00:01:01) 09:45:11 INFO - 2015-11-26 09:45:11,260 INFO : Starting test v8_7 09:45:11 INFO - 2015-11-26 09:45:11,260 DEBUG : operating with platform_type : linux_ 09:45:11 INFO - 2015-11-26 09:45:11,260 INFO : Initialising browser for v8_7 test... 09:45:11 INFO - 2015-11-26 09:45:11,266 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVnWqN8/profile http://localhost:39707/getInfo.html 09:45:15 INFO - 2015-11-26 09:45:15,778 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:15 INFO - 2015-11-26 09:45:15,778 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:15 INFO - 2015-11-26 09:45:15,779 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:45:15 INFO - 2015-11-26 09:45:15,779 DEBUG : BROWSER_OUTPUT: __metrics 09:45:16 INFO - 2015-11-26 09:45:16,833 INFO : Browser initialized. 09:45:16 INFO - 2015-11-26 09:45:16,834 INFO : Running cycle 1/1 for v8_7 test... 09:45:16 INFO - 2015-11-26 09:45:16,834 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVnWqN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:28 INFO - 2015-11-26 09:45:28,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 09:45:28 INFO - 2015-11-26 09:45:28,662 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39707/tests/v8_7/run.html (next: http://localhost:39707/tests/v8_7/run.html) 09:45:50 INFO - 2015-11-26 09:45:50,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 137744384 09:45:50 INFO - 2015-11-26 09:45:50,435 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,435 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:45:50 INFO - 2015-11-26 09:45:50,435 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.9112426035503 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.39251040221916 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 09:45:50 INFO - 2015-11-26 09:45:50,436 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1062.6992561105208 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: |5;Earley;711.2375533428165 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: |8;Splay;614.9144254278729 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:45:50 INFO - 2015-11-26 09:45:50,437 DEBUG : BROWSER_OUTPUT: __startTimestamp1448559950428__endTimestamp 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: Values: 166.4 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,438 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.91 Median:184.91 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: Values: 184.9 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.39 Median:277.39 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: Values: 277.4 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,439 DEBUG : BROWSER_OUTPUT: Values: 5229.2 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: Values: 1062.7 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:711.24 Median:711.24 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: Values: 711.2 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,440 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: Values: 12120.5 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: Values: 25820.5 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.91 Median:614.91 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,441 DEBUG : BROWSER_OUTPUT: Values: 614.9 09:45:50 INFO - 2015-11-26 09:45:50,442 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-26 09:45:50,442 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:45:50 INFO - 2015-11-26 09:45:50,442 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:45:50 INFO - 2015-11-26 09:45:50,442 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:45:50 INFO - 2015-11-26 09:45:50,442 DEBUG : BROWSER_OUTPUT: 09:45:51 INFO - 2015-11-26 09:45:51,355 INFO : Browser exited with error code: 0 09:45:51 INFO - 2015-11-26 09:45:51,366 INFO : Completed test v8_7 (00:00:40) 09:45:51 INFO - 2015-11-26 09:45:51,400 INFO : Completed test suite (00:20:15) 09:45:51 INFO - 2015-11-26 09:45:51,400 DEBUG : Working with test: dromaeo_css 09:45:51 INFO - 2015-11-26 09:45:51,400 DEBUG : Generating results file: dromaeo_css 09:45:51 INFO - 2015-11-26 09:45:51,401 DEBUG : Working with test: kraken 09:45:51 INFO - 2015-11-26 09:45:51,401 DEBUG : Generating results file: kraken 09:45:51 INFO - 2015-11-26 09:45:51,402 INFO : javascript benchmark 09:45:51 INFO - 2015-11-26 09:45:51,402 DEBUG : Working with test: v8_7 09:45:51 INFO - 2015-11-26 09:45:51,402 DEBUG : Generating results file: v8_7 09:45:51 INFO - 2015-11-26 09:45:51,402 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:51 INFO - 2015-11-26 09:45:51,466 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 09:45:51 INFO - 2015-11-26 09:45:51,466 DEBUG : process_Request line: dromaeo_css 6156.30 graph.html#tests=[[72,94,43]] 09:45:51 INFO - 2015-11-26 09:45:51,466 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:51 INFO - 2015-11-26 09:45:51,587 DEBUG : process_Request line: kraken 1545.10 graph.html#tests=[[232,94,43]] 09:45:51 INFO - 2015-11-26 09:45:51,587 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:45:51 INFO - 2015-11-26 09:45:51,698 DEBUG : process_Request line: v8_7 21367.84 graph.html#tests=[[230,94,43]] 09:45:51 INFO - 2015-11-26 09:45:51,700 INFO : javascript benchmark 09:45:51 INFO - 2015-11-26 09:45:51,703 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2706.445178738358, 2738.3838636306823, 2777.3334399744067, 2779.680336761272, 2810.466011457823, 4604.930926036104, 4801.6398770092255, 4807.062622788558, 4830.323754674344, 4858.125537403266, 4766.118268120392, 4774.9761251193695, 4784.712917224969, 4940.308356830046, 4951.331570238017, 4340.414044104053, 4424.557544245582, 4472.776361181945, 4489.977550112245, 4542.772861356935, 4368.934465983013, 4387.341898715186, 4470.105978804236, 4505.053938672882, 4538.8865278367975, 4303.160883627694, 4372.978135109336, 4396.978015109936, 4412.338149277602, 4435.1573201092015, 4395.912081758347, 4401.889952751175, 4415.801288942005, 4434.379186913835, 4434.955650443487, 4379.562043795627, 4382.496012958487, 4388.319810429389, 4401.361802538646, 4430.0, 4564.612007979325, 4669.859904202879, 4689.249720044811, 4759.048190361941, 4804.567588917014, 5177.948220517785, 5180.093483640386, 5187.507186817246, 5204.9479505204845, 5207.270982062514, 5204.219367094928, 5213.348331458567, 5219.660722053054, 5235.136202526579, 5253.106971814763, 4616.6537509686905, 4756.025014871978, 4769.0, 4858.80564777412, 4920.6309526785635, 5244.056069907453, 5250.264962905197, 5267.341582302212, 5298.655587386807, 5376.677399356051, 4862.246351815475, 5101.20931255656, 5104.770285337095, 5108.846734597968, 5114.488551144856, 5103.0, 5123.97438012815, 5219.034478621467, 5238.5023422774775, 5305.973470132624, 5117.948820511747, 5122.564582010571, 5129.512696293846, 5135.178371460548, 5176.559992400688, 4905.460399356068, 5050.166722490748, 5096.770645320969, 5101.693898366036, 5103.387593488731, 4172.70791044624, 4243.766592837424, 4248.192843359751, 4258.425112609758, 4265.0, 3763.5483741951143, 3782.2813665403487, 3785.5740554797953, 3805.4101614249835, 3816.1413681921345, 4280.657547396201, 4462.129884672458, 4463.308187230984, 4473.1277400907165, 4496.3705081288645, 5113.948860511347, 5145.716985565829, 5173.456787037307, 5213.530782229617, 5234.13636749932, 4415.116976604628, 4420.425344705168, 4445.533219012022, 4457.9331310030375, 4495.505494395614, 4399.38408622793, 4550.249208880564, 4576.084783043338, 4590.97704511482, 4600.4479462464715, 4795.688280261842, 4842.83050093245, 4851.902961940812, 4882.633802464758, 4923.630727695366, 5129.794808207779, 5131.846044618667, 5177.7670004849115, 5195.220716892345, 5236.423993360651, 4657.231556793226, 4754.976225118852, 4901.5588597026435, 4916.455947245859, 4921.9015619688125, 4927.876803079952, 4966.205407134841, 4997.625178111583, 5004.099262132851, 5045.974770126126, 5135.614828887774, 5185.170372740344, 5186.611004174627, 5195.064888320138, 5234.1102012657175, 4773.594244489257, 4926.901461970812, 4931.679440836478, 5017.448080711046, 5031.6226283029655, 5022.171341728574, 5040.899182016413, 5055.317532133115, 5056.873578160576, 5062.063518249136, 4907.754612269301, 4908.190148625579, 4950.282209079592, 4968.304437378698, 4993.126202914548, 4819.518048195152, 4929.950700493093, 4962.975185124052, 5057.620678449058, 5126.307948426915, 4948.851534453972, 4951.158303088556, 4961.404631444249, 4964.975175124101, 5023.623228257822], "unit": "ms", "name": "dojo.html", "value": 4716.499250657653}, {"lowerIsBetter": false, "replicates": [557.9888402231956, 569.5301376364499, 571.7055716306103, 573.211833728623, 575.7150210645726, 36376.81811590945, 36644.633553664455, 36689.26621467569, 36727.63272367275, 36827.815860920695, 39052.21895562087, 39892.60107398925, 39919.800400997956, 39990.0, 40007.59992400075, 7802.726904558327, 8010.39922005849, 8037.598120094001, 8046.678132874707, 8070.677172913076, 7823.960880195591, 7872.645730942121, 7889.5266284022855, 7898.368130549542, 7902.723404680837, 7939.325157361631, 7979.521228726295, 7996.240357166089, 8020.197980201962, 8025.036995560541, 7901.565413902233, 7938.086125836231, 7972.162922893071, 7972.681092756283, 7978.601069946509, 7680.923190768077, 7851.332636725885, 7872.409569282269, 7872.5670088145125, 7884.802879928047, 36321.0, 36848.63151368505, 36882.44676329857, 37264.627353726384, 37319.81340093309, 2855.5002874497086, 3089.073278016586, 3132.859021344045, 3255.202475393544, 3649.902827906224, 27216.72783272162, 27628.723712762818, 27653.170404887886, 27735.0, 27874.303142421602, 3391.7795343302605, 3419.0, 3423.7774544654517, 3501.684848363634, 3567.7502574819773, 215515.0, 216497.0, 216951.0, 217330.0, 217501.0, 50872.23691644628, 51762.22356664653, 54808.451915481135, 59660.701696492106, 60863.39136608666, 56315.71842140763, 56323.71838140783, 56329.71835140798, 56553.0, 56689.716551416976, 13279.73440531184, 13401.731965360834, 13450.327483625779, 13467.86532134666, 13469.191848489121, 10357.533910973874, 10391.220658450495, 10409.9479502602, 10424.270301078852, 10501.789964200825, 18611.162497687637, 18865.81134188668, 18879.52801179954, 19009.429717108233, 19050.52373690669, 7708.884366734504, 7771.572563508948, 7876.448648594544, 7881.862022438266, 7962.084360298524, 797.968081276754, 808.3533173461208, 818.6807145213371, 821.34292565947, 875.487839613833, 21739.891300543397, 21742.782572174077, 21840.89079554592, 22189.556208875732, 29361.265968350534, 890.670451932789, 946.5030858799048, 966.5505539923829, 966.8163049020663, 1025.7692019295748, 13301.866981330257, 13521.59435216945, 13592.524261650993, 13690.04169708111, 13753.243571603458, 328692.0, 330922.0, 335356.0, 335847.0, 335851.0, 44881.55118448839, 45635.0, 45668.77165614151, 45913.01565398239, 46010.539894601294, 1217.178404576907, 1220.1580909172642, 1237.2452803789681, 1248.6628610275357, 1249.3066348176667, 25569.616455752806, 25714.614280786176, 25752.742472575785, 25786.0, 26025.0, 37913.4312985311, 38005.61994380021, 38238.6176138235, 38243.617563824, 38388.61611383851, 253243.0, 255129.0, 255908.0, 256041.0, 256288.0, 28539.714602853706, 41119.03532122811, 42531.0, 42558.148837023706, 42567.0, 38420.231595367375, 38811.0, 38878.41682374823, 39334.40998384969, 39916.0, 32947.67052329446, 33251.33497329991, 33360.1659958503, 33548.329033418704, 34061.82969085139, 33310.333793324484, 33641.327173456884, 34103.82948085244, 34114.31771364609, 34469.82765086158, 33151.66848331486, 33380.165495861824, 33818.49272260967, 33839.66160338464, 33944.0, 28411.573826392207, 29376.26559336034, 30083.398332033674, 30341.544876826425, 30407.239819004702, 23499.41251468727, 23512.88243558771, 24330.14844480435, 24334.391640209138, 24586.385340366633], "unit": "ms", "name": "ext.html", "value": 17020.35615033687}, {"lowerIsBetter": false, "replicates": [300.5161689679617, 319.5207189216176, 320.8748588050661, 323.97084262416377, 328.3826406356051, 14833.332500037497, 15163.317650705718, 15236.466723664675, 15808.13055281959, 16409.0, 9501.857472137906, 9690.176335011533, 12457.68855778606, 14551.563453096398, 14620.415183392652, 4537.205988951937, 4565.132624801294, 4602.148602508547, 4637.1189474, 4644.744539050351, 4579.175748365293, 4623.676342656016, 4629.8148074077, 4646.303054541812, 4647.581717645411, 4688.109259240733, 4702.106599746055, 4829.51704829516, 5011.749412529377, 5017.122003649347, 4866.0, 4951.43058548268, 4958.181899986498, 4964.553190212862, 4974.303597496353, 5025.7235852028125, 5114.744262786846, 5146.536811686929, 5153.098207813655, 5166.276721259027, 18089.276428942827, 18116.90941545284, 18209.908950455163, 18698.252069917187, 18748.34380796679, 1642.2938136601256, 1650.7688923550713, 1765.0821572782081, 1856.3966710819038, 1882.2000649723814, 8742.737717868475, 8910.910890891073, 9164.175224229852, 9441.575129119206, 12781.744365112738, 1752.9386471473438, 1799.5860951980987, 1822.070743920597, 1825.4432398118568, 1846.8522518198513, 53596.0, 53674.73162634201, 54166.729166353914, 54227.728861355834, 54700.0, 9247.676331328372, 9335.906640933505, 9731.9026809731, 9753.414795112316, 9757.707268781947, 12235.69410764738, 12260.080493962989, 12328.137030407965, 12344.074194435454, 12388.752224955631, 6997.440204783605, 7005.649717514104, 7009.684564194624, 7053.753118640823, 7146.964265178744, 6590.439812615981, 6594.604323740591, 6649.933500664932, 6652.368025037614, 6671.899921501182, 4120.0, 4124.463819703419, 4143.3370660694145, 4153.68847336451, 4175.498940127204, 1695.9406420775213, 1715.9742603860952, 1729.9827001730073, 1734.37562477508, 1747.8077411484726, 355.6141586378808, 356.09906935453347, 357.1072319201995, 378.9052736815796, 380.209164936936, 9083.0, 9112.0, 9384.0, 9574.569144388519, 9581.568829402693, 385.9498265225559, 394.4773175542418, 395.9980200098981, 399.98800035998966, 409.32257114475, 5199.298094757235, 5301.231321458444, 5324.334458192726, 5328.147496400557, 5358.16948372995, 475278.0, 479816.0, 482407.0, 483180.0, 497847.0, 71376.0, 72474.63762681153, 73265.63367183237, 73883.0, 75164.62417687986, 406.5934065934066, 407.991840163201, 409.7951024487756, 410.0180068735362, 410.3168224905499, 9143.588538515916, 9383.85924211151, 9396.248300136109, 9400.811983760423, 9439.0, 29873.850630747576, 31555.68444315619, 31569.52645710362, 32269.0, 33079.50380744242, 45233.32150017686, 45779.31331030104, 45903.0, 45961.0, 46878.76560617175, 8722.781930451789, 8851.601677924638, 8915.108489151033, 8923.553822308988, 8962.86555701652, 15366.308516116578, 15668.216589170725, 15924.363025478851, 15993.8400615997, 16175.352985880432, 12736.808947865604, 13072.0, 13261.602151935458, 13322.866771332163, 13722.862771372158, 13505.12216705911, 13801.861981380058, 13933.51232706891, 13936.79094813599, 14288.857111429168, 13206.339683016004, 13385.866141338462, 13805.24071176095, 14421.278936053366, 14637.341319640855, 8754.69358572447, 8997.145271199226, 9000.63997440095, 12429.813552796897, 12438.502459901865, 14147.36336864823, 14558.854411456174, 14846.925765371105, 14893.553193404216, 14961.177135257665], "unit": "ms", "name": "jquery.html", "value": 7343.673811078369}, {"lowerIsBetter": false, "replicates": [1469.5664778890227, 1604.8876578639497, 1650.6368598908236, 1652.3968751405741, 1673.5314112048623, 5707.971460142704, 6070.0, 6766.864662706749, 6935.861282774342, 6939.09791727076, 6421.711023003964, 6532.281449040614, 6573.605583664984, 6575.605463672171, 6612.504062195342, 1937.4284586047079, 1967.5769709512451, 1968.5865968146707, 1975.9901200494048, 1977.6934575140876, 1970.6452838489067, 1991.522034711666, 1999.2502811445709, 2037.2360364863177, 2040.4490787487443, 1978.277928556081, 1990.164131064949, 2001.179516398277, 2009.889456079915, 2018.6770116781317, 1932.478230877662, 1953.6971769375768, 1957.0508303472805, 1958.8726732762468, 1968.9212431502795, 1956.491312258823, 1982.6629472989482, 1994.9601007979904, 2009.4775358406919, 2011.1553147677864, 6626.304238054983, 6686.1642294713165, 6709.2284387295595, 6738.865222695567, 6749.696263668097, 3883.805809709503, 3965.286248475273, 3977.8011099445202, 3980.3432433648413, 3983.063979964706, 2562.5899856022947, 2623.3835048763526, 2641.32646175226, 2645.179994201784, 2656.53510635638, 799.808046068945, 816.9591520423955, 821.6179476543376, 828.7845160258316, 843.8270154618289, 8759.036505984337, 8878.378513504058, 8885.600147993357, 8896.37725359225, 8917.777055573597, 3537.46937959303, 3553.662402071799, 3662.4689420033947, 3668.6514781095752, 3674.228412033503, 7459.216782237895, 7459.216782237895, 7467.775966721007, 7473.813154671068, 7494.737684181027, 4006.0, 4017.799110044486, 4018.216447792652, 4025.4766880305374, 4034.072163402434, 3714.257148570297, 3715.9442608360896, 3723.832427540767, 3738.719596030309, 3743.7192210584317, 2976.6725660177362, 3020.9395812083635, 3026.8183908965534, 3029.8485075746125, 3035.7723170762283, 900.9459432434074, 906.5965645287783, 907.3376435202339, 915.6749353979375, 919.3794188922451, 896.462122726359, 908.7455512456522, 909.4679612426804, 910.2035718746097, 1121.198343184627, 6314.17915670969, 6323.241211054611, 6325.240971083499, 6336.968315158487, 6338.207724034496, 419.4274814877731, 421.2543797478507, 421.90085329947436, 423.50238469797864, 430.69205518054116, 4830.058138662997, 4890.193118135468, 4905.386826646669, 4905.632077594195, 4911.435184953704, 7119.715211391486, 7355.264473552709, 7605.847883042308, 7800.375969922393, 7883.802904927423, 7118.0, 7157.284271572905, 7210.603416812126, 7226.819329516804, 7248.855022899513, 6366.331535188739, 6375.71309291083, 6453.225612926479, 6477.708503117371, 6481.546291759626, 6321.0, 6331.936680633319, 6366.64983425916, 6373.139626150411, 6390.616563006234, 7114.644267786486, 7253.782386528413, 7275.090613673291, 7279.854402911807, 7337.339639432476, 7344.375728062961, 7442.404607631268, 7485.625718713934, 7490.5880176588635, 7501.699932002659, 6518.380753828379, 6554.213494380705, 6598.505112116706, 6606.306337834458, 6609.041688954979, 6284.120223168668, 6321.778737744157, 6340.7463701451425, 6369.20384951881, 6384.521160913043, 6136.8772624548155, 6143.754249830135, 6188.783392581238, 6228.408301211378, 6255.906161407492, 6027.517798576191, 6081.665508397081, 6081.939180608138, 6188.535859810442, 6190.41191086846, 6063.605865618721, 6076.817695469143, 6108.602940808833, 6153.630782153085, 6201.627902325875, 5671.149327600728, 5672.376038635664, 5703.344115426779, 5719.714014299351, 5734.5125664319, 5810.796622118206, 5828.59199856006, 5831.0378787499585, 5833.4749872511675, 5854.063349864001], "unit": "ms", "name": "mootools.html", "value": 3771.8808820607333}, {"lowerIsBetter": false, "replicates": [288.52681602172436, 290.0486404592936, 294.858467935391, 296.76852055396796, 299.48040150339165, 5461.617686761923, 5507.256520369749, 5513.889722205554, 5538.446155384459, 5538.6122971392015, 5502.779888804453, 5520.861978450531, 5521.5306698930535, 5527.419620939793, 5527.50252477277, 4253.255680255958, 4254.319308910575, 4254.489461264652, 4255.872323830275, 4258.574142585748, 4091.0, 4138.52406973199, 4173.269677806372, 4174.31123864562, 4179.456670632813, 4110.486189226347, 4133.318002529594, 4136.482939632546, 4191.958080419187, 4193.454850869382, 4192.161567686459, 4193.559676233997, 4198.097409057067, 4203.684723645739, 4217.093324935154, 3641.089727568108, 3650.251698401848, 3653.1415117447377, 3654.4152935530187, 3661.1030297577263, 5118.61610379223, 5172.353455818023, 5274.971380580789, 5331.067063263913, 5340.91988620171, 4764.499727528629, 4810.989692164615, 4811.855644330676, 4821.22860342347, 4824.541668541518, 5769.105788602773, 5787.421257874221, 5798.1302804579655, 5806.216160818278, 5809.564282678816, 3950.308695978221, 3955.3869150281753, 3970.007498125469, 3974.423708562242, 3978.0651546886456, 5856.648601083906, 6122.234720659918, 6125.479334256594, 6126.846828829315, 6139.0, 4087.693422993228, 4095.1195492969155, 4098.139390727981, 4101.323281658493, 4101.364288535282, 4153.356229784388, 4163.7293575917465, 4164.354525048622, 4166.583341665809, 4169.666426685858, 4779.091972525279, 4799.952000480021, 4813.15769740301, 4816.566509014206, 4816.903661926742, 5587.217789509472, 5791.0734282514595, 5793.246877905845, 5850.765969361263, 5856.1508581255475, 1445.7975883376337, 1468.8163979502563, 1469.4489566412594, 1469.8824094072663, 1469.992650036743, 970.6408628807386, 972.8054389122204, 978.0708327089152, 997.3168379659957, 1000.8748906386702, 5061.519155680205, 5063.0, 5075.187969924795, 5085.74571271435, 5096.439391666913, 6060.575759696779, 6066.423689749467, 6072.848178795565, 6075.848103797441, 6083.178770865965, 5053.292539044537, 5054.292399064134, 5058.114829904752, 5072.163093089673, 5078.796848126108, 3208.1498402923244, 3244.4971029490466, 3285.737141028712, 3290.8190049547507, 3293.2919422323835, 5715.914261286084, 5717.2281741965135, 5718.856228754265, 5725.541956643542, 5731.398203188689, 6113.908291375633, 6212.875742485125, 6247.937520624827, 6255.718492667841, 6305.085762564494, 5753.33836608787, 5764.308283005982, 5777.711114444261, 5783.797567085132, 5786.739596718157, 6067.120267561268, 6118.082287656709, 6124.877502449837, 6126.356732543197, 6127.234095738033, 5808.283134019796, 5896.0, 5912.73392697321, 5964.075568286922, 5978.222831031938, 5749.885002299847, 5753.137029445449, 5766.077427611562, 5769.336526299361, 5773.653580785166, 4027.9194416110927, 4044.373122166069, 4078.653314468185, 4090.4273401724377, 4092.631663150331, 6010.368911264254, 6103.786367477117, 6123.938760612336, 6132.846678833065, 6142.447179753665, 5822.126680997884, 5844.094165404369, 5870.765169393177, 5878.971180043561, 5885.73514191871, 5876.1773351731645, 5885.793997210077, 5889.322727886348, 5889.793857214977, 5894.852628684145, 5754.367019627922, 5762.366139724543, 5767.653940763567, 5770.624909381045, 5770.653760774367, 5757.91363129545, 5888.676122813286, 5913.900565299429, 5931.228940237914, 5931.792387266425, 5786.739596718242, 5787.39232380594, 5800.332961709458, 5808.099744539603, 5808.941910581009], "unit": "ms", "name": "prototype.html", "value": 4340.166065623512}, {"lowerIsBetter": false, "replicates": [636.6593872278329, 688.7520492622655, 702.7364738223166, 777.1218523068932, 780.1106738318316, 10694.786104277919, 10903.781924361509, 10950.178736594757, 10996.725081872957, 11010.559577616887, 10537.52581133849, 10549.6307629233, 10561.471926403668, 10603.363798172115, 10720.249582529226, 756.9772906812791, 766.6741634805213, 774.1600363605495, 790.9485883417589, 791.0151860933146, 767.194445831877, 767.45510687412, 770.3182683325269, 770.7687693691898, 773.9342155916726, 768.5657603454058, 775.8603451378749, 776.7242628866755, 776.9728059517918, 778.5601135358532, 767.6507189228887, 768.5542385416474, 773.4701729315381, 773.7098588029489, 774.5546310871243, 578.5747475605426, 579.1399771339558, 581.7527550790896, 582.1035605168037, 583.8686295583502, 11416.54333826646, 11515.424228788526, 11518.942405288004, 11519.884801151966, 11523.48144333507, 9370.953145234298, 10661.84007239892, 10885.346879187275, 11205.943970280096, 11410.54357825686, 8856.601452934634, 9218.58516366765, 9255.814883702289, 9353.76615584609, 9364.484953327565, 3196.105090574643, 3206.8075915444915, 3226.774125811194, 3252.0569034979826, 3279.5244689520123, 41939.790301048604, 42303.78848105771, 42379.0, 42411.78794106041, 42427.57572424298, 8985.820283594292, 9029.954850225839, 9171.77070573241, 9265.629374824932, 9290.860637090449, 15529.301181446863, 15741.921290393704, 15754.448594299145, 16220.107894065939, 16257.268422920997, 6209.534284928648, 6214.5960512566535, 6276.372362763778, 6440.806775796734, 6497.18785151856, 3544.91137721559, 3565.16218688608, 3577.83899724513, 3612.837422316002, 3641.9271614568092, 2696.6224728538023, 2731.6995130535624, 2740.8081434299806, 2742.122520793327, 2746.8489233092373, 483.51406836130167, 493.38573476022583, 499.3533374280316, 504.44511037858064, 505.3026822984332, 460.4536910882823, 473.812843926647, 516.3958168942271, 531.5880192850494, 538.1201735162958, 7871.921280787234, 7928.643211055516, 8645.95677021611, 8754.781130471662, 8963.865542016874, 451.3838610296921, 467.81988934259874, 539.8380485854228, 566.9206311116448, 636.5480508838684, 3815.4276858471453, 3864.8450622791165, 3865.246276976019, 3876.5541962674088, 3968.146848427602, 48419.0, 49690.0, 49904.0, 50827.72930676689, 51390.48609513932, 40587.0, 40881.59118408837, 40896.38655420171, 41179.0, 45049.77475112669, 42071.0, 42270.78864605657, 42613.786931065144, 43115.13769724588, 43340.56659433428, 8087.150849160754, 8100.622894107898, 8535.573221339033, 8566.443181193203, 8691.652333906573, 29749.851250743606, 29759.10722678323, 29858.850705746332, 29969.100926972227, 30180.84909575438, 35483.0, 37800.62199377971, 38301.42547861728, 38559.80720096494, 38705.6129438702, 10126.341787783771, 10251.7437064074, 10314.484275786332, 10319.122874555747, 10530.157587393143, 11528.654140375802, 11723.531058757895, 11735.706607334885, 11786.646400607995, 11855.288682678722, 10683.679489615324, 10748.0, 10827.891721083004, 10953.671389858317, 11098.50056747432, 10455.581776728846, 10527.0, 10907.781844363228, 11031.393273370042, 11245.606403776155, 9678.225741940769, 10938.484148646015, 11050.115990720884, 11052.0, 11053.502592383202, 8907.599158038034, 9036.174652781256, 9203.815923681355, 9274.814503710022, 9336.06639336061, 8300.169983001651, 8826.470411775314, 8880.600372983103, 9157.221636161, 9161.358704890594], "unit": "ms", "name": "yui.html", "value": 5640.3431368742185}], "name": "dromaeo_css", "value": 6156.296779350923}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 114.0, 112.0, 115.0, 126.0, 114.0, 113.0, 112.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [158.0, 136.0, 160.0, 168.0, 131.0, 156.0, 154.0, 147.0, 165.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 164.0, 161.0, 162.0, 163.0, 171.0, 161.0, 167.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 139.0, 72.0, 78.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 127.0, 94.0, 95.0, 95.0, 132.0, 93.0, 95.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 152.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 76.0, 78.0, 75.0, 73.0, 75.0, 74.0, 77.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 85.0, 84.0, 85.0, 92.0, 84.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 124.0, 126.0, 127.0, 121.0, 126.0, 133.0, 136.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [153.0, 152.0, 148.0, 150.0, 149.0, 147.0, 153.0, 139.0, 147.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 70.0, 71.0, 70.0, 72.0, 69.0, 74.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1545.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [184.9112426035503], "unit": "score", "name": "DeltaBlue", "value": 357.56614399999995}, {"lowerIsBetter": false, "replicates": [277.39251040221916], "unit": "score", "name": "Encrypt", "value": 959.5825049999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [711.2375533428165], "unit": "score", "name": "Earley", "value": 937.0469780000002}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [614.9144254278729], "unit": "score", "name": "Splay", "value": 132.52413121272372}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21367.836859178922}]} 09:45:51 INFO - RETURN: dromaeo_css: 6156.30 09:45:51 INFO - RETURN: kraken: 1545.10 09:45:51 INFO - RETURN: v8_7: 21367.84 09:45:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21367.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1545.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6156.30"}}} 09:45:51 INFO - Return code: 0 09:45:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:45:51 INFO - # TBPL SUCCESS # 09:45:51 INFO - Running post-action listener: _resource_record_post_action 09:45:51 INFO - Running post-run listener: _resource_record_post_run 09:45:52 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510894080; Read time: 12; Write time: 465368 09:45:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238092288; Read time: 0; Write time: 303664 09:45:52 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272510976; Read time: 12; Write time: 161680 09:45:52 INFO - Running post-run listener: _upload_blobber_files 09:45:52 INFO - Blob upload gear active. 09:45:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:45:52 INFO - Copying logs to upload dir... 09:45:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.072152 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-26 09:45:52.465872) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:45:52.470779) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010179 build_url: 'https://queue.taskcluster.net/v1/task/oawcYVwyQDqGhph_EZhpJg/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-11-26 09:45:52.524484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:45:52.524991) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448558681.806614-631355732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:45:52.575123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:45:52.575442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 09:45:52.575743) ========= ========= Total master_lag: 0.23 =========