builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1449358584.34 results: success (0) buildid: 20151205152029 builduid: 72856fb371d04a888a89fde60e14d7e9 revision: cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.337512) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.337991) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.338337) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006485 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.414486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.414824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.476255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.476604) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.539892) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.540482) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.541195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.541825) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 15:36:25-- 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% 224M=0s 2015-12-05 15:36:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.733268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.733655) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.784411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:24.784796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea --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 cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea --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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 15:36:25,526 truncating revision to first 12 chars 2015-12-05 15:36:25,526 Setting DEBUG logging. 2015-12-05 15:36:25,526 attempt 1/10 2015-12-05 15:36:25,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc9c6cd756cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 15:36:26,125 unpacking tar archive at: mozilla-central-cc9c6cd756cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.884144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:25.682059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:25.682396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:25.691375) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:25.691786) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 15:36:25.692276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-05 15:36:25.692642) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:36:26 INFO - MultiFileLogger online at 20151205 15:36:26 in /builds/slave/test 15:36:26 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 15:36:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:36:26 INFO - {'append_to_log': False, 15:36:26 INFO - 'base_work_dir': '/builds/slave/test', 15:36:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:36:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:36:26 INFO - 'branch': 'Firefox-Non-PGO', 15:36:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:36:26 INFO - 'config_files': ('talos/linux_config.py',), 15:36:26 INFO - 'default_actions': ('clobber', 15:36:26 INFO - 'read-buildbot-config', 15:36:26 INFO - 'download-and-extract', 15:36:26 INFO - 'populate-webroot', 15:36:26 INFO - 'create-virtualenv', 15:36:26 INFO - 'install', 15:36:26 INFO - 'run-tests'), 15:36:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:36:26 INFO - 'download_minidump_stackwalk': True, 15:36:26 INFO - 'download_symbols': 'ondemand', 15:36:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:36:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:36:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:36:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:36:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:36:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:36:26 INFO - 'installer_path': 'installer.exe', 15:36:26 INFO - 'log_level': 'info', 15:36:26 INFO - 'log_name': 'talos', 15:36:26 INFO - 'log_to_console': True, 15:36:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:36:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:36:26 INFO - 'opt_config_files': (), 15:36:26 INFO - 'pip_index': False, 15:36:26 INFO - 'sps_profile': False, 15:36:26 INFO - 'sps_profile_interval': 0, 15:36:26 INFO - 'suite': 'dromaeojs-e10s', 15:36:26 INFO - 'system_bits': '64', 15:36:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:36:26 INFO - 'title': 'talos-linux64-ix-010', 15:36:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:36:26 INFO - 'use_talos_json': True, 15:36:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:36:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:36:26 INFO - 'work_dir': 'build'} 15:36:26 INFO - ##### 15:36:26 INFO - ##### Running clobber step. 15:36:26 INFO - ##### 15:36:26 INFO - Running pre-action listener: _resource_record_pre_action 15:36:26 INFO - Running main action method: clobber 15:36:26 INFO - rmtree: /builds/slave/test/build 15:36:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:36:26 INFO - Running post-action listener: _resource_record_post_action 15:36:26 INFO - ##### 15:36:26 INFO - ##### Running read-buildbot-config step. 15:36:26 INFO - ##### 15:36:26 INFO - Running pre-action listener: _resource_record_pre_action 15:36:26 INFO - Running main action method: read_buildbot_config 15:36:26 INFO - Using buildbot properties: 15:36:26 INFO - { 15:36:26 INFO - "properties": { 15:36:26 INFO - "buildnumber": 134, 15:36:26 INFO - "product": "firefox", 15:36:26 INFO - "script_repo_revision": "production", 15:36:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:36:26 INFO - "repository": "", 15:36:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:36:26 INFO - "buildid": "20151205152029", 15:36:26 INFO - "slavename": "talos-linux64-ix-010", 15:36:26 INFO - "pgo_build": "False", 15:36:26 INFO - "basedir": "/builds/slave/test", 15:36:26 INFO - "project": "", 15:36:26 INFO - "platform": "ubuntu64_hw", 15:36:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:36:26 INFO - "slavebuilddir": "test", 15:36:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:36:26 INFO - "branch": "mozilla-central", 15:36:26 INFO - "repo_path": "mozilla-central", 15:36:26 INFO - "stage_platform": "linux64", 15:36:26 INFO - "builduid": "72856fb371d04a888a89fde60e14d7e9", 15:36:26 INFO - "revision": "cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea" 15:36:26 INFO - }, 15:36:26 INFO - "sourcestamp": { 15:36:26 INFO - "repository": "", 15:36:26 INFO - "hasPatch": false, 15:36:26 INFO - "project": "", 15:36:26 INFO - "branch": "mozilla-central-linux64-talos", 15:36:26 INFO - "changes": [ 15:36:26 INFO - { 15:36:26 INFO - "category": null, 15:36:26 INFO - "files": [ 15:36:26 INFO - { 15:36:26 INFO - "url": null, 15:36:26 INFO - "name": "https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:36:26 INFO - } 15:36:26 INFO - ], 15:36:26 INFO - "repository": "", 15:36:26 INFO - "rev": "cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea", 15:36:26 INFO - "who": "dbaron@mozilla.com", 15:36:26 INFO - "when": 1449358538, 15:36:26 INFO - "number": 6808400, 15:36:26 INFO - "comments": "Back out changeset 9ebcec50fefa (bug 1223261) for causing unacceptable levels of intermittent orange (bug 1230015, bug 1230020). a=orange", 15:36:26 INFO - "project": "", 15:36:26 INFO - "at": "Sat 05 Dec 2015 15:35:38", 15:36:26 INFO - "branch": "mozilla-central-linux64-talos", 15:36:26 INFO - "revlink": "", 15:36:26 INFO - "properties": [ 15:36:26 INFO - [ 15:36:26 INFO - "buildid", 15:36:26 INFO - "20151205152029", 15:36:26 INFO - "Change" 15:36:26 INFO - ], 15:36:26 INFO - [ 15:36:26 INFO - "builduid", 15:36:26 INFO - "72856fb371d04a888a89fde60e14d7e9", 15:36:26 INFO - "Change" 15:36:26 INFO - ], 15:36:26 INFO - [ 15:36:26 INFO - "pgo_build", 15:36:26 INFO - "False", 15:36:26 INFO - "Change" 15:36:26 INFO - ] 15:36:26 INFO - ], 15:36:26 INFO - "revision": "cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea" 15:36:26 INFO - } 15:36:26 INFO - ], 15:36:26 INFO - "revision": "cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea" 15:36:26 INFO - } 15:36:26 INFO - } 15:36:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:36:26 INFO - Running post-action listener: _resource_record_post_action 15:36:26 INFO - ##### 15:36:26 INFO - ##### Running download-and-extract step. 15:36:26 INFO - ##### 15:36:26 INFO - Running pre-action listener: _resource_record_pre_action 15:36:26 INFO - Running main action method: download_and_extract 15:36:26 INFO - mkdir: /builds/slave/test/build/tests 15:36:26 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')]} 15:36:26 INFO - https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:36:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/test_packages.json 15:36:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/test_packages.json 15:36:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:36:32 INFO - Downloaded 1302 bytes. 15:36:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:36:32 INFO - Using the following test package requirements: 15:36:32 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:36:32 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:36:32 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'jsshell-linux-x86_64.zip'], 15:36:32 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:36:32 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:36:32 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:36:32 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:36:32 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:36:32 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:36:32 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:36:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:32 INFO - https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:37 INFO - Downloaded 21849359 bytes. 15:36:37 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 15:36:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:37 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 15:36:38 INFO - Return code: 0 15:36:38 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 15:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:38 INFO - https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:42 INFO - Downloaded 21849359 bytes. 15:36:42 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 15:36:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:36:42 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 15:36:43 INFO - Return code: 0 15:36:43 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')]} 15:36:43 INFO - https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:45 INFO - Downloaded 11132001 bytes. 15:36:45 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 15:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:45 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 15:36:45 INFO - Return code: 0 15:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:45 INFO - https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axeircW4QXODbqlq1hc1dw/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 15:36:47 INFO - Downloaded 57707612 bytes. 15:36:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:36:47 INFO - mkdir: /builds/slave/test/properties 15:36:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:36:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:36:47 INFO - Contents: 15:36:47 INFO - build_url:https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:36:47 INFO - Running post-action listener: _resource_record_post_action 15:36:47 INFO - Running post-action listener: set_extra_try_arguments 15:36:47 INFO - ##### 15:36:47 INFO - ##### Running populate-webroot step. 15:36:47 INFO - ##### 15:36:47 INFO - Running pre-action listener: _resource_record_pre_action 15:36:47 INFO - Running main action method: populate_webroot 15:36:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:36:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:36:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:36:47 INFO - '../fennec_ids.txt'], 15:36:47 INFO - 'tests': ['tcheck2']}, 15:36:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:36:47 INFO - '--tppagecycles', 15:36:47 INFO - '7'], 15:36:47 INFO - 'tests': ['tsvgm']}}, 15:36:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:36:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:36:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:36:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:36:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['damp', 'tps']}, 15:36:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['damp', 'tps']}, 15:36:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:36:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:36:47 INFO - 'other': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'other_l64': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'other_nol64': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore']}, 15:36:47 INFO - 'svgr': {'tests': ['tsvgx', 15:36:47 INFO - 'tsvgr_opacity', 15:36:47 INFO - 'tart', 15:36:47 INFO - 'tscrollx', 15:36:47 INFO - 'cart']}, 15:36:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['tsvgx', 15:36:47 INFO - 'tsvgr_opacity', 15:36:47 INFO - 'tart', 15:36:47 INFO - 'tscrollx', 15:36:47 INFO - 'cart']}, 15:36:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['tp5o']}, 15:36:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--e10s'], 15:36:47 INFO - 'tests': ['tp5o']}, 15:36:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--xperf_path', 15:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:47 INFO - 'tests': ['tp5n']}, 15:36:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--e10s', 15:36:47 INFO - '--xperf_path', 15:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:47 INFO - 'tests': ['tp5n']}}, 15:36:47 INFO - 'talos.zip': {'path': '', 15:36:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:36:47 INFO - Running post-action listener: _resource_record_post_action 15:36:47 INFO - ##### 15:36:47 INFO - ##### Running create-virtualenv step. 15:36:47 INFO - ##### 15:36:47 INFO - Running pre-action listener: _resource_record_pre_action 15:36:47 INFO - Running main action method: create_virtualenv 15:36:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:36:47 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 15:36:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:36:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:36:47 INFO - Using real prefix '/usr' 15:36:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:36:50 INFO - Installing pip.................done. 15:36:50 INFO - Return code: 0 15:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:36:50 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 15:36:50 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 15:36:50 INFO - Using env: {'DISPLAY': ':0', 15:36:50 INFO - 'HOME': '/home/cltbld', 15:36:50 INFO - 'LANG': 'en_US.UTF-8', 15:36:50 INFO - 'LANGUAGE': 'en_US:en', 15:36:50 INFO - 'LOGNAME': 'cltbld', 15:36:50 INFO - 'MAIL': '/var/mail/cltbld', 15:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:50 INFO - 'MOZ_NO_REMOTE': '1', 15:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:50 INFO - 'NO_EM_RESTART': '1', 15:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:50 INFO - 'PWD': '/builds/slave/test', 15:36:50 INFO - 'SHELL': '/bin/bash', 15:36:50 INFO - 'SHLVL': '1', 15:36:50 INFO - 'TERM': 'linux', 15:36:50 INFO - 'TMOUT': '86400', 15:36:50 INFO - 'USER': 'cltbld', 15:36:50 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:50 INFO - '_': '/tools/buildbot/bin/python'} 15:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:50 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 15:36:50 INFO - Cleaning up... 15:36:50 INFO - Return code: 0 15:36:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:36:50 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 15:36:50 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 15:36:50 INFO - Using env: {'DISPLAY': ':0', 15:36:50 INFO - 'HOME': '/home/cltbld', 15:36:50 INFO - 'LANG': 'en_US.UTF-8', 15:36:50 INFO - 'LANGUAGE': 'en_US:en', 15:36:50 INFO - 'LOGNAME': 'cltbld', 15:36:50 INFO - 'MAIL': '/var/mail/cltbld', 15:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:50 INFO - 'MOZ_NO_REMOTE': '1', 15:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:50 INFO - 'NO_EM_RESTART': '1', 15:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:50 INFO - 'PWD': '/builds/slave/test', 15:36:50 INFO - 'SHELL': '/bin/bash', 15:36:50 INFO - 'SHLVL': '1', 15:36:50 INFO - 'TERM': 'linux', 15:36:50 INFO - 'TMOUT': '86400', 15:36:50 INFO - 'USER': 'cltbld', 15:36:50 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:50 INFO - '_': '/tools/buildbot/bin/python'} 15:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:50 INFO - Downloading/unpacking psutil>=0.7.1 15:36:50 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 15:36:50 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 15:36:50 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 15:36:50 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 15:36:50 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 15:36:50 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 15:36:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:36:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:52 INFO - Installing collected packages: psutil 15:36:52 INFO - Running setup.py install for psutil 15:36:52 INFO - building 'psutil._psutil_linux' extension 15:36:52 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 15:36:52 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 15:36:52 INFO - building 'psutil._psutil_posix' extension 15:36:52 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 15:36:52 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 15:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:52 INFO - Successfully installed psutil 15:36:52 INFO - Cleaning up... 15:36:52 INFO - Return code: 0 15:36:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:52 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:36:52 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 15:36:52 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 15:36:52 INFO - Using env: {'DISPLAY': ':0', 15:36:52 INFO - 'HOME': '/home/cltbld', 15:36:52 INFO - 'LANG': 'en_US.UTF-8', 15:36:52 INFO - 'LANGUAGE': 'en_US:en', 15:36:52 INFO - 'LOGNAME': 'cltbld', 15:36:52 INFO - 'MAIL': '/var/mail/cltbld', 15:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:52 INFO - 'MOZ_NO_REMOTE': '1', 15:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:52 INFO - 'NO_EM_RESTART': '1', 15:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:52 INFO - 'PWD': '/builds/slave/test', 15:36:52 INFO - 'SHELL': '/bin/bash', 15:36:52 INFO - 'SHLVL': '1', 15:36:52 INFO - 'TERM': 'linux', 15:36:52 INFO - 'TMOUT': '86400', 15:36:52 INFO - 'USER': 'cltbld', 15:36:52 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:52 INFO - '_': '/tools/buildbot/bin/python'} 15:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:36:53 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 15:36:53 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 15:36:53 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 15:36:53 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 15:36:53 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 15:36:53 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 15:36:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:36:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:36:55 INFO - Installing collected packages: mozsystemmonitor 15:36:55 INFO - Running setup.py install for mozsystemmonitor 15:36:55 INFO - Successfully installed mozsystemmonitor 15:36:55 INFO - Cleaning up... 15:36:55 INFO - Return code: 0 15:36:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:36: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')]} 15:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36: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')]} 15:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:36:55 INFO - Using env: {'DISPLAY': ':0', 15:36:55 INFO - 'HOME': '/home/cltbld', 15:36:55 INFO - 'LANG': 'en_US.UTF-8', 15:36:55 INFO - 'LANGUAGE': 'en_US:en', 15:36:55 INFO - 'LOGNAME': 'cltbld', 15:36:55 INFO - 'MAIL': '/var/mail/cltbld', 15:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:55 INFO - 'MOZ_NO_REMOTE': '1', 15:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:55 INFO - 'NO_EM_RESTART': '1', 15:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:55 INFO - 'PWD': '/builds/slave/test', 15:36:55 INFO - 'SHELL': '/bin/bash', 15:36:55 INFO - 'SHLVL': '1', 15:36:55 INFO - 'TERM': 'linux', 15:36:55 INFO - 'TMOUT': '86400', 15:36:55 INFO - 'USER': 'cltbld', 15:36:55 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:55 INFO - '_': '/tools/buildbot/bin/python'} 15:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - Downloading blobuploader-1.2.4.tar.gz 15:36:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:36:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:36:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:57 INFO - Downloading docopt-0.6.1.tar.gz 15:36:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:36:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:36:57 INFO - Running setup.py install for blobuploader 15:36:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:36:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:36:58 INFO - Running setup.py install for requests 15:36:58 INFO - Running setup.py install for docopt 15:36:58 INFO - Successfully installed blobuploader requests docopt 15:36:58 INFO - Cleaning up... 15:36:58 INFO - Return code: 0 15:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:58 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:36:58 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 15:36:58 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 15:36:58 INFO - Using env: {'DISPLAY': ':0', 15:36:58 INFO - 'HOME': '/home/cltbld', 15:36:58 INFO - 'LANG': 'en_US.UTF-8', 15:36:58 INFO - 'LANGUAGE': 'en_US:en', 15:36:58 INFO - 'LOGNAME': 'cltbld', 15:36:58 INFO - 'MAIL': '/var/mail/cltbld', 15:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:58 INFO - 'MOZ_NO_REMOTE': '1', 15:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:58 INFO - 'NO_EM_RESTART': '1', 15:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:58 INFO - 'PWD': '/builds/slave/test', 15:36:58 INFO - 'SHELL': '/bin/bash', 15:36:58 INFO - 'SHLVL': '1', 15:36:58 INFO - 'TERM': 'linux', 15:36:58 INFO - 'TMOUT': '86400', 15:36:58 INFO - 'USER': 'cltbld', 15:36:58 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:58 INFO - '_': '/tools/buildbot/bin/python'} 15:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:36:58 INFO - Running setup.py (path:/tmp/pip-UXEu5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:36:58 INFO - Running setup.py (path:/tmp/pip-sCCoFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:36:58 INFO - Running setup.py (path:/tmp/pip-LIJTSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:36:58 INFO - Running setup.py (path:/tmp/pip-HKtKqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:36:59 INFO - Running setup.py (path:/tmp/pip-UWENzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:36:59 INFO - Running setup.py (path:/tmp/pip-c6dLEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:36:59 INFO - Running setup.py (path:/tmp/pip-NEAHCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:36:59 INFO - Running setup.py (path:/tmp/pip-aIflkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:36:59 INFO - Running setup.py (path:/tmp/pip-qpfKE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:36:59 INFO - Running setup.py (path:/tmp/pip-7zAyNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:36:59 INFO - Running setup.py (path:/tmp/pip-QCkLZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:36:59 INFO - Running setup.py (path:/tmp/pip-dQXmbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:36:59 INFO - Running setup.py (path:/tmp/pip-qSJ84U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:36:59 INFO - Running setup.py (path:/tmp/pip-pPyPwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:59 INFO - Running setup.py (path:/tmp/pip-TvHHDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:36:59 INFO - Running setup.py (path:/tmp/pip-eXaazD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:36:59 INFO - Running setup.py (path:/tmp/pip-ugb7DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:36:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:36:59 INFO - Running setup.py install for manifestparser 15:37:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for mozcrash 15:37:00 INFO - Running setup.py install for mozdebug 15:37:00 INFO - Running setup.py install for mozdevice 15:37:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for mozfile 15:37:00 INFO - Running setup.py install for mozhttpd 15:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for mozinfo 15:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for mozInstall 15:37:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for mozleak 15:37:00 INFO - Running setup.py install for mozlog 15:37:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:37:00 INFO - Running setup.py install for moznetwork 15:37:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Running setup.py install for mozprocess 15:37:01 INFO - Running setup.py install for mozprofile 15:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Running setup.py install for mozrunner 15:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Running setup.py install for mozscreenshot 15:37:01 INFO - Running setup.py install for moztest 15:37:01 INFO - Running setup.py install for mozversion 15:37:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:37:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:37:01 INFO - Cleaning up... 15:37:01 INFO - Return code: 0 15:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:01 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')]} 15:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:01 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')]} 15:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:01 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:37:01 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 15:37:01 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 15:37:01 INFO - Using env: {'DISPLAY': ':0', 15:37:01 INFO - 'HOME': '/home/cltbld', 15:37:01 INFO - 'LANG': 'en_US.UTF-8', 15:37:01 INFO - 'LANGUAGE': 'en_US:en', 15:37:01 INFO - 'LOGNAME': 'cltbld', 15:37:01 INFO - 'MAIL': '/var/mail/cltbld', 15:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:01 INFO - 'MOZ_NO_REMOTE': '1', 15:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:01 INFO - 'NO_EM_RESTART': '1', 15:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:01 INFO - 'PWD': '/builds/slave/test', 15:37:01 INFO - 'SHELL': '/bin/bash', 15:37:01 INFO - 'SHLVL': '1', 15:37:01 INFO - 'TERM': 'linux', 15:37:01 INFO - 'TMOUT': '86400', 15:37:01 INFO - 'USER': 'cltbld', 15:37:01 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:01 INFO - '_': '/tools/buildbot/bin/python'} 15:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:01 INFO - Running setup.py (path:/tmp/pip-tco73P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:02 INFO - Running setup.py (path:/tmp/pip-CK7Qwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:02 INFO - Running setup.py (path:/tmp/pip-PStKj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:02 INFO - Running setup.py (path:/tmp/pip-X56PAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:02 INFO - Running setup.py (path:/tmp/pip-LUZRo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:02 INFO - Running setup.py (path:/tmp/pip-tPFuo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:02 INFO - Running setup.py (path:/tmp/pip-lCBnYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:02 INFO - Running setup.py (path:/tmp/pip-qEOMPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:02 INFO - Running setup.py (path:/tmp/pip-N7norh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:02 INFO - Running setup.py (path:/tmp/pip-2tQ7ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:02 INFO - Running setup.py (path:/tmp/pip-78mKcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:02 INFO - Running setup.py (path:/tmp/pip-Sli__o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:02 INFO - Running setup.py (path:/tmp/pip-JD7pUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:02 INFO - Running setup.py (path:/tmp/pip-w3Wa5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:02 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)) 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:02 INFO - Running setup.py (path:/tmp/pip-0_ElNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:03 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)) 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:03 INFO - Running setup.py (path:/tmp/pip-TTImoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:03 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)) 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:03 INFO - Running setup.py (path:/tmp/pip-pd_sBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:03 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)) 15:37:03 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)) 15:37:03 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)) 15:37:03 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)) 15:37:03 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)) 15:37:03 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)) 15:37:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:04 INFO - Downloading blessings-1.5.1.tar.gz 15:37:04 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 15:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:37:04 INFO - Installing collected packages: blessings 15:37:04 INFO - Running setup.py install for blessings 15:37:05 INFO - Successfully installed blessings 15:37:05 INFO - Cleaning up... 15:37:05 INFO - Return code: 0 15:37:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:05 INFO - Reading from file tmpfile_stdout 15:37:05 INFO - Current package versions: 15:37:05 INFO - argparse == 1.2.1 15:37:05 INFO - blessings == 1.5.1 15:37:05 INFO - blobuploader == 1.2.4 15:37:05 INFO - docopt == 0.6.1 15:37:05 INFO - manifestparser == 1.1 15:37:05 INFO - mozInstall == 1.12 15:37:05 INFO - mozcrash == 0.16 15:37:05 INFO - mozdebug == 0.1 15:37:05 INFO - mozdevice == 0.47 15:37:05 INFO - mozfile == 1.2 15:37:05 INFO - mozhttpd == 0.7 15:37:05 INFO - mozinfo == 0.9 15:37:05 INFO - mozleak == 0.1 15:37:05 INFO - mozlog == 3.1 15:37:05 INFO - moznetwork == 0.27 15:37:05 INFO - mozprocess == 0.22 15:37:05 INFO - mozprofile == 0.27 15:37:05 INFO - mozrunner == 6.11 15:37:05 INFO - mozscreenshot == 0.1 15:37:05 INFO - mozsystemmonitor == 0.0 15:37:05 INFO - moztest == 0.7 15:37:05 INFO - mozversion == 1.4 15:37:05 INFO - psutil == 3.1.1 15:37:05 INFO - requests == 1.2.3 15:37:05 INFO - wsgiref == 0.1.2 15:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:05 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')]} 15:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 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')]} 15:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:37:05 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 15:37:05 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 15:37:05 INFO - Using env: {'DISPLAY': ':0', 15:37:05 INFO - 'HOME': '/home/cltbld', 15:37:05 INFO - 'LANG': 'en_US.UTF-8', 15:37:05 INFO - 'LANGUAGE': 'en_US:en', 15:37:05 INFO - 'LOGNAME': 'cltbld', 15:37:05 INFO - 'MAIL': '/var/mail/cltbld', 15:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:05 INFO - 'MOZ_NO_REMOTE': '1', 15:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:05 INFO - 'NO_EM_RESTART': '1', 15:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:05 INFO - 'PWD': '/builds/slave/test', 15:37:05 INFO - 'SHELL': '/bin/bash', 15:37:05 INFO - 'SHLVL': '1', 15:37:05 INFO - 'TERM': 'linux', 15:37:05 INFO - 'TMOUT': '86400', 15:37:05 INFO - 'USER': 'cltbld', 15:37:05 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:05 INFO - '_': '/tools/buildbot/bin/python'} 15:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 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)) 15:37:05 INFO - Cleaning up... 15:37:05 INFO - Return code: 0 15:37:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:37:05 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')]} 15:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 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')]} 15:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:37:05 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 15:37:05 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 15:37:05 INFO - Using env: {'DISPLAY': ':0', 15:37:05 INFO - 'HOME': '/home/cltbld', 15:37:05 INFO - 'LANG': 'en_US.UTF-8', 15:37:05 INFO - 'LANGUAGE': 'en_US:en', 15:37:05 INFO - 'LOGNAME': 'cltbld', 15:37:05 INFO - 'MAIL': '/var/mail/cltbld', 15:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:05 INFO - 'MOZ_NO_REMOTE': '1', 15:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:05 INFO - 'NO_EM_RESTART': '1', 15:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:05 INFO - 'PWD': '/builds/slave/test', 15:37:05 INFO - 'SHELL': '/bin/bash', 15:37:05 INFO - 'SHLVL': '1', 15:37:05 INFO - 'TERM': 'linux', 15:37:05 INFO - 'TMOUT': '86400', 15:37:05 INFO - 'USER': 'cltbld', 15:37:05 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:05 INFO - '_': '/tools/buildbot/bin/python'} 15:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:05 INFO - Downloading/unpacking jsonschema 15:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:37:07 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 15:37:07 INFO - Downloading/unpacking functools32 (from jsonschema) 15:37:07 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 15:37:07 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 15:37:07 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 15:37:07 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 15:37:07 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 15:37:07 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 15:37:07 INFO - Downloading functools32-3.2.3-2.tar.gz 15:37:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:37:07 INFO - warning: no files found matching '*.txt' 15:37:07 INFO - no previously-included directories found matching 'build' 15:37:07 INFO - no previously-included directories found matching 'dist' 15:37:07 INFO - no previously-included directories found matching '.git*' 15:37:07 INFO - Installing collected packages: jsonschema, functools32 15:37:07 INFO - Running setup.py install for functools32 15:37:07 INFO - warning: no files found matching '*.txt' 15:37:07 INFO - no previously-included directories found matching 'build' 15:37:07 INFO - no previously-included directories found matching 'dist' 15:37:07 INFO - no previously-included directories found matching '.git*' 15:37:07 INFO - Successfully installed jsonschema functools32 15:37:07 INFO - Cleaning up... 15:37:07 INFO - Return code: 0 15:37:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:37: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')]} 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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')]} 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fe24ac29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20aa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', '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 15:37:07 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 15:37:07 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 15:37:07 INFO - Using env: {'DISPLAY': ':0', 15:37:07 INFO - 'HOME': '/home/cltbld', 15:37:07 INFO - 'LANG': 'en_US.UTF-8', 15:37:07 INFO - 'LANGUAGE': 'en_US:en', 15:37:07 INFO - 'LOGNAME': 'cltbld', 15:37:07 INFO - 'MAIL': '/var/mail/cltbld', 15:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:07 INFO - 'MOZ_NO_REMOTE': '1', 15:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:07 INFO - 'NO_EM_RESTART': '1', 15:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:07 INFO - 'PWD': '/builds/slave/test', 15:37:07 INFO - 'SHELL': '/bin/bash', 15:37:07 INFO - 'SHLVL': '1', 15:37:07 INFO - 'TERM': 'linux', 15:37:07 INFO - 'TMOUT': '86400', 15:37:07 INFO - 'USER': 'cltbld', 15:37:07 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:07 INFO - '_': '/tools/buildbot/bin/python'} 15:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:08 INFO - Downloading/unpacking flake8 15:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:37:09 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 15:37:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:37:09 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 15:37:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:09 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 15:37:10 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 15:37:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:37:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:37:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:37:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:37:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:37:10 INFO - no previously-included directories found matching 'docs/_build' 15:37:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:37:10 INFO - Running setup.py install for pep8 15:37:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:37:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:37:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:37:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:37:10 INFO - no previously-included directories found matching 'docs/_build' 15:37:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:37:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:37:10 INFO - Cleaning up... 15:37:10 INFO - Return code: 0 15:37:10 INFO - Running post-action listener: _resource_record_post_action 15:37:10 INFO - Running post-action listener: _start_resource_monitoring 15:37:10 INFO - Starting resource monitoring. 15:37:10 INFO - ##### 15:37:10 INFO - ##### Running install step. 15:37:10 INFO - ##### 15:37:10 INFO - Running pre-action listener: _resource_record_pre_action 15:37:10 INFO - Running main action method: install 15:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:10 INFO - Reading from file tmpfile_stdout 15:37:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:37:10 INFO - Reading from file tmpfile_stdout 15:37:10 INFO - Output received: 15:37:10 INFO - Usage: mozinstall [options] installer 15:37:10 INFO - Options: 15:37:10 INFO - -h, --help show this help message and exit 15:37:10 INFO - -d DEST, --destination=DEST 15:37:10 INFO - Directory to install application into. [default: 15:37:10 INFO - "/builds/slave/test"] 15:37:10 INFO - --app=APP Application being installed. [default: firefox] 15:37:10 INFO - mkdir: /builds/slave/test/build/application 15:37:10 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'] 15:37:10 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 15:37:25 INFO - Reading from file tmpfile_stdout 15:37:25 INFO - Output received: 15:37:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:37:25 INFO - Running post-action listener: _resource_record_post_action 15:37:25 INFO - ##### 15:37:25 INFO - ##### Running run-tests step. 15:37:25 INFO - ##### 15:37:25 INFO - Running pre-action listener: _resource_record_pre_action 15:37:25 INFO - Running main action method: run_tests 15:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:37:25 INFO - Python 2.7.3 15:37:25 INFO - Return code: 0 15:37:25 INFO - grabbing minidump binary from tooltool 15:37:25 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')]} 15:37:25 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 0x21390b0>, '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 0x2139fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:37:25 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 15:37:25 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 15:37:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:37:25 INFO - Return code: 0 15:37:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:37:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:37:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:37:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:37:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:37:26 INFO - Return code: 0 15:37:26 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/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test/build 15:37:26 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/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 15:37:26 INFO - Using env: {'DISPLAY': ':0', 15:37:26 INFO - 'HOME': '/home/cltbld', 15:37:26 INFO - 'LANG': 'en_US.UTF-8', 15:37:26 INFO - 'LANGUAGE': 'en_US:en', 15:37:26 INFO - 'LOGNAME': 'cltbld', 15:37:26 INFO - 'MAIL': '/var/mail/cltbld', 15:37:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:37:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:26 INFO - 'MOZ_NO_REMOTE': '1', 15:37:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:26 INFO - 'NO_EM_RESTART': '1', 15:37:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:26 INFO - 'PWD': '/builds/slave/test', 15:37:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:37:26 INFO - 'SHELL': '/bin/bash', 15:37:26 INFO - 'SHLVL': '1', 15:37:26 INFO - 'TERM': 'linux', 15:37:26 INFO - 'TMOUT': '86400', 15:37:26 INFO - 'USER': 'cltbld', 15:37:26 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226', 15:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:26 INFO - '_': '/tools/buildbot/bin/python'} 15:37:26 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/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 15:37:26 INFO - mozversion INFO | application_buildid: 20151205152029 15:37:26 INFO - mozversion INFO | application_changeset: cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea 15:37:26 INFO - mozversion INFO | application_display_name: Nightly 15:37:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:37:26 INFO - mozversion INFO | application_name: Firefox 15:37:26 INFO - mozversion INFO | application_remotingname: firefox 15:37:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:37:26 INFO - mozversion INFO | application_vendor: Mozilla 15:37:26 INFO - mozversion INFO | application_version: 45.0a1 15:37:26 INFO - mozversion INFO | platform_buildid: 20151205152029 15:37:26 INFO - mozversion INFO | platform_changeset: cc9c6cd756cb744596ba039dcc5ad3065a7cc3ea 15:37:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:37:26 INFO - mozversion INFO | platform_version: 45.0a1 15:37:26 INFO - 2015-12-05 15:37:26,703 DEBUG : using testdate: 1449358646 15:37:26 INFO - 2015-12-05 15:37:26,703 DEBUG : actual date: 1449358646 15:37:26 INFO - 2015-12-05 15:37:26,798 INFO : starting webserver on 'localhost:49548' 15:37:26 INFO - 2015-12-05 15:37:26,799 INFO : Starting test suite talos-linux64-ix-010.e 15:37:26 INFO - 2015-12-05 15:37:26,799 INFO : Starting test dromaeo_css 15:37:26 INFO - 2015-12-05 15:37:26,799 DEBUG : operating with platform_type : linux_ 15:37:26 INFO - 2015-12-05 15:37:26,800 INFO : Initialising browser for dromaeo_css test... 15:37:26 INFO - 2015-12-05 15:37:26,812 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01qEQX/profile http://localhost:49548/getInfo.html 15:37:31 INFO - 2015-12-05 15:37:31,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:37:31 INFO - 2015-12-05 15:37:31,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:37:31 INFO - 2015-12-05 15:37:31,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:37:31 INFO - 2015-12-05 15:37:31,585 DEBUG : BROWSER_OUTPUT: __metrics 15:37:31 INFO - 2015-12-05 15:37:31,729 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:37:32 INFO - 2015-12-05 15:37:32,661 INFO : Browser initialized. 15:37:32 INFO - 2015-12-05 15:37:32,662 INFO : Running cycle 1/1 for dromaeo_css test... 15:37:32 INFO - 2015-12-05 15:37:32,662 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01qEQX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:37:44 INFO - 2015-12-05 15:37:44,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 143192064 15:37:44 INFO - 2015-12-05 15:37:44,702 DEBUG : BROWSER_OUTPUT: 15:38:34 INFO - 2015-12-05 15:38:34,326 DEBUG : BROWSER_OUTPUT: 1449358714325 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] 15:40:46 INFO - 2015-12-05 15:40:46,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49548/tests/dromaeo/cssquery-ext.html) 15:40:47 INFO - 2015-12-05 15:40:47,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 148320256 15:40:47 INFO - 2015-12-05 15:40:47,675 DEBUG : BROWSER_OUTPUT: 15:43:49 INFO - 2015-12-05 15:43:49,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-ext.html (next: http://localhost:49548/tests/dromaeo/cssquery-jquery.html) 15:43:50 INFO - 2015-12-05 15:43:50,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 144793600 15:43:50 INFO - 2015-12-05 15:43:50,344 DEBUG : BROWSER_OUTPUT: 15:46:52 INFO - 2015-12-05 15:46:52,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49548/tests/dromaeo/cssquery-mootools.html) 15:46:52 INFO - 2015-12-05 15:46:52,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 145661952 15:46:52 INFO - 2015-12-05 15:46:52,822 DEBUG : BROWSER_OUTPUT: 15:49:54 INFO - 2015-12-05 15:49:54,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49548/tests/dromaeo/cssquery-prototype.html) 15:49:55 INFO - 2015-12-05 15:49:55,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 144564224 15:49:55 INFO - 2015-12-05 15:49:55,167 DEBUG : BROWSER_OUTPUT: 15:52:57 INFO - 2015-12-05 15:52:57,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49548/tests/dromaeo/cssquery-yui.html) 15:52:58 INFO - 2015-12-05 15:52:58,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 145031168 15:52:58 INFO - 2015-12-05 15:52:58,420 DEBUG : BROWSER_OUTPUT: 15:56:00 INFO - 2015-12-05 15:56:00,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/dromaeo/cssquery-yui.html (next: http://localhost:49548/tests/dromaeo/cssquery-dojo.html) 15:56:00 INFO - 2015-12-05 15:56:00,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 147619840 15:56:00 INFO - 2015-12-05 15:56:00,983 DEBUG : BROWSER_OUTPUT: 15:56:00 INFO - 2015-12-05 15:56:00,985 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:56:00 INFO - 2015-12-05 15:56:00,985 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:56:00 INFO - 2015-12-05 15:56:00,985 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:56:00 INFO - 2015-12-05 15:56:00,985 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:56:00 INFO - 2015-12-05 15:56:00,988 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2668.773154281886;2697.9190624281277;2729.194887508185;2737.3293543081936;2745.6018877262804;4497.280435130379;4676.929846052308;4677.649176311773;4712.340272361864;4725.432948046235;4632.652551058667;4642.419697537808;4644.442666879979;4749.596284315838;4773.260144677572;4229.830806767741;4254.212970600441;4323.610875021247;4329.112531930962;4354.499232588261;4323.848665296715;4327.307630779076;4346.282863327548;4392.516823149451;4422.071365013351;4126.42230087788;4233.7883105844585;4248.34150706641;4350.608445239912;4408.933865992013;4279.165562715271;4305.5694430557005;4320.870373888757;4336.696431249814;4345.217860785057;4262.616364527207;4275.615194632467;4291.399204111427;4316.201502721975;4366;4403.361512580658;4502.864914052584;4537.705049171794;4619.330197121399;4671.6262698984;4906;4927.531884470969;4954.5293197146575;4956.702597844141;4977.527134922177;5034.496550344937;5047.242913562958;5050.444451110375;5067.239914012891;5072.163093089635;4487.551244875552;4494.662900282492;4613.561711637456;4617.3074038893765;4619.584237418649;5020.49795020495;5031.094403007493;5039.974800125976;5061.4179369373;5079.4412614612365;4840.927386089212;4844.128056949783;4846.466888642247;4872.3909511311085;4890.388701412324;4753.857384278408;4852.8544143675745;4866.197077482176;4922.75386230687;4993.425756038029;4957.677750946177;4980.626453016038;4982.725950072709;4986.975065124651;5036.244563315458;4762.499937506581;4954.925676114861;4968.503149685002;4969.155243608595;5000.699958002531;4080.2859499587453;4083.8570650027104;4159.209750147463;4162.354835000579;4207.200631879994;3653.232821107544;3663.0292972362345;3667.211549516867;3669.156094098319;3688.2623475305045;4161.292580261363;4251.192273468031;4353.651707863363;4358.280883654162;4386.978065109654;4911.582515486152;4973.90052198954;4977;4977.726225057584;5021.5229553192385;4301.09676967834;4321.805518751664;4322.0491491871735;4363.847265345697;4386.144701783185;4246.341817018367;4355.020120472868;4358.585934336233;4411.1618792429335;4425.35832304314;4776.904461910812;4780.330753694555;4800.447948485829;4802.639802014933;4860;5032.04391165692;5032.220005899091;5036.697798132123;5038.596912247085;5047.823326183566;4462.330650402466;4548.408706868086;4669.229577119737;4748.881277968078;4806.49531799156;4836.637252206028;4865.80536778539;4882.292067650242;4889.657723959289;4901.044296362318;4944.208926571731;4949.109160351171;4963.801447942042;4974.253861920741;4984.675996060245;4752.310914917249;4824.951750482591;4880.78036488366;4880.99939512392;4924.212126059813;4839.854804355875;4863.124637565272;4878.682885612424;4896.828610998598;4919.237518184687;4623.12160689468;4752.881177970578;4774.092922344744;4785.138675038526;4785.306130610972;4833.10587541306;4841.225403935354;4868.926966095441;4876.00041991398;4891.241857512091;4776.020915712201;4785.258284965836;4788.4253889533475;4791.856244312677;4822.68652537584 15:56:00 INFO - 2015-12-05 15:56:00,990 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.8661121330882;562.5949316492125;574.7068994812645;579.8405438504411;620.2340109964197;37623.81188094059;38191.236175276514;38496.42255366168;38506;38580.614193858055;39116.80441597788;39374.80312598433;39579.208415831665;39594.40608390876;39672;7812.570308633023;7860;7947.483413578099;7951.324137448324;7961.323287520568;7758.224177582225;7816.570088645122;7822.804429889241;7832.412569057315;7833.295003449688;7744.496607720508;7820.921790782105;7910.208979102102;7921.881171782399;7926.722564710236;7866.567338796364;7993.640286187136;8004.799880002988;8020.398470114736;8034;7777.2222777722345;7905.288524032865;7922.881156782653;7955.4033447491665;7976.401769867283;36327.4550881737;36405.63594364075;36633.63366366329;36700.816495917614;36737.448938265945;2696.514627367073;2759.2412086676322;2860.442213768316;3126.9212121817936;3162.8734850605947;27455.039073632328;27607;27643.308917277027;28123.43753124926;28303.71696283052;3421.897343079687;3491.14466955595;3536.0099172231817;3536.982315088408;3580.7314451416246;226187;226814;227638;229146;230063;47531.76234118876;48396;56313.71843140758;56643.71678141665;56828.14757778637;67589.66205169041;68080.6595967017;68267;68744;68843;13679.384427700777;13838.4464621414;13876.375563099482;13876.930615346859;13955.58133256004;11129.443527823576;11162.441877906072;11187.160962927814;11196.38419886914;11196.832047519294;19171.32900348481;19280.132394042303;19427;19481.318153864548;19569.902150489157;7653.5407875526535;7900.972873526404;7957.010747313172;7970.721024764105;8124.309433698084;866.7746385939575;890.6838072484304;913.949732764691;922.916937475617;1005.1197668597873;25747.871260643577;26022.86988565045;26477.602835957478;26623.201303960912;27218.591721124198;947.9715608531756;958.6548842416724;987.1855719031828;993.6869885985891;1060.3637817309707;13586.252756098313;13628.386722597506;15766.9211653941;16067.357305707874;16500;320673;324037;324777;325599;327409;48239.75880120577;48465.515344846805;48862.511374886504;48894.75552622214;49101.50898491041;1236.3509157692283;1252.8747125287398;1263.7156639756165;1269.955551555691;1270.0474644016801;27640;27720.866208492545;27826.304342391602;28040.85979570089;28450.85774571114;39733.403998940616;40360.3945940817;40401.595984039785;40437.1912561753;40494.392584111854;253216;256409;256685;257326;258369;29526.114216573536;41646.37530437107;42745.1450970985;42866.57133428626;43251.35122973221;41625;42835.7858210707;43789.56210437855;46329.768351158025;46723.53276467328;33565;33599.664003359656;34161;34387.82806085954;34687.479687804196;33972;34361.65638343684;34406.795762148206;34419.483707744905;34757.13107172341;33670.49494257539;34346.313073738886;34553.82723086469;34555.65444345524;34693.653063470054;29022.419551608426;31101.688983110784;31163.688363116984;31210.843945780125;31336.21659458532;24445.75554244435;24536.263912082664;24659.506809864062;24723.25830225096;24735.38161545976 15:56:00 INFO - 2015-12-05 15:56:00,993 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.2414570633251;332.4514550990865;332.6523782647134;334.3680443960914;338.6765638814932;10295.176385889139;10343.948280258588;10720.946395268013;15092.24538773061;15547.14490703011;16266.105364204965;16332;16500;16678;16723.247453864577;5342.946570534304;5694.259746232984;5697.401772813857;5697.515711164556;5703.686297253649;5634.32388113427;5654.632448890829;5655.632383895054;5657.2928383952;5675.404082571333;3896.7856767877756;4022.8994275143064;6167.7841275555365;6375.8406039848915;6380.585261957958;6705.966470167618;6735.764248251312;6750;6757.526973111909;6767.864642707143;5867.207926929853;6070.119832624289;6070.21087258658;6080.756769729205;6081.756729730805;19397.127129279215;19464.221431142738;19865.20539178431;19891.104900279523;20072;1749.9562510937328;1830.588117673526;1831.8992455414948;1889.5842914558775;1943.3004118517322;13440.798388024188;13929.094608850493;14031.298435078308;14354.138751674933;14537.200453975027;1790.1586254460383;1812.9842399085956;1819.5269230000295;1825.2881376263135;1870.700687889931;58810.41189588092;63228.051579226805;63255.68372158156;63373.36626633721;64352.3564764351;15848.603784905239;15864.52406427809;15886.285117169755;15936.681266374608;16053.876228664116;23109;23116.76883231146;23300.7669923302;23315.53368932612;23430.4226535081;8651.52416617092;8857.689980850639;8916.751654768337;8964.193222609996;8970.282377409792;7392.334689877936;7403.66683499233;7479.850402992019;7497;7525.172231054579;7697.230276972258;7768.7669369918995;7769.223077692185;7804.180561041009;7824;3122.5784519090084;3128.655847856734;3145.937081258362;3162.3517178978254;3212.1969507623094;354.6081579854224;358.57867006268054;367.6470588235324;373.3932359915138;377.63558166369035;10196.235282353853;10322.845157322647;10428.426436546062;10537.262391632512;10638.095761860173;375.68442508292617;390.2651623958744;390.84756944791553;397.43762575955276;408.1286453421906;5598.3282006159525;5602.579806514527;5682.090865461506;5711.286089238845;5728.541716662657;476150;478985;479296;496842;497203;70278;72101.63949180221;73767.26232737712;74478.6276068627;74496.25503745001;415.59064321643154;417.53236375259905;418.35782074515475;420.8169446290812;421.5278887645856;9553;9761.60953561878;9864.605415783288;9877.901220987698;9954.701358959242;32397;32973.34053318872;33388.666113339525;33554.496682549296;33716;42426.78786606047;43511.78244108886;43699.56300436955;44573.55426445694;44662.3300650484;8816.735497934817;9008.369414141209;9084.954575227082;9115.863262051207;9135.725928221898;10557.102646275152;13601.387937542637;16057.839421605635;16520.42178523746;16788.664226715642;10937;12721.173123746927;13140.671483212996;13589.388477518338;14377.065490743487;12574.874251257736;12578.245305281713;13122.671933201364;13222.140560863512;13242;13095.869041309847;13139.277339746406;13499.86500134986;13771.517996870061;13775.104618199784;8621.784455388666;8883.067277935723;8886.4668119913;8892.288616910502;8956.68651597191;13813.309334533033;13955.441782328593;14019.439222430989;14219.786703199254;14324.427022918966 15:56:00 INFO - 2015-12-05 15:56:00,997 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1468.8531146885307;1701.1834319526627;1761.867859910507;1779.7063484525054;1782.6167374014585;6781.118454600901;7183.928160718391;7299.416046716263;7406.07424071991;7577.77266681999;7488.101427828655;7510.136334321554;7576;7576.924230757691;7587.203343648906;2117.851750377474;2151.515908920496;2155.6012137754487;2156.2345367394582;2156.956860862782;2070.534129820793;2126.6916297136904;2150.7526634437086;2162.081115525903;2172.6849606807004;1667.9749803752954;1717.7509261157124;2047.5495391013953;2058.4133521946246;2073.2743539761036;1869.569998900247;1881.1628825172804;1884.5948121154017;1888.4523488188477;1889.0460317539691;2031.9492012699652;2046.5088378789133;2096.4968407582223;2097.2974053692033;2109.1985045682695;7320.158181809107;7386.704531818721;7445.739399121005;7456.813579660497;7469.738559150458;4338.067315527145;4414.53647367025;4425.712328698624;4428.911421771579;4440.2895536714295;2743.43759529296;2760.5997130415976;2798.6221860048836;2805.803593748418;2808.817426867247;851.676362982069;862.5471627395605;863.197226579281;865.346663269234;889.0531583863229;9963.551640176138;9998.550065247082;10031.398116113056;10059.748506287255;10105.848412273821;3797.3354662933875;3803.67668748154;3866.9613303867163;3905.824237909301;3929.115948911472;8081.030276366756;8118.553479558563;8133.349332053422;8141.470804397695;8149.225823546753;4262.978685106555;4294.119705460374;4295.613394794484;4299;4299.78501074945;3912.7847968361443;3916.980415097906;3931.567527571965;3936.7637941723588;3947.467091942551;3138.466460701686;3160.920976975594;3179.4594918863386;3201.279712064767;3204.647488776233;893.8525143351275;923.0354279777514;935.504182783126;937.1986951156799;940.0411580188306;821.4003777242527;865.4288169807896;930.065284389198;1197.0662882951312;1229.2255878796302;6858.794236172823;6878.8624227515165;6899.75850845218;6912.861742765116;6914.446844252448;576.1012820000813;584.0363400389391;584.9005669036274;589.4370875813588;730.819726142287;5157.097507936096;5264.947350526446;5276.997370499669;5278.181881808326;5307.389650190277;8230.053543842416;8906.06486318927;8921.866172007425;8972.968108667455;8990.505522196341;8744.256738177199;8745.912540874637;8776.692815751418;8881.156290152425;8886;6869.725210991604;6956.339147780953;6995.055667484824;7002.439804815603;7007.089078419875;6702.430293425114;6711.899321510084;6719.328067193242;6723.697433615401;6725.226598941184;7665.961670191613;7717.2668596483245;7827.84344313122;7962.562059086806;7964.960175199087;7807.726729564665;8060.435769496079;8075;8082.838343232985;8170.387220958333;6037.849053773691;6047.183630209865;6084.6349219047;6171.166892469639;6208.161898143693;6958.165020197609;6988.965055174692;7012;7020.403265722471;7047.295270472911;6428.260750013808;6757.898631520629;6764.154480689914;6769.695363708546;6863.313668633096;6122.142899993915;6611.933880661132;6670.299618539983;6690.83272918181;6691.1636045494315;5286.920696189483;5405.432429594836;6063.666498342457;6159.81520554384;6168.8766224674355;5912.970435147797;5942.58401911862;5967.582269241111;5969.850753731192;5974.940250597612;5650.57620678459;5689.459501347365;5830.4461076197695;5878.2358293421585;5904.0553511437965 15:56:00 INFO - 2015-12-05 15:56:00,998 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.8515816301034;278.39310303538286;278.5126029448465;288.0307764372886;289.2104554566035;5341.626086173959;5424.267723857278;5438.320209973754;5487.835364939053;5514.172874068891;5264.6051546134;5416.972915135429;5417.349918009834;5420.024395608789;5428.4842939920645;4089.182163567291;4113.588641135892;4114.526829414625;4120.58794120587;4141.4409054777525;4118.38224266361;4137.069159439132;4137.896552586194;4146.60607242313;4151;4031.4557534732876;4083.5508094109623;4103.076807718269;4108.322126849066;4116.156187981472;4080.9387859182134;4119.958800412018;4124.9587504124875;4126.09225970286;4128.814203360856;3561.94657080144;3565.858925143955;3566.732495062881;3575.94636080459;3585.9421470666216;5221.321228240305;5223.947760522384;5224.138017227153;5229.111051121318;5232.2674825524455;4751.976240118812;4753.738544380058;4754.809807607691;4759;4759.071980963713;5560.81064523242;5646.6894320812335;5665.753534222465;5692.288463942007;5695.288088988877;3901.161250331164;3903;3907.33575292201;3914.080191155076;3918.0400801803457;5986.73059712314;5988.101784732282;5988.203538938301;5990.011648078062;6003.7898673546215;4019.0756126090578;4022.8591999279884;4023.7786921719585;4044.6359827615656;4047.777372244555;3838.9040273993373;4011.478507793968;4018.517777866675;4019.83920643171;4096.09885825118;4666.580007799314;4678.8128474861305;4682.2508398656055;4688.835890743808;4693.859184224479;5703.8859222816145;5726.112452569859;5740.368559458456;5749.971250143806;5750.453706897838;1329.335332333833;1385.1204485152;1412.8022076909242;1413.321605629283;1414.0313884988816;880.5289170293862;915.075773468788;930.232558139524;945.2060269373621;945.3477100800426;4816.446108697474;4848.684835485682;4867.148249056401;4924.3352147460355;4955.281484184773;5869.20765696634;5878.676672782953;5880.441358070976;5884.08796636522;5904.616199947076;4895.681780684244;4918.483559226302;4921.8523444296725;4951.282064100757;4956.083124621957;3079.9846000769853;3128.264857758425;3182.3158021025592;3188.4739018062223;3203.599550056243;5596.496315331558;5607.971960140173;5673.063944449203;5681.034224181899;5701.486866181981;6157.538184636171;6172.969135154295;6178.907316390258;6184.598001130003;6194.535409844189;5445.210444485607;5583.497485226349;5624.100143976944;5652.802151924663;5687.40282270364;5949.91075133882;5952.404759524013;5999.970000149971;6001.309849367379;6006.309274433322;5836.9416305838095;5843.2695913010875;5849.64902105875;5888.3228428731245;5897.616654917417;5563.109902415594;5628.127640215773;5641.12562552805;5665.461781130786;5682.204491371294;3971.384435412516;4059.5534491206536;4093.3655283431117;4094.0788322627172;4095.6723462123555;5922.674252916131;5925.674087925033;5932.970335148297;5934.732937017759;5938.257717785277;5641.238432811518;5673.489385955284;5680.460356266148;5680.630759000652;5693.9430605693415;5514.228008078792;5670.489655930821;5689.260396148474;5692.6299790513485;5708.315002199763;5519.641223320471;5571.66570005801;5571.9442805571425;5574.777008919597;5584.553235741049;5513.2005859151;5655.717214139194;5676.886462270814;5693.231413759089;5804.448577385142;5600.971995139998;5618.550515958796;5623.465770751772;5623.634463759842;5632.464915832989 15:56:01 INFO - 2015-12-05 15:56:00,999 DEBUG : BROWSER_OUTPUT: |5;yui.html;681.8159097043798;704.246456291768;789.8736202207648;794.9205079492048;826.5412695953751;11202.047825934795;11286.943565282183;11327.207095503318;11357.545698172084;11390.487428065737;11090.390028548427;11169.72075698108;11178.2734122282;11220.943895280512;11260.774784504305;633.2907143998705;637.9968100159492;795.5743677132749;801.1507801730185;814.2183503836295;800.5516910530122;801.3188789528883;805.569020573993;810.6797814863125;811.8985126859143;823.567626995829;834.4909605140859;839.9034111077212;841.1840514700731;844.3118858130634;825.2984962781647;832.0888626953506;832.5337810825927;833.5082301442178;834.7078522517131;620.221621864557;624.1854380034054;624.9687515624246;628.3841835001679;628.3936001758279;11333.886661133365;11361.488733007034;11362.71593210168;11380.829287560693;11429.714257143554;11024.50389732464;11285.210035297532;11301.49143288554;11485.425728713615;11652.766944661143;9351.532423378803;9479.905200947971;9481.525923703855;9531.142197202216;9588.424694518351;3332.4334863073336;3347.8828241011693;3350.1122202616325;3372.0726800129914;3381.7970921744773;41426;41556.376654350206;41908.37137442941;41959.58040419587;41987.160256794996;8517.233448989497;8670.393072484865;8674.6530138795;8717.259032982267;8745.212930836255;14181.14913105217;14260.429582816778;14278.785818212735;14295.07082039664;14402.711945761026;6188.1027251048345;6328;6345.460635845912;6428.582142160744;6560.606363618198;3480.704140148065;3555.1467647764352;3583.4803953427127;3592.7305452090677;3593.407087830531;2602.2713640180777;2611.7779988700795;2612.1771641932733;2637;2640.6699162604673;474.4472689316907;477.60597507056815;477.79216041022266;481.07633343978944;485.7886819233645;457.93588897554366;497.0704782057575;592.7332700284803;594.1592646405288;596.9283685957625;7381.446391520657;7404.835020910669;7438.5908775016815;7737.342325902361;7851.214878512217;469.96710230283554;545.312905738772;589.666838236395;634.4068296143121;636.296891934415;3554.2713743682484;3750.737448378642;3782;3839.424086387064;3849.826757795906;51910.480895190565;52537.7373113132;52567.21149182766;52594;53041.469585304425;46389.76805115953;47091.76454117776;47766;47859.76070119627;47882.76058619685;42106.1578768429;42236.99999999939;42276.36585451221;42802.35796463056;42907;7589.772306830804;7940;8100.189981001853;8320.292775114183;8388.370872184732;31492.685073149893;32267.51598726068;32395.838020810686;32773.34453310968;32787.672123279415;40940;40953.38569921394;41063.38404923988;41063.589364105974;41522.79238603909;10255.94872025635;10276.537555810157;10523.94738026305;10616.628418005641;10628.8937110631;11082.22424430282;11188.888111118784;11498.712532186762;11534.538618455503;11547.711307217387;10440.58237670515;10480;10498.265121441425;10563.630272940718;10651.57393704243;10496.842547361948;10660.786784264115;10740.570377184826;10919.399433030942;11005.17461190398;10410.1671866249;10522.579096836042;10609.840852387375;10640.574377024832;11042.944785276022;9157.587908543997;9430.151286384258;9517.428954262767;9658.179054780423;9715.951420242853;8436.578171091298;8869.379143459895;8906.376553641183;8983.505907174907;9023.774405639911 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,334 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: __startTimestamp1449359760983__endTimestamp 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,000 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4596.05 Median:4762.50 stddev:467.22 (9.8%) stddev-sans-first:443.52 15:56:01 INFO - 2015-12-05 15:56:01,001 DEBUG : BROWSER_OUTPUT: Values: 2668.8 2697.9 2729.2 2737.3 2745.6 4497.3 4676.9 4677.6 4712.3 4725.4 4632.7 4642.4 4644.4 4749.6 4773.3 4229.8 4254.2 4323.6 4329.1 4354.5 4323.8 4327.3 4346.3 4392.5 4422.1 4126.4 4233.8 4248.3 4350.6 4408.9 4279.2 4305.6 4320.9 4336.7 4345.2 4262.6 4275.6 4291.4 4316.2 4366.0 4403.4 4502.9 4537.7 4619.3 4671.6 4906.0 4927.5 4954.5 4956.7 4977.5 5034.5 5047.2 5050.4 5067.2 5072.2 4487.6 4494.7 4613.6 4617.3 4619.6 5020.5 5031.1 5040.0 5061.4 5079.4 4840.9 4844.1 4846.5 4872.4 4890.4 4753.9 4852.9 4866.2 4922.8 4993.4 4957.7 4980.6 4982.7 4987.0 5036.2 4762.5 4954.9 4968.5 4969.2 5000.7 4080.3 4083.9 4159.2 4162.4 4207.2 3653.2 3663.0 3667.2 3669.2 3688.3 4161.3 4251.2 4353.7 4358.3 4387.0 4911.6 4973.9 4977.0 4977.7 5021.5 4301.1 4321.8 4322.0 4363.8 4386.1 4246.3 4355.0 4358.6 4411.2 4425.4 4776.9 4780.3 4800.4 4802.6 4860.0 5032.0 5032.2 5036.7 5038.6 5047.8 4462.3 4548.4 4669.2 4748.9 4806.5 4836.6 4865.8 4882.3 4889.7 4901.0 4944.2 4949.1 4963.8 4974.3 4984.7 4752.3 4825.0 4880.8 4881.0 4924.2 4839.9 4863.1 4878.7 4896.8 4919.2 4623.1 4752.9 4774.1 4785.1 4785.3 4833.1 4841.2 4868.9 4876.0 4891.2 4776.0 4785.3 4788.4 4791.9 4822.7 15:56:01 INFO - 2015-12-05 15:56:01,001 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,002 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43760.56 Median:3536.50 stddev:71337.92 (2017.2%) stddev-sans-first:71464.29 15:56:01 INFO - 2015-12-05 15:56:01,002 DEBUG : BROWSER_OUTPUT: Values: 557.9 562.6 574.7 579.8 620.2 37623.8 38191.2 38496.4 38506.0 38580.6 39116.8 39374.8 39579.2 39594.4 39672.0 7812.6 7860.0 7947.5 7951.3 7961.3 7758.2 7816.6 7822.8 7832.4 7833.3 7744.5 7820.9 7910.2 7921.9 7926.7 7866.6 7993.6 8004.8 8020.4 8034.0 7777.2 7905.3 7922.9 7955.4 7976.4 36327.5 36405.6 36633.6 36700.8 36737.4 2696.5 2759.2 2860.4 3126.9 3162.9 27455.0 27607.0 27643.3 28123.4 28303.7 3421.9 3491.1 3536.0 3537.0 3580.7 226187.0 226814.0 227638.0 229146.0 230063.0 47531.8 48396.0 56313.7 56643.7 56828.1 67589.7 68080.7 68267.0 68744.0 68843.0 13679.4 13838.4 13876.4 13876.9 13955.6 11129.4 11162.4 11187.2 11196.4 11196.8 19171.3 19280.1 19427.0 19481.3 19569.9 7653.5 7901.0 7957.0 7970.7 8124.3 866.8 890.7 913.9 922.9 1005.1 25747.9 26022.9 26477.6 26623.2 27218.6 948.0 958.7 987.2 993.7 1060.4 13586.3 13628.4 15766.9 16067.4 16500.0 320673.0 324037.0 324777.0 325599.0 327409.0 48239.8 48465.5 48862.5 48894.8 49101.5 1236.4 1252.9 1263.7 1270.0 1270.0 27640.0 27720.9 27826.3 28040.9 28450.9 39733.4 40360.4 40401.6 40437.2 40494.4 253216.0 256409.0 256685.0 257326.0 258369.0 29526.1 41646.4 42745.1 42866.6 43251.4 41625.0 42835.8 43789.6 46329.8 46723.5 33565.0 33599.7 34161.0 34387.8 34687.5 33972.0 34361.7 34406.8 34419.5 34757.1 33670.5 34346.3 34553.8 34555.7 34693.7 29022.4 31101.7 31163.7 31210.8 31336.2 24445.8 24536.3 24659.5 24723.3 24735.4 15:56:01 INFO - 2015-12-05 15:56:01,002 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,002 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27054.04 Median:2137.21 stddev:79356.89 (3713.1%) stddev-sans-first:79554.14 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: Values: 331.2 332.5 332.7 334.4 338.7 10295.2 10343.9 10720.9 15092.2 15547.1 16266.1 16332.0 16500.0 16678.0 16723.2 5342.9 5694.3 5697.4 5697.5 5703.7 5634.3 5654.6 5655.6 5657.3 5675.4 3896.8 4022.9 6167.8 6375.8 6380.6 6706.0 6735.8 6750.0 6757.5 6767.9 5867.2 6070.1 6070.2 6080.8 6081.8 19397.1 19464.2 19865.2 19891.1 20072.0 1750.0 1830.6 1831.9 1889.6 1943.3 13440.8 13929.1 14031.3 14354.1 14537.2 1790.2 1813.0 1819.5 1825.3 1870.7 58810.4 63228.1 63255.7 63373.4 64352.4 15848.6 15864.5 15886.3 15936.7 16053.9 23109.0 23116.8 23300.8 23315.5 23430.4 8651.5 8857.7 8916.8 8964.2 8970.3 7392.3 7403.7 7479.9 7497.0 7525.2 7697.2 7768.8 7769.2 7804.2 7824.0 3122.6 3128.7 3145.9 3162.4 3212.2 354.6 358.6 367.6 373.4 377.6 10196.2 10322.8 10428.4 10537.3 10638.1 375.7 390.3 390.8 397.4 408.1 5598.3 5602.6 5682.1 5711.3 5728.5 476150.0 478985.0 479296.0 496842.0 497203.0 70278.0 72101.6 73767.3 74478.6 74496.3 415.6 417.5 418.4 420.8 421.5 9553.0 9761.6 9864.6 9877.9 9954.7 32397.0 32973.3 33388.7 33554.5 33716.0 42426.8 43511.8 43699.6 44573.6 44662.3 8816.7 9008.4 9085.0 9115.9 9135.7 10557.1 13601.4 16057.8 16520.4 16788.7 10937.0 12721.2 13140.7 13589.4 14377.1 12574.9 12578.2 13122.7 13222.1 13242.0 13095.9 13139.3 13499.9 13771.5 13775.1 8621.8 8883.1 8886.5 8892.3 8956.7 13813.3 13955.4 14019.4 14219.8 14324.4 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5037.48 Median:6140.98 stddev:2683.80 (43.7%) stddev-sans-first:2677.92 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: Values: 1468.9 1701.2 1761.9 1779.7 1782.6 6781.1 7183.9 7299.4 7406.1 7577.8 7488.1 7510.1 7576.0 7576.9 7587.2 2117.9 2151.5 2155.6 2156.2 2157.0 2070.5 2126.7 2150.8 2162.1 2172.7 1668.0 1717.8 2047.5 2058.4 2073.3 1869.6 1881.2 1884.6 1888.5 1889.0 2031.9 2046.5 2096.5 2097.3 2109.2 7320.2 7386.7 7445.7 7456.8 7469.7 4338.1 4414.5 4425.7 4428.9 4440.3 2743.4 2760.6 2798.6 2805.8 2808.8 851.7 862.5 863.2 865.3 889.1 9963.6 9998.6 10031.4 10059.7 10105.8 3797.3 3803.7 3867.0 3905.8 3929.1 8081.0 8118.6 8133.3 8141.5 8149.2 4263.0 4294.1 4295.6 4299.0 4299.8 3912.8 3917.0 3931.6 3936.8 3947.5 3138.5 3160.9 3179.5 3201.3 3204.6 893.9 923.0 935.5 937.2 940.0 821.4 865.4 930.1 1197.1 1229.2 6858.8 6878.9 6899.8 6912.9 6914.4 576.1 584.0 584.9 589.4 730.8 5157.1 5264.9 5277.0 5278.2 5307.4 8230.1 8906.1 8921.9 8973.0 8990.5 8744.3 8745.9 8776.7 8881.2 8886.0 6869.7 6956.3 6995.1 7002.4 7007.1 6702.4 6711.9 6719.3 6723.7 6725.2 7666.0 7717.3 7827.8 7962.6 7965.0 7807.7 8060.4 8075.0 8082.8 8170.4 6037.8 6047.2 6084.6 6171.2 6208.2 6958.2 6989.0 7012.0 7020.4 7047.3 6428.3 6757.9 6764.2 6769.7 6863.3 6122.1 6611.9 6670.3 6690.8 6691.2 5286.9 5405.4 6063.7 6159.8 6168.9 5913.0 5942.6 5967.6 5969.9 5974.9 5650.6 5689.5 5830.4 5878.2 5904.1 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4704.74 Median:5426.38 stddev:1417.28 (26.1%) stddev-sans-first:1381.61 15:56:01 INFO - 2015-12-05 15:56:01,003 DEBUG : BROWSER_OUTPUT: Values: 269.9 278.4 278.5 288.0 289.2 5341.6 5424.3 5438.3 5487.8 5514.2 5264.6 5417.0 5417.3 5420.0 5428.5 4089.2 4113.6 4114.5 4120.6 4141.4 4118.4 4137.1 4137.9 4146.6 4151.0 4031.5 4083.6 4103.1 4108.3 4116.2 4080.9 4120.0 4125.0 4126.1 4128.8 3561.9 3565.9 3566.7 3575.9 3585.9 5221.3 5223.9 5224.1 5229.1 5232.3 4752.0 4753.7 4754.8 4759.0 4759.1 5560.8 5646.7 5665.8 5692.3 5695.3 3901.2 3903.0 3907.3 3914.1 3918.0 5986.7 5988.1 5988.2 5990.0 6003.8 4019.1 4022.9 4023.8 4044.6 4047.8 3838.9 4011.5 4018.5 4019.8 4096.1 4666.6 4678.8 4682.3 4688.8 4693.9 5703.9 5726.1 5740.4 5750.0 5750.5 1329.3 1385.1 1412.8 1413.3 1414.0 880.5 915.1 930.2 945.2 945.3 4816.4 4848.7 4867.1 4924.3 4955.3 5869.2 5878.7 5880.4 5884.1 5904.6 4895.7 4918.5 4921.9 4951.3 4956.1 3080.0 3128.3 3182.3 3188.5 3203.6 5596.5 5608.0 5673.1 5681.0 5701.5 6157.5 6173.0 6178.9 6184.6 6194.5 5445.2 5583.5 5624.1 5652.8 5687.4 5949.9 5952.4 6000.0 6001.3 6006.3 5836.9 5843.3 5849.6 5888.3 5897.6 5563.1 5628.1 5641.1 5665.5 5682.2 3971.4 4059.6 4093.4 4094.1 4095.7 5922.7 5925.7 5933.0 5934.7 5938.3 5641.2 5673.5 5680.5 5680.6 5693.9 5514.2 5670.5 5689.3 5692.6 5708.3 5519.6 5571.7 5571.9 5574.8 5584.6 5513.2 5655.7 5676.9 5693.2 5804.4 5601.0 5618.6 5623.5 5623.6 5632.5 15:56:01 INFO - 2015-12-05 15:56:01,004 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,004 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12468.57 Median:23423.85 stddev:14506.91 (61.9%) stddev-sans-first:14520.60 15:56:01 INFO - 2015-12-05 15:56:01,005 DEBUG : BROWSER_OUTPUT: Values: 681.8 704.2 789.9 794.9 826.5 11202.0 11286.9 11327.2 11357.5 11390.5 11090.4 11169.7 11178.3 11220.9 11260.8 633.3 638.0 795.6 801.2 814.2 800.6 801.3 805.6 810.7 811.9 823.6 834.5 839.9 841.2 844.3 825.3 832.1 832.5 833.5 834.7 620.2 624.2 625.0 628.4 628.4 11333.9 11361.5 11362.7 11380.8 11429.7 11024.5 11285.2 11301.5 11485.4 11652.8 9351.5 9479.9 9481.5 9531.1 9588.4 3332.4 3347.9 3350.1 3372.1 3381.8 41426.0 41556.4 41908.4 41959.6 41987.2 8517.2 8670.4 8674.7 8717.3 8745.2 14181.1 14260.4 14278.8 14295.1 14402.7 6188.1 6328.0 6345.5 6428.6 6560.6 3480.7 3555.1 3583.5 3592.7 3593.4 2602.3 2611.8 2612.2 2637.0 2640.7 474.4 477.6 477.8 481.1 485.8 457.9 497.1 592.7 594.2 596.9 7381.4 7404.8 7438.6 7737.3 7851.2 470.0 545.3 589.7 634.4 636.3 3554.3 3750.7 3782.0 3839.4 3849.8 51910.5 52537.7 52567.2 52594.0 53041.5 46389.8 47091.8 47766.0 47859.8 47882.8 42106.2 42237.0 42276.4 42802.4 42907.0 7589.8 7940.0 8100.2 8320.3 8388.4 31492.7 32267.5 32395.8 32773.3 32787.7 40940.0 40953.4 41063.4 41063.6 41522.8 10255.9 10276.5 10523.9 10616.6 10628.9 11082.2 11188.9 11498.7 11534.5 11547.7 10440.6 10480.0 10498.3 10563.6 10651.6 10496.8 10660.8 10740.6 10919.4 11005.2 10410.2 10522.6 10609.8 10640.6 11042.9 9157.6 9430.2 9517.4 9658.2 9716.0 8436.6 8869.4 8906.4 8983.5 9023.8 15:56:01 INFO - 2015-12-05 15:56:01,005 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:56:01 INFO - 2015-12-05 15:56:01,005 DEBUG : BROWSER_OUTPUT: 15:56:01 INFO - 2015-12-05 15:56:01,742 INFO : Browser exited with error code: 0 15:56:01 INFO - 2015-12-05 15:56:01,760 INFO : Completed test dromaeo_css (00:18:34) 15:56:01 INFO - 2015-12-05 15:56:01,760 INFO : Starting test kraken 15:56:01 INFO - 2015-12-05 15:56:01,760 DEBUG : operating with platform_type : linux_ 15:56:01 INFO - 2015-12-05 15:56:01,760 INFO : Initialising browser for kraken test... 15:56:01 INFO - 2015-12-05 15:56:01,767 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL999DV/profile http://localhost:49548/getInfo.html 15:56:06 INFO - 2015-12-05 15:56:06,387 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:56:06 INFO - 2015-12-05 15:56:06,387 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:56:06 INFO - 2015-12-05 15:56:06,387 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:56:06 INFO - 2015-12-05 15:56:06,387 DEBUG : BROWSER_OUTPUT: __metrics 15:56:06 INFO - 2015-12-05 15:56:06,524 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:56:07 INFO - 2015-12-05 15:56:07,429 INFO : Browser initialized. 15:56:07 INFO - 2015-12-05 15:56:07,430 INFO : Running cycle 1/1 for kraken test... 15:56:07 INFO - 2015-12-05 15:56:07,430 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL999DV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:56:19 INFO - 2015-12-05 15:56:19,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 143634432 15:56:19 INFO - 2015-12-05 15:56:19,411 DEBUG : BROWSER_OUTPUT: 15:56:21 INFO - 2015-12-05 15:56:21,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49548/tests/kraken/driver.html?testName=audio-beat-detection) 15:56:22 INFO - 2015-12-05 15:56:22,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 143163392 15:56:22 INFO - 2015-12-05 15:56:22,617 DEBUG : BROWSER_OUTPUT: 15:56:25 INFO - 2015-12-05 15:56:25,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49548/tests/kraken/driver.html?testName=audio-dft) 15:56:25 INFO - 2015-12-05 15:56:25,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 15:56:25 INFO - 2015-12-05 15:56:25,921 DEBUG : BROWSER_OUTPUT: 15:56:28 INFO - 2015-12-05 15:56:28,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49548/tests/kraken/driver.html?testName=audio-fft) 15:56:29 INFO - 2015-12-05 15:56:29,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 138276864 15:56:29 INFO - 2015-12-05 15:56:29,419 DEBUG : BROWSER_OUTPUT: 15:56:31 INFO - 2015-12-05 15:56:31,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49548/tests/kraken/driver.html?testName=audio-oscillator) 15:56:32 INFO - 2015-12-05 15:56:32,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 139722752 15:56:32 INFO - 2015-12-05 15:56:32,153 DEBUG : BROWSER_OUTPUT: 15:56:34 INFO - 2015-12-05 15:56:34,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:56:34 INFO - 2015-12-05 15:56:34,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 139816960 15:56:34 INFO - 2015-12-05 15:56:34,945 DEBUG : BROWSER_OUTPUT: 15:56:38 INFO - 2015-12-05 15:56:38,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49548/tests/kraken/driver.html?testName=imaging-darkroom) 15:56:38 INFO - 2015-12-05 15:56:38,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 141365248 15:56:38 INFO - 2015-12-05 15:56:38,604 DEBUG : BROWSER_OUTPUT: 15:56:42 INFO - 2015-12-05 15:56:42,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49548/tests/kraken/driver.html?testName=imaging-desaturate) 15:56:42 INFO - 2015-12-05 15:56:42,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 139157504 15:56:42 INFO - 2015-12-05 15:56:42,712 DEBUG : BROWSER_OUTPUT: 15:56:45 INFO - 2015-12-05 15:56:45,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49548/tests/kraken/driver.html?testName=json-parse-financial) 15:56:46 INFO - 2015-12-05 15:56:46,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 139689984 15:56:46 INFO - 2015-12-05 15:56:46,198 DEBUG : BROWSER_OUTPUT: 15:56:47 INFO - 2015-12-05 15:56:47,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:56:48 INFO - 2015-12-05 15:56:48,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 140963840 15:56:48 INFO - 2015-12-05 15:56:48,543 DEBUG : BROWSER_OUTPUT: 15:56:50 INFO - 2015-12-05 15:56:50,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:56:51 INFO - 2015-12-05 15:56:51,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 141004800 15:56:51 INFO - 2015-12-05 15:56:51,048 DEBUG : BROWSER_OUTPUT: 15:56:53 INFO - 2015-12-05 15:56:53,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:56:53 INFO - 2015-12-05 15:56:53,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 141025280 15:56:53 INFO - 2015-12-05 15:56:53,795 DEBUG : BROWSER_OUTPUT: 15:56:56 INFO - 2015-12-05 15:56:56,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:56:56 INFO - 2015-12-05 15:56:56,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 141262848 15:56:56 INFO - 2015-12-05 15:56:56,974 DEBUG : BROWSER_OUTPUT: 15:56:59 INFO - 2015-12-05 15:56:59,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:57:00 INFO - 2015-12-05 15:57:00,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 140144640 15:57:00 INFO - 2015-12-05 15:57:00,122 DEBUG : BROWSER_OUTPUT: 15:57:01 INFO - 2015-12-05 15:57:01,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49548/tests/kraken/driver.html?testName=ai-astar) 15:57:02 INFO - 2015-12-05 15:57:02,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 15:57:02 INFO - 2015-12-05 15:57:02,128 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,128 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;113;111;112;122;111;110;114;111 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;132;149;169;129;155;165;131;166;135 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;162;163;165;171;162;164;164 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;74;79;73;74;130;73;72;73;74 15:57:02 INFO - 2015-12-05 15:57:02,129 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;130;94;95;95;134;94;94;126 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;110;111;110;110;110;110;110 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;147;148;147;148;149;147;148;147;147 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;96;96;96;96;95;95;96 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;74;72;74;76;73;72;72;73 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;67;68;67;67;67;68 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;85;86;85;89;83;84;85;86 15:57:02 INFO - 2015-12-05 15:57:02,130 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;128;129;134;131;129;119;127;119;133 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;144;146;146;134;142;143;143;145 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;69;68;72;68;69;70;68;68 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,795 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: __startTimestamp1449359822124__endTimestamp 15:57:02 INFO - 2015-12-05 15:57:02,131 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:3.97 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 113.0 111.0 112.0 122.0 111.0 110.0 114.0 111.0 15:57:02 INFO - 2015-12-05 15:57:02,139 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:15.61 (10.2%) stddev-sans-first:16.50 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: Values: 152.0 132.0 149.0 169.0 129.0 155.0 165.0 131.0 166.0 135.0 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.88 (1.8%) stddev-sans-first:2.99 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 162.0 163.0 165.0 171.0 162.0 164.0 164.0 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:73.50 stddev:17.94 (24.4%) stddev-sans-first:18.77 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 79.0 73.0 74.0 130.0 73.0 72.0 73.0 74.0 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:94.00 stddev:17.29 (18.4%) stddev-sans-first:17.87 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 130.0 94.0 95.0 95.0 134.0 94.0 94.0 126.0 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 15:57:02 INFO - 2015-12-05 15:57:02,140 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:0.73 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: Values: 150.0 147.0 148.0 147.0 148.0 149.0 147.0 148.0 147.0 147.0 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:73.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 72.0 74.0 76.0 73.0 72.0 72.0 73.0 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 68.0 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,141 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:2.11 (2.5%) stddev-sans-first:2.00 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 85.0 86.0 85.0 89.0 83.0 84.0 85.0 86.0 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:129.00 stddev:5.79 (4.5%) stddev-sans-first:5.41 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: Values: 119.0 128.0 129.0 134.0 131.0 129.0 119.0 127.0 119.0 133.0 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.70 Median:144.50 stddev:3.92 (2.7%) stddev-sans-first:3.77 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 144.0 146.0 146.0 134.0 142.0 143.0 143.0 145.0 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.65 (2.4%) stddev-sans-first:1.48 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 69.0 68.0 72.0 68.0 69.0 70.0 68.0 68.0 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:57:02 INFO - 2015-12-05 15:57:02,142 DEBUG : BROWSER_OUTPUT: 15:57:02 INFO - 2015-12-05 15:57:02,997 INFO : Browser exited with error code: 0 15:57:03 INFO - 2015-12-05 15:57:03,051 INFO : Completed test kraken (00:01:01) 15:57:03 INFO - 2015-12-05 15:57:03,051 INFO : Starting test v8_7 15:57:03 INFO - 2015-12-05 15:57:03,051 DEBUG : operating with platform_type : linux_ 15:57:03 INFO - 2015-12-05 15:57:03,051 INFO : Initialising browser for v8_7 test... 15:57:03 INFO - 2015-12-05 15:57:03,058 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSJSvpx/profile http://localhost:49548/getInfo.html 15:57:07 INFO - 2015-12-05 15:57:07,508 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:57:07 INFO - 2015-12-05 15:57:07,508 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:57:07 INFO - 2015-12-05 15:57:07,508 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:57:07 INFO - 2015-12-05 15:57:07,508 DEBUG : BROWSER_OUTPUT: __metrics 15:57:07 INFO - 2015-12-05 15:57:07,625 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:57:08 INFO - 2015-12-05 15:57:08,529 INFO : Browser initialized. 15:57:08 INFO - 2015-12-05 15:57:08,530 INFO : Running cycle 1/1 for v8_7 test... 15:57:08 INFO - 2015-12-05 15:57:08,530 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSJSvpx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:57:20 INFO - 2015-12-05 15:57:20,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 142635008 15:57:20 INFO - 2015-12-05 15:57:20,573 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49548/tests/v8_7/run.html (next: http://localhost:49548/tests/v8_7/run.html) 15:57:42 INFO - 2015-12-05 15:57:42,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 138006528 15:57:42 INFO - 2015-12-05 15:57:42,316 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7550140891762 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.5199119104423 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 15:57:42 INFO - 2015-12-05 15:57:42,317 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |5;Earley;708.7172218284904 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |7;RegExp;26230.76923076923 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |8;Splay;597.3715651135007 15:57:42 INFO - 2015-12-05 15:57:42,318 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:57:42 INFO - 2015-12-05 15:57:42,319 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:57:42 INFO - 2015-12-05 15:57:42,319 DEBUG : BROWSER_OUTPUT: __startTimestamp1449359862315__endTimestamp 15:57:42 INFO - 2015-12-05 15:57:42,319 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,319 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:57:42 INFO - 2015-12-05 15:57:42,320 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:57:42 INFO - 2015-12-05 15:57:42,321 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,321 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,321 DEBUG : BROWSER_OUTPUT: Values: 165.8 15:57:42 INFO - 2015-12-05 15:57:42,321 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.52 Median:183.52 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: Values: 183.5 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: Values: 279.6 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,322 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: Values: 5191.7 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: Values: 1060.4 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.72 Median:708.72 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: Values: 708.7 15:57:42 INFO - 2015-12-05 15:57:42,323 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: Values: 12292.7 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: Values: 26230.8 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,324 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.37 Median:597.37 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: Values: 597.4 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:57:42 INFO - 2015-12-05 15:57:42,325 DEBUG : BROWSER_OUTPUT: 15:57:43 INFO - 2015-12-05 15:57:43,197 INFO : Browser exited with error code: 0 15:57:43 INFO - 2015-12-05 15:57:43,214 INFO : Completed test v8_7 (00:00:40) 15:57:43 INFO - 2015-12-05 15:57:43,261 INFO : Completed test suite (00:20:16) 15:57:43 INFO - 2015-12-05 15:57:43,261 DEBUG : Working with test: dromaeo_css 15:57:43 INFO - 2015-12-05 15:57:43,261 DEBUG : Generating results file: dromaeo_css 15:57:43 INFO - 2015-12-05 15:57:43,262 DEBUG : Working with test: kraken 15:57:43 INFO - 2015-12-05 15:57:43,262 DEBUG : Generating results file: kraken 15:57:43 INFO - 2015-12-05 15:57:43,262 INFO : javascript benchmark 15:57:43 INFO - 2015-12-05 15:57:43,263 DEBUG : Working with test: v8_7 15:57:43 INFO - 2015-12-05 15:57:43,263 DEBUG : Generating results file: v8_7 15:57:43 INFO - 2015-12-05 15:57:43,263 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:57:43 INFO - 2015-12-05 15:57:43,319 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 15:57:43 INFO - 2015-12-05 15:57:43,319 DEBUG : process_Request line: dromaeo_css 6344.24 graph.html#tests=[[72,94,43]] 15:57:43 INFO - 2015-12-05 15:57:43,319 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:57:43 INFO - 2015-12-05 15:57:43,360 DEBUG : process_Request line: kraken 1527.10 graph.html#tests=[[232,94,43]] 15:57:43 INFO - 2015-12-05 15:57:43,361 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:57:43 INFO - 2015-12-05 15:57:43,389 DEBUG : process_Request line: v8_7 21406.45 graph.html#tests=[[230,94,43]] 15:57:43 INFO - 2015-12-05 15:57:43,391 INFO : javascript benchmark 15:57:43 INFO - 2015-12-05 15:57:43,394 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2668.773154281886, 2697.9190624281277, 2729.194887508185, 2737.3293543081936, 2745.6018877262804, 4497.280435130379, 4676.929846052308, 4677.649176311773, 4712.340272361864, 4725.432948046235, 4632.652551058667, 4642.419697537808, 4644.442666879979, 4749.596284315838, 4773.260144677572, 4229.830806767741, 4254.212970600441, 4323.610875021247, 4329.112531930962, 4354.499232588261, 4323.848665296715, 4327.307630779076, 4346.282863327548, 4392.516823149451, 4422.071365013351, 4126.42230087788, 4233.7883105844585, 4248.34150706641, 4350.608445239912, 4408.933865992013, 4279.165562715271, 4305.5694430557005, 4320.870373888757, 4336.696431249814, 4345.217860785057, 4262.616364527207, 4275.615194632467, 4291.399204111427, 4316.201502721975, 4366.0, 4403.361512580658, 4502.864914052584, 4537.705049171794, 4619.330197121399, 4671.6262698984, 4906.0, 4927.531884470969, 4954.5293197146575, 4956.702597844141, 4977.527134922177, 5034.496550344937, 5047.242913562958, 5050.444451110375, 5067.239914012891, 5072.163093089635, 4487.551244875552, 4494.662900282492, 4613.561711637456, 4617.3074038893765, 4619.584237418649, 5020.49795020495, 5031.094403007493, 5039.974800125976, 5061.4179369373, 5079.4412614612365, 4840.927386089212, 4844.128056949783, 4846.466888642247, 4872.3909511311085, 4890.388701412324, 4753.857384278408, 4852.8544143675745, 4866.197077482176, 4922.75386230687, 4993.425756038029, 4957.677750946177, 4980.626453016038, 4982.725950072709, 4986.975065124651, 5036.244563315458, 4762.499937506581, 4954.925676114861, 4968.503149685002, 4969.155243608595, 5000.699958002531, 4080.2859499587453, 4083.8570650027104, 4159.209750147463, 4162.354835000579, 4207.200631879994, 3653.232821107544, 3663.0292972362345, 3667.211549516867, 3669.156094098319, 3688.2623475305045, 4161.292580261363, 4251.192273468031, 4353.651707863363, 4358.280883654162, 4386.978065109654, 4911.582515486152, 4973.90052198954, 4977.0, 4977.726225057584, 5021.5229553192385, 4301.09676967834, 4321.805518751664, 4322.0491491871735, 4363.847265345697, 4386.144701783185, 4246.341817018367, 4355.020120472868, 4358.585934336233, 4411.1618792429335, 4425.35832304314, 4776.904461910812, 4780.330753694555, 4800.447948485829, 4802.639802014933, 4860.0, 5032.04391165692, 5032.220005899091, 5036.697798132123, 5038.596912247085, 5047.823326183566, 4462.330650402466, 4548.408706868086, 4669.229577119737, 4748.881277968078, 4806.49531799156, 4836.637252206028, 4865.80536778539, 4882.292067650242, 4889.657723959289, 4901.044296362318, 4944.208926571731, 4949.109160351171, 4963.801447942042, 4974.253861920741, 4984.675996060245, 4752.310914917249, 4824.951750482591, 4880.78036488366, 4880.99939512392, 4924.212126059813, 4839.854804355875, 4863.124637565272, 4878.682885612424, 4896.828610998598, 4919.237518184687, 4623.12160689468, 4752.881177970578, 4774.092922344744, 4785.138675038526, 4785.306130610972, 4833.10587541306, 4841.225403935354, 4868.926966095441, 4876.00041991398, 4891.241857512091, 4776.020915712201, 4785.258284965836, 4788.4253889533475, 4791.856244312677, 4822.68652537584], "unit": "ms", "name": "dojo.html", "value": 4567.925165867869}, {"lowerIsBetter": false, "replicates": [557.8661121330882, 562.5949316492125, 574.7068994812645, 579.8405438504411, 620.2340109964197, 37623.81188094059, 38191.236175276514, 38496.42255366168, 38506.0, 38580.614193858055, 39116.80441597788, 39374.80312598433, 39579.208415831665, 39594.40608390876, 39672.0, 7812.570308633023, 7860.0, 7947.483413578099, 7951.324137448324, 7961.323287520568, 7758.224177582225, 7816.570088645122, 7822.804429889241, 7832.412569057315, 7833.295003449688, 7744.496607720508, 7820.921790782105, 7910.208979102102, 7921.881171782399, 7926.722564710236, 7866.567338796364, 7993.640286187136, 8004.799880002988, 8020.398470114736, 8034.0, 7777.2222777722345, 7905.288524032865, 7922.881156782653, 7955.4033447491665, 7976.401769867283, 36327.4550881737, 36405.63594364075, 36633.63366366329, 36700.816495917614, 36737.448938265945, 2696.514627367073, 2759.2412086676322, 2860.442213768316, 3126.9212121817936, 3162.8734850605947, 27455.039073632328, 27607.0, 27643.308917277027, 28123.43753124926, 28303.71696283052, 3421.897343079687, 3491.14466955595, 3536.0099172231817, 3536.982315088408, 3580.7314451416246, 226187.0, 226814.0, 227638.0, 229146.0, 230063.0, 47531.76234118876, 48396.0, 56313.71843140758, 56643.71678141665, 56828.14757778637, 67589.66205169041, 68080.6595967017, 68267.0, 68744.0, 68843.0, 13679.384427700777, 13838.4464621414, 13876.375563099482, 13876.930615346859, 13955.58133256004, 11129.443527823576, 11162.441877906072, 11187.160962927814, 11196.38419886914, 11196.832047519294, 19171.32900348481, 19280.132394042303, 19427.0, 19481.318153864548, 19569.902150489157, 7653.5407875526535, 7900.972873526404, 7957.010747313172, 7970.721024764105, 8124.309433698084, 866.7746385939575, 890.6838072484304, 913.949732764691, 922.916937475617, 1005.1197668597873, 25747.871260643577, 26022.86988565045, 26477.602835957478, 26623.201303960912, 27218.591721124198, 947.9715608531756, 958.6548842416724, 987.1855719031828, 993.6869885985891, 1060.3637817309707, 13586.252756098313, 13628.386722597506, 15766.9211653941, 16067.357305707874, 16500.0, 320673.0, 324037.0, 324777.0, 325599.0, 327409.0, 48239.75880120577, 48465.515344846805, 48862.511374886504, 48894.75552622214, 49101.50898491041, 1236.3509157692283, 1252.8747125287398, 1263.7156639756165, 1269.955551555691, 1270.0474644016801, 27640.0, 27720.866208492545, 27826.304342391602, 28040.85979570089, 28450.85774571114, 39733.403998940616, 40360.3945940817, 40401.595984039785, 40437.1912561753, 40494.392584111854, 253216.0, 256409.0, 256685.0, 257326.0, 258369.0, 29526.114216573536, 41646.37530437107, 42745.1450970985, 42866.57133428626, 43251.35122973221, 41625.0, 42835.7858210707, 43789.56210437855, 46329.768351158025, 46723.53276467328, 33565.0, 33599.664003359656, 34161.0, 34387.82806085954, 34687.479687804196, 33972.0, 34361.65638343684, 34406.795762148206, 34419.483707744905, 34757.13107172341, 33670.49494257539, 34346.313073738886, 34553.82723086469, 34555.65444345524, 34693.653063470054, 29022.419551608426, 31101.688983110784, 31163.688363116984, 31210.843945780125, 31336.21659458532, 24445.75554244435, 24536.263912082664, 24659.506809864062, 24723.25830225096, 24735.38161545976], "unit": "ms", "name": "ext.html", "value": 17550.96429542254}, {"lowerIsBetter": false, "replicates": [331.2414570633251, 332.4514550990865, 332.6523782647134, 334.3680443960914, 338.6765638814932, 10295.176385889139, 10343.948280258588, 10720.946395268013, 15092.24538773061, 15547.14490703011, 16266.105364204965, 16332.0, 16500.0, 16678.0, 16723.247453864577, 5342.946570534304, 5694.259746232984, 5697.401772813857, 5697.515711164556, 5703.686297253649, 5634.32388113427, 5654.632448890829, 5655.632383895054, 5657.2928383952, 5675.404082571333, 3896.7856767877756, 4022.8994275143064, 6167.7841275555365, 6375.8406039848915, 6380.585261957958, 6705.966470167618, 6735.764248251312, 6750.0, 6757.526973111909, 6767.864642707143, 5867.207926929853, 6070.119832624289, 6070.21087258658, 6080.756769729205, 6081.756729730805, 19397.127129279215, 19464.221431142738, 19865.20539178431, 19891.104900279523, 20072.0, 1749.9562510937328, 1830.588117673526, 1831.8992455414948, 1889.5842914558775, 1943.3004118517322, 13440.798388024188, 13929.094608850493, 14031.298435078308, 14354.138751674933, 14537.200453975027, 1790.1586254460383, 1812.9842399085956, 1819.5269230000295, 1825.2881376263135, 1870.700687889931, 58810.41189588092, 63228.051579226805, 63255.68372158156, 63373.36626633721, 64352.3564764351, 15848.603784905239, 15864.52406427809, 15886.285117169755, 15936.681266374608, 16053.876228664116, 23109.0, 23116.76883231146, 23300.7669923302, 23315.53368932612, 23430.4226535081, 8651.52416617092, 8857.689980850639, 8916.751654768337, 8964.193222609996, 8970.282377409792, 7392.334689877936, 7403.66683499233, 7479.850402992019, 7497.0, 7525.172231054579, 7697.230276972258, 7768.7669369918995, 7769.223077692185, 7804.180561041009, 7824.0, 3122.5784519090084, 3128.655847856734, 3145.937081258362, 3162.3517178978254, 3212.1969507623094, 354.6081579854224, 358.57867006268054, 367.6470588235324, 373.3932359915138, 377.63558166369035, 10196.235282353853, 10322.845157322647, 10428.426436546062, 10537.262391632512, 10638.095761860173, 375.68442508292617, 390.2651623958744, 390.84756944791553, 397.43762575955276, 408.1286453421906, 5598.3282006159525, 5602.579806514527, 5682.090865461506, 5711.286089238845, 5728.541716662657, 476150.0, 478985.0, 479296.0, 496842.0, 497203.0, 70278.0, 72101.63949180221, 73767.26232737712, 74478.6276068627, 74496.25503745001, 415.59064321643154, 417.53236375259905, 418.35782074515475, 420.8169446290812, 421.5278887645856, 9553.0, 9761.60953561878, 9864.605415783288, 9877.901220987698, 9954.701358959242, 32397.0, 32973.34053318872, 33388.666113339525, 33554.496682549296, 33716.0, 42426.78786606047, 43511.78244108886, 43699.56300436955, 44573.55426445694, 44662.3300650484, 8816.735497934817, 9008.369414141209, 9084.954575227082, 9115.863262051207, 9135.725928221898, 10557.102646275152, 13601.387937542637, 16057.839421605635, 16520.42178523746, 16788.664226715642, 10937.0, 12721.173123746927, 13140.671483212996, 13589.388477518338, 14377.065490743487, 12574.874251257736, 12578.245305281713, 13122.671933201364, 13222.140560863512, 13242.0, 13095.869041309847, 13139.277339746406, 13499.86500134986, 13771.517996870061, 13775.104618199784, 8621.784455388666, 8883.067277935723, 8886.4668119913, 8892.288616910502, 8956.68651597191, 13813.309334533033, 13955.441782328593, 14019.439222430989, 14219.786703199254, 14324.427022918966], "unit": "ms", "name": "jquery.html", "value": 8282.497362657337}, {"lowerIsBetter": false, "replicates": [1468.8531146885307, 1701.1834319526627, 1761.867859910507, 1779.7063484525054, 1782.6167374014585, 6781.118454600901, 7183.928160718391, 7299.416046716263, 7406.07424071991, 7577.77266681999, 7488.101427828655, 7510.136334321554, 7576.0, 7576.924230757691, 7587.203343648906, 2117.851750377474, 2151.515908920496, 2155.6012137754487, 2156.2345367394582, 2156.956860862782, 2070.534129820793, 2126.6916297136904, 2150.7526634437086, 2162.081115525903, 2172.6849606807004, 1667.9749803752954, 1717.7509261157124, 2047.5495391013953, 2058.4133521946246, 2073.2743539761036, 1869.569998900247, 1881.1628825172804, 1884.5948121154017, 1888.4523488188477, 1889.0460317539691, 2031.9492012699652, 2046.5088378789133, 2096.4968407582223, 2097.2974053692033, 2109.1985045682695, 7320.158181809107, 7386.704531818721, 7445.739399121005, 7456.813579660497, 7469.738559150458, 4338.067315527145, 4414.53647367025, 4425.712328698624, 4428.911421771579, 4440.2895536714295, 2743.43759529296, 2760.5997130415976, 2798.6221860048836, 2805.803593748418, 2808.817426867247, 851.676362982069, 862.5471627395605, 863.197226579281, 865.346663269234, 889.0531583863229, 9963.551640176138, 9998.550065247082, 10031.398116113056, 10059.748506287255, 10105.848412273821, 3797.3354662933875, 3803.67668748154, 3866.9613303867163, 3905.824237909301, 3929.115948911472, 8081.030276366756, 8118.553479558563, 8133.349332053422, 8141.470804397695, 8149.225823546753, 4262.978685106555, 4294.119705460374, 4295.613394794484, 4299.0, 4299.78501074945, 3912.7847968361443, 3916.980415097906, 3931.567527571965, 3936.7637941723588, 3947.467091942551, 3138.466460701686, 3160.920976975594, 3179.4594918863386, 3201.279712064767, 3204.647488776233, 893.8525143351275, 923.0354279777514, 935.504182783126, 937.1986951156799, 940.0411580188306, 821.4003777242527, 865.4288169807896, 930.065284389198, 1197.0662882951312, 1229.2255878796302, 6858.794236172823, 6878.8624227515165, 6899.75850845218, 6912.861742765116, 6914.446844252448, 576.1012820000813, 584.0363400389391, 584.9005669036274, 589.4370875813588, 730.819726142287, 5157.097507936096, 5264.947350526446, 5276.997370499669, 5278.181881808326, 5307.389650190277, 8230.053543842416, 8906.06486318927, 8921.866172007425, 8972.968108667455, 8990.505522196341, 8744.256738177199, 8745.912540874637, 8776.692815751418, 8881.156290152425, 8886.0, 6869.725210991604, 6956.339147780953, 6995.055667484824, 7002.439804815603, 7007.089078419875, 6702.430293425114, 6711.899321510084, 6719.328067193242, 6723.697433615401, 6725.226598941184, 7665.961670191613, 7717.2668596483245, 7827.84344313122, 7962.562059086806, 7964.960175199087, 7807.726729564665, 8060.435769496079, 8075.0, 8082.838343232985, 8170.387220958333, 6037.849053773691, 6047.183630209865, 6084.6349219047, 6171.166892469639, 6208.161898143693, 6958.165020197609, 6988.965055174692, 7012.0, 7020.403265722471, 7047.295270472911, 6428.260750013808, 6757.898631520629, 6764.154480689914, 6769.695363708546, 6863.313668633096, 6122.142899993915, 6611.933880661132, 6670.299618539983, 6690.83272918181, 6691.1636045494315, 5286.920696189483, 5405.432429594836, 6063.666498342457, 6159.81520554384, 6168.8766224674355, 5912.970435147797, 5942.58401911862, 5967.582269241111, 5969.850753731192, 5974.940250597612, 5650.57620678459, 5689.459501347365, 5830.4461076197695, 5878.2358293421585, 5904.0553511437965], "unit": "ms", "name": "mootools.html", "value": 4053.4493420468034}, {"lowerIsBetter": false, "replicates": [269.8515816301034, 278.39310303538286, 278.5126029448465, 288.0307764372886, 289.2104554566035, 5341.626086173959, 5424.267723857278, 5438.320209973754, 5487.835364939053, 5514.172874068891, 5264.6051546134, 5416.972915135429, 5417.349918009834, 5420.024395608789, 5428.4842939920645, 4089.182163567291, 4113.588641135892, 4114.526829414625, 4120.58794120587, 4141.4409054777525, 4118.38224266361, 4137.069159439132, 4137.896552586194, 4146.60607242313, 4151.0, 4031.4557534732876, 4083.5508094109623, 4103.076807718269, 4108.322126849066, 4116.156187981472, 4080.9387859182134, 4119.958800412018, 4124.9587504124875, 4126.09225970286, 4128.814203360856, 3561.94657080144, 3565.858925143955, 3566.732495062881, 3575.94636080459, 3585.9421470666216, 5221.321228240305, 5223.947760522384, 5224.138017227153, 5229.111051121318, 5232.2674825524455, 4751.976240118812, 4753.738544380058, 4754.809807607691, 4759.0, 4759.071980963713, 5560.81064523242, 5646.6894320812335, 5665.753534222465, 5692.288463942007, 5695.288088988877, 3901.161250331164, 3903.0, 3907.33575292201, 3914.080191155076, 3918.0400801803457, 5986.73059712314, 5988.101784732282, 5988.203538938301, 5990.011648078062, 6003.7898673546215, 4019.0756126090578, 4022.8591999279884, 4023.7786921719585, 4044.6359827615656, 4047.777372244555, 3838.9040273993373, 4011.478507793968, 4018.517777866675, 4019.83920643171, 4096.09885825118, 4666.580007799314, 4678.8128474861305, 4682.2508398656055, 4688.835890743808, 4693.859184224479, 5703.8859222816145, 5726.112452569859, 5740.368559458456, 5749.971250143806, 5750.453706897838, 1329.335332333833, 1385.1204485152, 1412.8022076909242, 1413.321605629283, 1414.0313884988816, 880.5289170293862, 915.075773468788, 930.232558139524, 945.2060269373621, 945.3477100800426, 4816.446108697474, 4848.684835485682, 4867.148249056401, 4924.3352147460355, 4955.281484184773, 5869.20765696634, 5878.676672782953, 5880.441358070976, 5884.08796636522, 5904.616199947076, 4895.681780684244, 4918.483559226302, 4921.8523444296725, 4951.282064100757, 4956.083124621957, 3079.9846000769853, 3128.264857758425, 3182.3158021025592, 3188.4739018062223, 3203.599550056243, 5596.496315331558, 5607.971960140173, 5673.063944449203, 5681.034224181899, 5701.486866181981, 6157.538184636171, 6172.969135154295, 6178.907316390258, 6184.598001130003, 6194.535409844189, 5445.210444485607, 5583.497485226349, 5624.100143976944, 5652.802151924663, 5687.40282270364, 5949.91075133882, 5952.404759524013, 5999.970000149971, 6001.309849367379, 6006.309274433322, 5836.9416305838095, 5843.2695913010875, 5849.64902105875, 5888.3228428731245, 5897.616654917417, 5563.109902415594, 5628.127640215773, 5641.12562552805, 5665.461781130786, 5682.204491371294, 3971.384435412516, 4059.5534491206536, 4093.3655283431117, 4094.0788322627172, 4095.6723462123555, 5922.674252916131, 5925.674087925033, 5932.970335148297, 5934.732937017759, 5938.257717785277, 5641.238432811518, 5673.489385955284, 5680.460356266148, 5680.630759000652, 5693.9430605693415, 5514.228008078792, 5670.489655930821, 5689.260396148474, 5692.6299790513485, 5708.315002199763, 5519.641223320471, 5571.66570005801, 5571.9442805571425, 5574.777008919597, 5584.553235741049, 5513.2005859151, 5655.717214139194, 5676.886462270814, 5693.231413759089, 5804.448577385142, 5600.971995139998, 5618.550515958796, 5623.465770751772, 5623.634463759842, 5632.464915832989], "unit": "ms", "name": "prototype.html", "value": 4234.109845610722}, {"lowerIsBetter": false, "replicates": [681.8159097043798, 704.246456291768, 789.8736202207648, 794.9205079492048, 826.5412695953751, 11202.047825934795, 11286.943565282183, 11327.207095503318, 11357.545698172084, 11390.487428065737, 11090.390028548427, 11169.72075698108, 11178.2734122282, 11220.943895280512, 11260.774784504305, 633.2907143998705, 637.9968100159492, 795.5743677132749, 801.1507801730185, 814.2183503836295, 800.5516910530122, 801.3188789528883, 805.569020573993, 810.6797814863125, 811.8985126859143, 823.567626995829, 834.4909605140859, 839.9034111077212, 841.1840514700731, 844.3118858130634, 825.2984962781647, 832.0888626953506, 832.5337810825927, 833.5082301442178, 834.7078522517131, 620.221621864557, 624.1854380034054, 624.9687515624246, 628.3841835001679, 628.3936001758279, 11333.886661133365, 11361.488733007034, 11362.71593210168, 11380.829287560693, 11429.714257143554, 11024.50389732464, 11285.210035297532, 11301.49143288554, 11485.425728713615, 11652.766944661143, 9351.532423378803, 9479.905200947971, 9481.525923703855, 9531.142197202216, 9588.424694518351, 3332.4334863073336, 3347.8828241011693, 3350.1122202616325, 3372.0726800129914, 3381.7970921744773, 41426.0, 41556.376654350206, 41908.37137442941, 41959.58040419587, 41987.160256794996, 8517.233448989497, 8670.393072484865, 8674.6530138795, 8717.259032982267, 8745.212930836255, 14181.14913105217, 14260.429582816778, 14278.785818212735, 14295.07082039664, 14402.711945761026, 6188.1027251048345, 6328.0, 6345.460635845912, 6428.582142160744, 6560.606363618198, 3480.704140148065, 3555.1467647764352, 3583.4803953427127, 3592.7305452090677, 3593.407087830531, 2602.2713640180777, 2611.7779988700795, 2612.1771641932733, 2637.0, 2640.6699162604673, 474.4472689316907, 477.60597507056815, 477.79216041022266, 481.07633343978944, 485.7886819233645, 457.93588897554366, 497.0704782057575, 592.7332700284803, 594.1592646405288, 596.9283685957625, 7381.446391520657, 7404.835020910669, 7438.5908775016815, 7737.342325902361, 7851.214878512217, 469.96710230283554, 545.312905738772, 589.666838236395, 634.4068296143121, 636.296891934415, 3554.2713743682484, 3750.737448378642, 3782.0, 3839.424086387064, 3849.826757795906, 51910.480895190565, 52537.7373113132, 52567.21149182766, 52594.0, 53041.469585304425, 46389.76805115953, 47091.76454117776, 47766.0, 47859.76070119627, 47882.76058619685, 42106.1578768429, 42236.99999999939, 42276.36585451221, 42802.35796463056, 42907.0, 7589.772306830804, 7940.0, 8100.189981001853, 8320.292775114183, 8388.370872184732, 31492.685073149893, 32267.51598726068, 32395.838020810686, 32773.34453310968, 32787.672123279415, 40940.0, 40953.38569921394, 41063.38404923988, 41063.589364105974, 41522.79238603909, 10255.94872025635, 10276.537555810157, 10523.94738026305, 10616.628418005641, 10628.8937110631, 11082.22424430282, 11188.888111118784, 11498.712532186762, 11534.538618455503, 11547.711307217387, 10440.58237670515, 10480.0, 10498.265121441425, 10563.630272940718, 10651.57393704243, 10496.842547361948, 10660.786784264115, 10740.570377184826, 10919.399433030942, 11005.17461190398, 10410.1671866249, 10522.579096836042, 10609.840852387375, 10640.574377024832, 11042.944785276022, 9157.587908543997, 9430.151286384258, 9517.428954262767, 9658.179054780423, 9715.951420242853, 8436.578171091298, 8869.379143459895, 8906.376553641183, 8983.505907174907, 9023.774405639911], "unit": "ms", "name": "yui.html", "value": 5720.891311311029}], "name": "dromaeo_css", "value": 6344.243291088955}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 113.0, 111.0, 112.0, 122.0, 111.0, 110.0, 114.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 149.0, 169.0, 129.0, 155.0, 165.0, 131.0, 166.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 165.0, 171.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 79.0, 73.0, 74.0, 130.0, 73.0, 72.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 130.0, 94.0, 95.0, 95.0, 134.0, 94.0, 94.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 72.0, 74.0, 76.0, 73.0, 72.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 86.0, 85.0, 89.0, 83.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [119.0, 128.0, 129.0, 134.0, 131.0, 129.0, 119.0, 127.0, 119.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 144.0, 146.0, 146.0, 134.0, 142.0, 143.0, 143.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 69.0, 68.0, 72.0, 68.0, 69.0, 70.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1527.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [183.5199119104423], "unit": "score", "name": "DeltaBlue", "value": 360.27698199999986}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [708.7172218284904], "unit": "score", "name": "Earley", "value": 940.379293}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [597.3715651135007], "unit": "score", "name": "Splay", "value": 136.41593400000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21406.44688338626}]} 15:57:43 INFO - RETURN: dromaeo_css: 6344.24 15:57:43 INFO - RETURN: kraken: 1527.10 15:57:43 INFO - RETURN: v8_7: 21406.45 15:57:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21406.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1527.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6344.24"}}} 15:57:43 INFO - Return code: 0 15:57:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:57:43 INFO - # TBPL SUCCESS # 15:57:43 INFO - Running post-action listener: _resource_record_post_action 15:57:43 INFO - Running post-run listener: _resource_record_post_run 15:57:44 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506839040; Read time: 12; Write time: 388116 15:57:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230932480; Read time: 0; Write time: 225464 15:57:44 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275595264; Read time: 12; Write time: 162624 15:57:44 INFO - Running post-run listener: _upload_blobber_files 15:57:44 INFO - Blob upload gear active. 15:57:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:57:44 INFO - Copying logs to upload dir... 15:57:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.231389 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-05 15:57:43.944667) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 15:57:43.947957) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009923 build_url: 'https://queue.taskcluster.net/v1/task/axeircW4QXODbqlq1hc1dw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 15:57:44.003933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:57:44.004595) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449358322.436553-1534484226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 15:57:44.056999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 15:57:44.057718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 15:57:44.058462) ========= ========= Total master_lag: 0.31 =========