builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1449858324.03 results: success (0) buildid: 20151211083202 builduid: e69bdc5b86cb46699cff39c07c3c6e2b revision: c56806034eda39d8275a071152eb2704411906a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.033060) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.033508) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.033872) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006331 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.064835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.065334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.096749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.097264) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.149090) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.149650) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.150050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.150363) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 10:25: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2015-12-11 10:25:25 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136364 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.312845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.313169) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022301 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.378789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:24.379152) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c56806034eda39d8275a071152eb2704411906a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c56806034eda39d8275a071152eb2704411906a9 --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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 10:25:25,382 truncating revision to first 12 chars 2015-12-11 10:25:25,382 Setting DEBUG logging. 2015-12-11 10:25:25,382 attempt 1/10 2015-12-11 10:25:25,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c56806034eda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 10:25:25,725 unpacking tar archive at: fx-team-c56806034eda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:25.018726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:25.019115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:25.049451) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:25.049919) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 10:25:25.050476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-11 10:25:25.050816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:25:26 INFO - MultiFileLogger online at 20151211 10:25:26 in /builds/slave/test 10:25:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:25:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:26 INFO - {'append_to_log': False, 10:25:26 INFO - 'base_work_dir': '/builds/slave/test', 10:25:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:25:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:26 INFO - 'branch': 'Fx-Team-Non-PGO', 10:25:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:26 INFO - 'config_files': ('talos/linux_config.py',), 10:25:26 INFO - 'default_actions': ('clobber', 10:25:26 INFO - 'read-buildbot-config', 10:25:26 INFO - 'download-and-extract', 10:25:26 INFO - 'populate-webroot', 10:25:26 INFO - 'create-virtualenv', 10:25:26 INFO - 'install', 10:25:26 INFO - 'run-tests'), 10:25:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:26 INFO - 'download_minidump_stackwalk': True, 10:25:26 INFO - 'download_symbols': 'ondemand', 10:25:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:26 INFO - 'installer_path': 'installer.exe', 10:25:26 INFO - 'log_level': 'info', 10:25:26 INFO - 'log_name': 'talos', 10:25:26 INFO - 'log_to_console': True, 10:25:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:25:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:25:26 INFO - 'opt_config_files': (), 10:25:26 INFO - 'pip_index': False, 10:25:26 INFO - 'sps_profile': False, 10:25:26 INFO - 'sps_profile_interval': 0, 10:25:26 INFO - 'suite': 'dromaeojs-e10s', 10:25:26 INFO - 'system_bits': '64', 10:25:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:26 INFO - 'title': 'talos-linux64-ix-020', 10:25:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:26 INFO - 'use_talos_json': True, 10:25:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:26 INFO - 'work_dir': 'build'} 10:25:26 INFO - ##### 10:25:26 INFO - ##### Running clobber step. 10:25:26 INFO - ##### 10:25:26 INFO - Running pre-action listener: _resource_record_pre_action 10:25:26 INFO - Running main action method: clobber 10:25:26 INFO - rmtree: /builds/slave/test/build 10:25:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:26 INFO - Running post-action listener: _resource_record_post_action 10:25:26 INFO - ##### 10:25:26 INFO - ##### Running read-buildbot-config step. 10:25:26 INFO - ##### 10:25:26 INFO - Running pre-action listener: _resource_record_pre_action 10:25:26 INFO - Running main action method: read_buildbot_config 10:25:26 INFO - Using buildbot properties: 10:25:26 INFO - { 10:25:26 INFO - "properties": { 10:25:26 INFO - "buildnumber": 569, 10:25:26 INFO - "product": "firefox", 10:25:26 INFO - "script_repo_revision": "production", 10:25:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:25:26 INFO - "repository": "", 10:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:25:26 INFO - "buildid": "20151211083202", 10:25:26 INFO - "slavename": "talos-linux64-ix-020", 10:25:26 INFO - "pgo_build": "False", 10:25:26 INFO - "basedir": "/builds/slave/test", 10:25:26 INFO - "project": "", 10:25:26 INFO - "platform": "ubuntu64_hw", 10:25:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:25:26 INFO - "slavebuilddir": "test", 10:25:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:25:26 INFO - "branch": "fx-team", 10:25:26 INFO - "repo_path": "integration/fx-team", 10:25:26 INFO - "stage_platform": "linux64", 10:25:26 INFO - "builduid": "e69bdc5b86cb46699cff39c07c3c6e2b", 10:25:26 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 10:25:26 INFO - }, 10:25:26 INFO - "sourcestamp": { 10:25:26 INFO - "repository": "", 10:25:26 INFO - "hasPatch": false, 10:25:26 INFO - "project": "", 10:25:26 INFO - "branch": "fx-team-linux64-talos", 10:25:26 INFO - "changes": [ 10:25:26 INFO - { 10:25:26 INFO - "category": null, 10:25:26 INFO - "files": [ 10:25:26 INFO - { 10:25:26 INFO - "url": null, 10:25:26 INFO - "name": "https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:25:26 INFO - } 10:25:26 INFO - ], 10:25:26 INFO - "repository": "", 10:25:26 INFO - "rev": "c56806034eda39d8275a071152eb2704411906a9", 10:25:26 INFO - "who": "maglione.k@gmail.com", 10:25:26 INFO - "when": 1449858250, 10:25:26 INFO - "number": 7352890, 10:25:26 INFO - "comments": "Bug 1231827: Fix ESLint regressions in toolkit/components/extensions. r=trivial", 10:25:26 INFO - "project": "", 10:25:26 INFO - "at": "Fri 11 Dec 2015 10:24:10", 10:25:26 INFO - "branch": "fx-team-linux64-talos", 10:25:26 INFO - "revlink": "", 10:25:26 INFO - "properties": [ 10:25:26 INFO - [ 10:25:26 INFO - "buildid", 10:25:26 INFO - "20151211083202", 10:25:26 INFO - "Change" 10:25:26 INFO - ], 10:25:26 INFO - [ 10:25:26 INFO - "builduid", 10:25:26 INFO - "e69bdc5b86cb46699cff39c07c3c6e2b", 10:25:26 INFO - "Change" 10:25:26 INFO - ], 10:25:26 INFO - [ 10:25:26 INFO - "pgo_build", 10:25:26 INFO - "False", 10:25:26 INFO - "Change" 10:25:26 INFO - ] 10:25:26 INFO - ], 10:25:26 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 10:25:26 INFO - } 10:25:26 INFO - ], 10:25:26 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 10:25:26 INFO - } 10:25:26 INFO - } 10:25:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:25:26 INFO - Running post-action listener: _resource_record_post_action 10:25:26 INFO - ##### 10:25:26 INFO - ##### Running download-and-extract step. 10:25:26 INFO - ##### 10:25:26 INFO - Running pre-action listener: _resource_record_pre_action 10:25:26 INFO - Running main action method: download_and_extract 10:25:26 INFO - mkdir: /builds/slave/test/build/tests 10:25: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')]} 10:25:26 INFO - https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/test_packages.json 10:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/test_packages.json 10:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:25:30 INFO - Downloaded 1302 bytes. 10:25:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:25:30 INFO - Using the following test package requirements: 10:25:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:25:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:25:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'jsshell-linux-x86_64.zip'], 10:25:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:25:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:25:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:25:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:25:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:25:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:25:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:25:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:30 INFO - https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:47 INFO - Downloaded 21874385 bytes. 10:25:47 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 10:25:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:47 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 10:25:48 INFO - Return code: 0 10:25:48 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 10:25:48 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')]} 10:25:48 INFO - https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:49 INFO - Downloaded 21874385 bytes. 10:25:49 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 10:25:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:25:49 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 10:25:51 INFO - Return code: 0 10:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:51 INFO - https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:51 INFO - Downloaded 11132038 bytes. 10:25:51 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 10:25:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:25:51 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 10:25:52 INFO - Return code: 0 10:25: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')]} 10:25:52 INFO - https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1yHKRmvgRgOHI2mncdmk1A/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 10:25:53 INFO - Downloaded 57728217 bytes. 10:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:25:53 INFO - mkdir: /builds/slave/test/properties 10:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:53 INFO - Contents: 10:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:25:53 INFO - Running post-action listener: _resource_record_post_action 10:25:53 INFO - Running post-action listener: set_extra_try_arguments 10:25:53 INFO - ##### 10:25:53 INFO - ##### Running populate-webroot step. 10:25:53 INFO - ##### 10:25:53 INFO - Running pre-action listener: _resource_record_pre_action 10:25:53 INFO - Running main action method: populate_webroot 10:25:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:53 INFO - '--tppagecycles', 10:25:53 INFO - '7'], 10:25:53 INFO - 'tests': ['tsvgm']}}, 10:25:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:25:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:25:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:25:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'tests': ['damp', 'tps']}, 10:25:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['damp', 'tps']}, 10:25:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:25:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:53 INFO - 'other': {'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'other_l64': {'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'other_nol64': {'tests': ['a11yr', 10:25:53 INFO - 'ts_paint', 10:25:53 INFO - 'tpaint', 10:25:53 INFO - 'sessionrestore', 10:25:53 INFO - 'sessionrestore_no_auto_restore']}, 10:25:53 INFO - 'svgr': {'tests': ['tsvgx', 10:25:53 INFO - 'tsvgr_opacity', 10:25:53 INFO - 'tart', 10:25:53 INFO - 'tscrollx', 10:25:53 INFO - 'cart']}, 10:25:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['tsvgx', 10:25:53 INFO - 'tsvgr_opacity', 10:25:53 INFO - 'tart', 10:25:53 INFO - 'tscrollx', 10:25:53 INFO - 'cart']}, 10:25:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'tests': ['tp5o']}, 10:25:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'talos_options': ['--e10s'], 10:25:53 INFO - 'tests': ['tp5o']}, 10:25:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'talos_options': ['--xperf_path', 10:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:53 INFO - 'tests': ['tp5n']}, 10:25:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:53 INFO - 'talos_options': ['--e10s', 10:25:53 INFO - '--xperf_path', 10:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:53 INFO - 'tests': ['tp5n']}}, 10:25:53 INFO - 'talos.zip': {'path': '', 10:25:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:53 INFO - Running post-action listener: _resource_record_post_action 10:25:53 INFO - ##### 10:25:53 INFO - ##### Running create-virtualenv step. 10:25:53 INFO - ##### 10:25:53 INFO - Running pre-action listener: _resource_record_pre_action 10:25:53 INFO - Running main action method: create_virtualenv 10:25:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:53 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 10:25:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:53 INFO - Using real prefix '/usr' 10:25:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:25:56 INFO - Installing pip.................done. 10:25:56 INFO - Return code: 0 10:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:25:56 INFO - Using env: {'DISPLAY': ':0', 10:25:56 INFO - 'HOME': '/home/cltbld', 10:25:56 INFO - 'LANG': 'en_US.UTF-8', 10:25:56 INFO - 'LANGUAGE': 'en_US:en', 10:25:56 INFO - 'LOGNAME': 'cltbld', 10:25:56 INFO - 'MAIL': '/var/mail/cltbld', 10:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:56 INFO - 'MOZ_NO_REMOTE': '1', 10:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:56 INFO - 'NO_EM_RESTART': '1', 10:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:56 INFO - 'PWD': '/builds/slave/test', 10:25:56 INFO - 'SHELL': '/bin/bash', 10:25:56 INFO - 'SHLVL': '1', 10:25:56 INFO - 'TERM': 'linux', 10:25:56 INFO - 'TMOUT': '86400', 10:25:56 INFO - 'USER': 'cltbld', 10:25:56 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:56 INFO - '_': '/tools/buildbot/bin/python'} 10:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:56 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 10:25:56 INFO - Cleaning up... 10:25:56 INFO - Return code: 0 10:25:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:25:56 INFO - Using env: {'DISPLAY': ':0', 10:25:56 INFO - 'HOME': '/home/cltbld', 10:25:56 INFO - 'LANG': 'en_US.UTF-8', 10:25:56 INFO - 'LANGUAGE': 'en_US:en', 10:25:56 INFO - 'LOGNAME': 'cltbld', 10:25:56 INFO - 'MAIL': '/var/mail/cltbld', 10:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:56 INFO - 'MOZ_NO_REMOTE': '1', 10:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:56 INFO - 'NO_EM_RESTART': '1', 10:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:56 INFO - 'PWD': '/builds/slave/test', 10:25:56 INFO - 'SHELL': '/bin/bash', 10:25:56 INFO - 'SHLVL': '1', 10:25:56 INFO - 'TERM': 'linux', 10:25:56 INFO - 'TMOUT': '86400', 10:25:56 INFO - 'USER': 'cltbld', 10:25:56 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:56 INFO - '_': '/tools/buildbot/bin/python'} 10:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:56 INFO - Downloading/unpacking psutil>=0.7.1 10:25:56 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 10:25:56 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 10:25:56 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 10:25:56 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 10:25:56 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 10:25:56 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 10:25:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:58 INFO - Installing collected packages: psutil 10:25:58 INFO - Running setup.py install for psutil 10:25:58 INFO - building 'psutil._psutil_linux' extension 10:25:58 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 10:25:58 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 10:25:58 INFO - building 'psutil._psutil_posix' extension 10:25:58 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 10:25:58 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 10:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:25:58 INFO - Successfully installed psutil 10:25:58 INFO - Cleaning up... 10:25:58 INFO - Return code: 0 10:25:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:25: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')]} 10:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25: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')]} 10:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:58 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 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:25:58 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 10:25:58 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 10:25:58 INFO - Using env: {'DISPLAY': ':0', 10:25:58 INFO - 'HOME': '/home/cltbld', 10:25:58 INFO - 'LANG': 'en_US.UTF-8', 10:25:58 INFO - 'LANGUAGE': 'en_US:en', 10:25:58 INFO - 'LOGNAME': 'cltbld', 10:25:58 INFO - 'MAIL': '/var/mail/cltbld', 10:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:58 INFO - 'MOZ_NO_REMOTE': '1', 10:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:58 INFO - 'NO_EM_RESTART': '1', 10:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:58 INFO - 'PWD': '/builds/slave/test', 10:25:58 INFO - 'SHELL': '/bin/bash', 10:25:58 INFO - 'SHLVL': '1', 10:25:58 INFO - 'TERM': 'linux', 10:25:58 INFO - 'TMOUT': '86400', 10:25:58 INFO - 'USER': 'cltbld', 10:25:58 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:58 INFO - '_': '/tools/buildbot/bin/python'} 10:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:26:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:26:00 INFO - Installing collected packages: mozsystemmonitor 10:26:00 INFO - Running setup.py install for mozsystemmonitor 10:26:00 INFO - Successfully installed mozsystemmonitor 10:26:00 INFO - Cleaning up... 10:26:01 INFO - Return code: 0 10:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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', '--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 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:01 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 10:26:01 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 10:26:01 INFO - Using env: {'DISPLAY': ':0', 10:26:01 INFO - 'HOME': '/home/cltbld', 10:26:01 INFO - 'LANG': 'en_US.UTF-8', 10:26:01 INFO - 'LANGUAGE': 'en_US:en', 10:26:01 INFO - 'LOGNAME': 'cltbld', 10:26:01 INFO - 'MAIL': '/var/mail/cltbld', 10:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:01 INFO - 'MOZ_NO_REMOTE': '1', 10:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:01 INFO - 'NO_EM_RESTART': '1', 10:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:01 INFO - 'PWD': '/builds/slave/test', 10:26:01 INFO - 'SHELL': '/bin/bash', 10:26:01 INFO - 'SHLVL': '1', 10:26:01 INFO - 'TERM': 'linux', 10:26:01 INFO - 'TMOUT': '86400', 10:26:01 INFO - 'USER': 'cltbld', 10:26:01 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:01 INFO - '_': '/tools/buildbot/bin/python'} 10:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26:03 INFO - Downloading docopt-0.6.1.tar.gz 10:26:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:03 INFO - Running setup.py install for blobuploader 10:26:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:03 INFO - Running setup.py install for requests 10:26:04 INFO - Running setup.py install for docopt 10:26:04 INFO - Successfully installed blobuploader requests docopt 10:26:04 INFO - Cleaning up... 10:26:04 INFO - Return code: 0 10:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:26:04 INFO - Using env: {'DISPLAY': ':0', 10:26:04 INFO - 'HOME': '/home/cltbld', 10:26:04 INFO - 'LANG': 'en_US.UTF-8', 10:26:04 INFO - 'LANGUAGE': 'en_US:en', 10:26:04 INFO - 'LOGNAME': 'cltbld', 10:26:04 INFO - 'MAIL': '/var/mail/cltbld', 10:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:04 INFO - 'MOZ_NO_REMOTE': '1', 10:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:04 INFO - 'NO_EM_RESTART': '1', 10:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:04 INFO - 'PWD': '/builds/slave/test', 10:26:04 INFO - 'SHELL': '/bin/bash', 10:26:04 INFO - 'SHLVL': '1', 10:26:04 INFO - 'TERM': 'linux', 10:26:04 INFO - 'TMOUT': '86400', 10:26:04 INFO - 'USER': 'cltbld', 10:26:04 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:04 INFO - '_': '/tools/buildbot/bin/python'} 10:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:04 INFO - Running setup.py (path:/tmp/pip-C9hbyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:04 INFO - Running setup.py (path:/tmp/pip-T15lGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:04 INFO - Running setup.py (path:/tmp/pip-wp96qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:04 INFO - Running setup.py (path:/tmp/pip-aklLjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:04 INFO - Running setup.py (path:/tmp/pip-600Whv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:04 INFO - Running setup.py (path:/tmp/pip-qdMiGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:04 INFO - Running setup.py (path:/tmp/pip-MXVoGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:04 INFO - Running setup.py (path:/tmp/pip-cJOdd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:05 INFO - Running setup.py (path:/tmp/pip-8sToWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:05 INFO - Running setup.py (path:/tmp/pip-_oyYZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:05 INFO - Running setup.py (path:/tmp/pip-tiS2_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:05 INFO - Running setup.py (path:/tmp/pip-wttwRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:05 INFO - Running setup.py (path:/tmp/pip-fti0H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:05 INFO - Running setup.py (path:/tmp/pip-xWrwCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:05 INFO - Running setup.py (path:/tmp/pip-mKXrj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:05 INFO - Running setup.py (path:/tmp/pip-LGdwnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:05 INFO - Running setup.py (path:/tmp/pip-MgedYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:05 INFO - Running setup.py install for manifestparser 10:26:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:05 INFO - Running setup.py install for mozcrash 10:26:05 INFO - Running setup.py install for mozdebug 10:26:05 INFO - Running setup.py install for mozdevice 10:26:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for mozfile 10:26:06 INFO - Running setup.py install for mozhttpd 10:26:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for mozinfo 10:26:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for mozInstall 10:26:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for mozleak 10:26:06 INFO - Running setup.py install for mozlog 10:26:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for moznetwork 10:26:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Running setup.py install for mozprocess 10:26:06 INFO - Running setup.py install for mozprofile 10:26:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:07 INFO - Running setup.py install for mozrunner 10:26:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:07 INFO - Running setup.py install for mozscreenshot 10:26:07 INFO - Running setup.py install for moztest 10:26:07 INFO - Running setup.py install for mozversion 10:26:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:07 INFO - Cleaning up... 10:26:07 INFO - Return code: 0 10:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:26:07 INFO - Using env: {'DISPLAY': ':0', 10:26:07 INFO - 'HOME': '/home/cltbld', 10:26:07 INFO - 'LANG': 'en_US.UTF-8', 10:26:07 INFO - 'LANGUAGE': 'en_US:en', 10:26:07 INFO - 'LOGNAME': 'cltbld', 10:26:07 INFO - 'MAIL': '/var/mail/cltbld', 10:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:07 INFO - 'MOZ_NO_REMOTE': '1', 10:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:07 INFO - 'NO_EM_RESTART': '1', 10:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:07 INFO - 'PWD': '/builds/slave/test', 10:26:07 INFO - 'SHELL': '/bin/bash', 10:26:07 INFO - 'SHLVL': '1', 10:26:07 INFO - 'TERM': 'linux', 10:26:07 INFO - 'TMOUT': '86400', 10:26:07 INFO - 'USER': 'cltbld', 10:26:07 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:07 INFO - '_': '/tools/buildbot/bin/python'} 10:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:07 INFO - Running setup.py (path:/tmp/pip-JybsRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:07 INFO - Running setup.py (path:/tmp/pip-K0yGb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:07 INFO - Running setup.py (path:/tmp/pip-3h_8se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:07 INFO - Running setup.py (path:/tmp/pip-SxW79N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:07 INFO - Running setup.py (path:/tmp/pip-vghN_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:08 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)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:08 INFO - Running setup.py (path:/tmp/pip-uJYK39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:08 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)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:08 INFO - Running setup.py (path:/tmp/pip-NvLXVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:08 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)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:08 INFO - Running setup.py (path:/tmp/pip-ETvmnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:08 INFO - Running setup.py (path:/tmp/pip-vDg3U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:08 INFO - Running setup.py (path:/tmp/pip-ZaiiuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:08 INFO - Running setup.py (path:/tmp/pip-mZHjF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:08 INFO - Running setup.py (path:/tmp/pip-tpeHxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:08 INFO - Running setup.py (path:/tmp/pip-LyhmjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:08 INFO - Running setup.py (path:/tmp/pip-U71Uon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:08 INFO - Running setup.py (path:/tmp/pip-XNm_2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:08 INFO - Running setup.py (path:/tmp/pip-jR_F4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:08 INFO - Running setup.py (path:/tmp/pip-xWUeAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:26:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26: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 10:26:10 INFO - Downloading blessings-1.5.1.tar.gz 10:26:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:10 INFO - Installing collected packages: blessings 10:26:10 INFO - Running setup.py install for blessings 10:26:10 INFO - Successfully installed blessings 10:26:10 INFO - Cleaning up... 10:26:10 INFO - Return code: 0 10:26:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:11 INFO - Reading from file tmpfile_stdout 10:26:11 INFO - Current package versions: 10:26:11 INFO - argparse == 1.2.1 10:26:11 INFO - blessings == 1.5.1 10:26:11 INFO - blobuploader == 1.2.4 10:26:11 INFO - docopt == 0.6.1 10:26:11 INFO - manifestparser == 1.1 10:26:11 INFO - mozInstall == 1.12 10:26:11 INFO - mozcrash == 0.16 10:26:11 INFO - mozdebug == 0.1 10:26:11 INFO - mozdevice == 0.47 10:26:11 INFO - mozfile == 1.2 10:26:11 INFO - mozhttpd == 0.7 10:26:11 INFO - mozinfo == 0.9 10:26:11 INFO - mozleak == 0.1 10:26:11 INFO - mozlog == 3.1 10:26:11 INFO - moznetwork == 0.27 10:26:11 INFO - mozprocess == 0.22 10:26:11 INFO - mozprofile == 0.27 10:26:11 INFO - mozrunner == 6.11 10:26:11 INFO - mozscreenshot == 0.1 10:26:11 INFO - mozsystemmonitor == 0.0 10:26:11 INFO - moztest == 0.7 10:26:11 INFO - mozversion == 1.4 10:26:11 INFO - psutil == 3.1.1 10:26:11 INFO - requests == 1.2.3 10:26:11 INFO - wsgiref == 0.1.2 10:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:11 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 10:26:11 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 10:26:11 INFO - Using env: {'DISPLAY': ':0', 10:26:11 INFO - 'HOME': '/home/cltbld', 10:26:11 INFO - 'LANG': 'en_US.UTF-8', 10:26:11 INFO - 'LANGUAGE': 'en_US:en', 10:26:11 INFO - 'LOGNAME': 'cltbld', 10:26:11 INFO - 'MAIL': '/var/mail/cltbld', 10:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:11 INFO - 'MOZ_NO_REMOTE': '1', 10:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:11 INFO - 'NO_EM_RESTART': '1', 10:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:11 INFO - 'PWD': '/builds/slave/test', 10:26:11 INFO - 'SHELL': '/bin/bash', 10:26:11 INFO - 'SHLVL': '1', 10:26:11 INFO - 'TERM': 'linux', 10:26:11 INFO - 'TMOUT': '86400', 10:26:11 INFO - 'USER': 'cltbld', 10:26:11 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:11 INFO - '_': '/tools/buildbot/bin/python'} 10:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:26:11 INFO - Cleaning up... 10:26:11 INFO - Return code: 0 10:26:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:26:11 INFO - Using env: {'DISPLAY': ':0', 10:26:11 INFO - 'HOME': '/home/cltbld', 10:26:11 INFO - 'LANG': 'en_US.UTF-8', 10:26:11 INFO - 'LANGUAGE': 'en_US:en', 10:26:11 INFO - 'LOGNAME': 'cltbld', 10:26:11 INFO - 'MAIL': '/var/mail/cltbld', 10:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:11 INFO - 'MOZ_NO_REMOTE': '1', 10:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:11 INFO - 'NO_EM_RESTART': '1', 10:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:11 INFO - 'PWD': '/builds/slave/test', 10:26:11 INFO - 'SHELL': '/bin/bash', 10:26:11 INFO - 'SHLVL': '1', 10:26:11 INFO - 'TERM': 'linux', 10:26:11 INFO - 'TMOUT': '86400', 10:26:11 INFO - 'USER': 'cltbld', 10:26:11 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:11 INFO - '_': '/tools/buildbot/bin/python'} 10:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:11 INFO - Downloading/unpacking jsonschema 10:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:13 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 10:26:13 INFO - Downloading/unpacking functools32 (from jsonschema) 10:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:13 INFO - warning: no files found matching '*.txt' 10:26:13 INFO - no previously-included directories found matching 'build' 10:26:13 INFO - no previously-included directories found matching 'dist' 10:26:13 INFO - no previously-included directories found matching '.git*' 10:26:13 INFO - Installing collected packages: jsonschema, functools32 10:26:13 INFO - Running setup.py install for functools32 10:26:13 INFO - warning: no files found matching '*.txt' 10:26:13 INFO - no previously-included directories found matching 'build' 10:26:13 INFO - no previously-included directories found matching 'dist' 10:26:13 INFO - no previously-included directories found matching '.git*' 10:26:13 INFO - Successfully installed jsonschema functools32 10:26:13 INFO - Cleaning up... 10:26:13 INFO - Return code: 0 10:26:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc1f664f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd5240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', '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 10:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:26:13 INFO - Using env: {'DISPLAY': ':0', 10:26:13 INFO - 'HOME': '/home/cltbld', 10:26:13 INFO - 'LANG': 'en_US.UTF-8', 10:26:13 INFO - 'LANGUAGE': 'en_US:en', 10:26:13 INFO - 'LOGNAME': 'cltbld', 10:26:13 INFO - 'MAIL': '/var/mail/cltbld', 10:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:13 INFO - 'MOZ_NO_REMOTE': '1', 10:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:13 INFO - 'NO_EM_RESTART': '1', 10:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:13 INFO - 'PWD': '/builds/slave/test', 10:26:13 INFO - 'SHELL': '/bin/bash', 10:26:13 INFO - 'SHLVL': '1', 10:26:13 INFO - 'TERM': 'linux', 10:26:13 INFO - 'TMOUT': '86400', 10:26:13 INFO - 'USER': 'cltbld', 10:26:13 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:13 INFO - '_': '/tools/buildbot/bin/python'} 10:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:14 INFO - Downloading/unpacking flake8 10:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:26:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:26:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:26:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:26:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:16 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 10:26:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:26:16 INFO - no previously-included directories found matching 'docs/_build' 10:26:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:26:16 INFO - Running setup.py install for pep8 10:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:26:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:26:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:26:16 INFO - no previously-included directories found matching 'docs/_build' 10:26:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:26:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Running post-action listener: _resource_record_post_action 10:26:16 INFO - Running post-action listener: _start_resource_monitoring 10:26:16 INFO - Starting resource monitoring. 10:26:16 INFO - ##### 10:26:16 INFO - ##### Running install step. 10:26:16 INFO - ##### 10:26:16 INFO - Running pre-action listener: _resource_record_pre_action 10:26:16 INFO - Running main action method: install 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:16 INFO - Reading from file tmpfile_stdout 10:26:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:16 INFO - Reading from file tmpfile_stdout 10:26:16 INFO - Output received: 10:26:16 INFO - Usage: mozinstall [options] installer 10:26:16 INFO - Options: 10:26:16 INFO - -h, --help show this help message and exit 10:26:16 INFO - -d DEST, --destination=DEST 10:26:16 INFO - Directory to install application into. [default: 10:26:16 INFO - "/builds/slave/test"] 10:26:16 INFO - --app=APP Application being installed. [default: firefox] 10:26:16 INFO - mkdir: /builds/slave/test/build/application 10:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:26:31 INFO - Reading from file tmpfile_stdout 10:26:31 INFO - Output received: 10:26:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:26:31 INFO - Running post-action listener: _resource_record_post_action 10:26:31 INFO - ##### 10:26:31 INFO - ##### Running run-tests step. 10:26:31 INFO - ##### 10:26:31 INFO - Running pre-action listener: _resource_record_pre_action 10:26:31 INFO - Running main action method: run_tests 10:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:26:31 INFO - Python 2.7.3 10:26:31 INFO - Return code: 0 10:26:31 INFO - grabbing minidump binary from tooltool 10:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640b0>, '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 0x1064fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:26:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:26:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:26:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:26:31 INFO - Return code: 0 10:26:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:26:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:26:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:26:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:26:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:26:32 INFO - Return code: 0 10:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test/build 10:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 10:26:32 INFO - Using env: {'DISPLAY': ':0', 10:26:32 INFO - 'HOME': '/home/cltbld', 10:26:32 INFO - 'LANG': 'en_US.UTF-8', 10:26:32 INFO - 'LANGUAGE': 'en_US:en', 10:26:32 INFO - 'LOGNAME': 'cltbld', 10:26:32 INFO - 'MAIL': '/var/mail/cltbld', 10:26:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:26:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:32 INFO - 'MOZ_NO_REMOTE': '1', 10:26:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:32 INFO - 'NO_EM_RESTART': '1', 10:26:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:32 INFO - 'PWD': '/builds/slave/test', 10:26:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:26:32 INFO - 'SHELL': '/bin/bash', 10:26:32 INFO - 'SHLVL': '1', 10:26:32 INFO - 'TERM': 'linux', 10:26:32 INFO - 'TMOUT': '86400', 10:26:32 INFO - 'USER': 'cltbld', 10:26:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388', 10:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:32 INFO - '_': '/tools/buildbot/bin/python'} 10:26:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 10:26:32 INFO - mozversion INFO | application_buildid: 20151211083202 10:26:32 INFO - mozversion INFO | application_changeset: c56806034eda39d8275a071152eb2704411906a9 10:26:32 INFO - mozversion INFO | application_display_name: Nightly 10:26:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:32 INFO - mozversion INFO | application_name: Firefox 10:26:32 INFO - mozversion INFO | application_remotingname: firefox 10:26:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:26:32 INFO - mozversion INFO | application_vendor: Mozilla 10:26:32 INFO - mozversion INFO | application_version: 45.0a1 10:26:32 INFO - mozversion INFO | platform_buildid: 20151211083202 10:26:32 INFO - mozversion INFO | platform_changeset: c56806034eda39d8275a071152eb2704411906a9 10:26:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:26:32 INFO - mozversion INFO | platform_version: 45.0a1 10:26:32 INFO - 2015-12-11 10:26:32,612 DEBUG : using testdate: 1449858392 10:26:32 INFO - 2015-12-11 10:26:32,612 DEBUG : actual date: 1449858392 10:26:32 INFO - 2015-12-11 10:26:32,620 INFO : starting webserver on 'localhost:56613' 10:26:32 INFO - 2015-12-11 10:26:32,621 INFO : Starting test suite talos-linux64-ix-020.e 10:26:32 INFO - 2015-12-11 10:26:32,621 INFO : Starting test dromaeo_css 10:26:32 INFO - 2015-12-11 10:26:32,621 DEBUG : operating with platform_type : linux_ 10:26:32 INFO - 2015-12-11 10:26:32,622 INFO : Initialising browser for dromaeo_css test... 10:26:32 INFO - 2015-12-11 10:26:32,639 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ2aqL8/profile http://localhost:56613/getInfo.html 10:26:37 INFO - 2015-12-11 10:26:37,893 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:26:37 INFO - 2015-12-11 10:26:37,893 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:26:37 INFO - 2015-12-11 10:26:37,893 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:26:37 INFO - 2015-12-11 10:26:37,893 DEBUG : BROWSER_OUTPUT: __metrics 10:26:38 INFO - 2015-12-11 10:26:38,036 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] 10:26:39 INFO - 2015-12-11 10:26:39,157 INFO : Browser initialized. 10:26:39 INFO - 2015-12-11 10:26:39,158 INFO : Running cycle 1/1 for dromaeo_css test... 10:26:39 INFO - 2015-12-11 10:26:39,158 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ2aqL8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:26:51 INFO - 2015-12-11 10:26:51,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 143368192 10:26:51 INFO - 2015-12-11 10:26:51,166 DEBUG : BROWSER_OUTPUT: 10:27:40 INFO - 2015-12-11 10:27:40,803 DEBUG : BROWSER_OUTPUT: 1449858460801 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] 10:29:52 INFO - 2015-12-11 10:29:52,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56613/tests/dromaeo/cssquery-ext.html) 10:29:53 INFO - 2015-12-11 10:29:53,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 147460096 10:29:53 INFO - 2015-12-11 10:29:53,492 DEBUG : BROWSER_OUTPUT: 10:32:55 INFO - 2015-12-11 10:32:55,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-ext.html (next: http://localhost:56613/tests/dromaeo/cssquery-jquery.html) 10:32:56 INFO - 2015-12-11 10:32:56,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 147357696 10:32:56 INFO - 2015-12-11 10:32:56,061 DEBUG : BROWSER_OUTPUT: 10:35:57 INFO - 2015-12-11 10:35:57,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56613/tests/dromaeo/cssquery-mootools.html) 10:35:58 INFO - 2015-12-11 10:35:58,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 145313792 10:35:58 INFO - 2015-12-11 10:35:58,481 DEBUG : BROWSER_OUTPUT: 10:39:00 INFO - 2015-12-11 10:39:00,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56613/tests/dromaeo/cssquery-prototype.html) 10:39:00 INFO - 2015-12-11 10:39:00,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 144338944 10:39:00 INFO - 2015-12-11 10:39:00,871 DEBUG : BROWSER_OUTPUT: 10:42:03 INFO - 2015-12-11 10:42:03,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56613/tests/dromaeo/cssquery-yui.html) 10:42:04 INFO - 2015-12-11 10:42:04,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 145313792 10:42:04 INFO - 2015-12-11 10:42:04,149 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/dromaeo/cssquery-yui.html (next: http://localhost:56613/tests/dromaeo/cssquery-dojo.html) 10:45:06 INFO - 2015-12-11 10:45:06,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 147083264 10:45:06 INFO - 2015-12-11 10:45:06,733 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,734 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:45:06 INFO - 2015-12-11 10:45:06,734 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:45:06 INFO - 2015-12-11 10:45:06,734 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:45:06 INFO - 2015-12-11 10:45:06,735 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:45:06 INFO - 2015-12-11 10:45:06,736 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.4599357131783;2702.905398311057;2733.5079685656574;2750.7249275072495;2756.614074029635;4553.521880202581;4619.2147334953015;4673.065386922616;4684.039771846772;4688.53114688531;4621.098885717278;4633.1891918914225;4654.394928659278;4739.265413860849;4747.454042785081;4310.741355518679;4362.912741745163;4457.465104187502;4469.932951005738;4487;4162.542120366757;4374.60628543431;4398.846040388587;4433.334999750047;4510.526394728556;4288.378185163149;4294.785260736982;4395.802188901507;4409.316555933835;4430.003249268889;4331.7617531035785;4374.715643483195;4395.077033822901;4396.71421357614;4454.554544545552;4183.3515805049965;4298.290782020963;4339.067100573392;4369.80335884886;4420.40324556184;4443.42235509385;4513.616342610882;4537;4542.02346495505;4544.818207271705;5053.469385714484;5118.61610379223;5120.92318615221;5123.795048198068;5135.537801597837;4932.112219800434;5028.547430731252;5035.244713292998;5153.871153221162;5187.455317191679;4780.426348838162;4788.329633851264;4795.736234507136;4812.494688057774;4856.490068542823;5249.685018898802;5280.9471905281225;5292.761825717852;5311.150215965427;5316.521513063843;4845.41854977405;4918.458969513351;4960.379952505937;5053.570446512088;5065.468125846806;5038;5092.2361645753435;5109.718965456936;5113.258577506241;5152.433232344439;5040.59675225981;5052.317937078447;5055.9494405055475;5067.1639179535705;5070.670406423571;4742.549457801503;4875.463698993108;4898.14282500561;4965.900681986413;4990.675606085593;4246;4269.402283680287;4274.401583778274;4276.72201306914;4308.159908817813;3633.6729694327637;3767.6797472215167;3801.2967600993907;3803.258364618928;3807.0862992881507;4312.913741725148;4375.321825117112;4381.014271788886;4415.249407600716;4427.712198707074;5078.187490001582;5162.148245539444;5175.896482070338;5200.24596433515;5209.114450543341;4205.032842446254;4303.376010478463;4440.711353761995;4472.239719247736;4515.2324104902245;4448.488423831236;4518.1415531049;4518.4126063612175;4554.863354099382;4567.474740404829;4816.54242846936;4849.030193961151;4856.368672072608;4865.513448655177;4898.804047838046;4872.9269060964825;4992.500749924979;4992.750362481789;5082.466341034286;5120.462351453044;4783.928241076456;4799.544043315879;4916.287138364845;4918.2376731606655;4934.963657631937;5047.091523525801;5059.139946209079;5063.594912407072;5068.873278168076;5100.158473851773;4960.379952505937;5130.769115389891;5135.2553879687985;5143.254228136824;5149.279100925948;4858.659893807541;4897.9020419592125;4903.901921961469;4944.802207911644;4993.875153121201;4933.235348520985;4942.3080768693135;4949.752512374439;4970.602351811919;5026.874328141826;4659.138059459011;4853.174960256694;4861.149298872612;4861.854144375674;4898.657094003528;4859.586935110555;4928.088303663833;4943.678660887031;4949.97525012387;4977.4773648767805;4883.780229889735;4898.559129678346;4905.043516514245;4910.901781964412;4920.261960705922 10:45:06 INFO - 2015-12-11 10:45:06,737 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.6527170518428;565.728450343835;572.0389745228018;572.1046562130264;576.0092640658067;35614.82192589037;36450;36458.270834583294;36495.635043649556;36551.817240913755;40188;40884.38673419894;40894.795526022404;40999.18001639965;41020.58979410205;7707.884381734279;7897.723579674713;7900.051993760757;7903.40724445666;7905.762827115196;7678.155402905676;7679.500832445901;7727.845443091135;7740.303372696456;7753.651085701157;7775.144734079275;7903.40724445666;7906.960465197666;7922.920770792305;7935.761927142195;7778.105517865433;7856.332211762007;7857.685692572319;7865.292123708894;7895.249951254593;7765.301122898966;7838.686452541891;7844.882326765103;7851.725189618336;7886.211378862068;36419.27161456756;37133;37334.43998340027;37498;37543.436848447294;2801.131649188738;2893.1754449981654;2937.1775902747263;2937.7502912252485;2945.7937944343903;28344.14967550977;28528.429431411463;28547;28598.714012859815;28606.284842878886;3334.1664583854035;3360.1599600099976;3377.628460869327;3409.505621684842;3459.3081383723106;203811;203837;203882;204325.97837010867;204408;49851.75074124606;51138;60524.579016839714;62638.373616264165;62779;54536;54883.72558137264;54951.17573236405;55236.17145742817;55325.72337138288;12626.242425454502;12629.93685031569;12713.872861271453;12741.872581274254;12747.553835615894;9871;9912.752181195383;9917.553710083064;9937;9946;19034.61930761377;19212.903935480514;19343.322983695503;19466.61066778685;19467.31864384768;7708.884366734504;7936.96003038075;7945.562994035384;8053.355731541463;8063.27430531255;810.7770363150181;816.2408959667448;867.4231635962014;970.3110791338088;1019.3068713275044;25326.493470130496;26000.479990400465;26063.08779192719;26182;26288.8685556571;902.3638334973828;930.9487978161267;937.7983733497331;938.216589148069;955.4697143085515;12692;12734.299613521345;14034.578962631138;14037.438502459992;14512.564623061326;260959;264808;265260;265994;266314;45372.77313613411;45791.77104114458;45863.31205031927;45898.5410145901;46010;1140.520981187903;1147.7819214349247;1161.6805378520974;1162.0297051961707;1298.1626850681446;26153.215403537924;26183.73816261813;26266.4746705061;26764.59853102244;26903.596446053718;39310;39808.40287395634;39856;39908.401373978835;40006.39990400204;242846;243700;244536;244794;245839;27435.31411714723;27820.582691260053;28403.721832517174;28666.283342916595;28687.569686454302;32893.835530822194;33006.669933300356;33186;33995.66004339925;34094.65905340915;29091.7090829089;29502;29625.703742962294;29847.253818654706;30016.699833001392;28707.712922870505;28892;29301.560476593295;31209.687903120677;32047.35905281928;29240.41519169562;29456.11631651054;29665.703342967157;29993.400131997674;30027.249318767204;25618.462892226526;26018.219453416426;27278.454430910875;27606.585901211096;27712.44575108527;23303.76696233016;23366.64950025785;23410.338174875404;23766.405839854142;23767 10:45:06 INFO - 2015-12-11 10:45:06,737 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.8270490697293;339.0743270870523;340.01056924350144;340.74444166874844;344.99827500862494;14710.117392956417;15672.608184795386;16019.279132439038;16613.08628025458;16653.833461665396;9996.60013599457;10099.29304948654;10237.897621023787;10264.897351026488;10293.279470437072;4580.267157254832;4699.107169637758;4699.107169637775;4703.835365762199;4705.176594096037;4698.671093023489;5085.5423011928915;5086.720230387327;5088.4148322942965;5092.337996060507;5050.964552266776;5055.949440505603;5068.949310506885;5223.477652234765;5236.8690782730355;5197.038547868638;5210.036143313499;5216.374035115791;5222.190560463135;5233.65981211222;4996.600271978233;5016.573591244749;5175.663581867204;5220.29526013987;5223.425423203445;11812.291262524275;12017.819732703929;12081.214721043105;17324.740128898076;19315.130819113172;1767.7348397740313;1841.29110292537;1845.8800177988387;1860.2930886263268;1907.4468404162776;8967.68613098545;9288.628454861797;9334.71995840126;11692.649220523397;12372.257664540066;1745.860331173503;1762.207006846924;1808.5749848785524;1839.8252166044203;1890.602973375579;53545.1968220477;54540.18189727157;54547.45452545463;55595;57143.42856571464;9822.901770982342;9935.950320248352;9965.85392679851;9975;9999.450030248407;12232.510699572096;12328.50685972569;12366.505339786489;12466.189697669804;12486.250824950532;6833.145856767904;6841.076454678654;6870.725170993204;6876.828079298058;6876.828079298058;6448.838779030561;6464.418202361716;6496.610203387718;6507.089007538948;6516.837079073061;4120.526139493936;4145.316022856256;4196.349565817303;4228.873133805991;4241.27898257297;1706.5733566608349;1724.6033412315237;1733.2806885142525;1737.7654016707584;1769.4691592522192;336.8231678368876;338.89155470249284;363.59277609078003;755.7317152410925;944.976375590602;9108.407953483002;9332.486713230837;9580.95209523948;9864.802703945881;9880.555375008142;373.7383831318088;384.3427738567026;384.8672208088205;392.931237033518;399.2693371130824;4619.745913974696;5437.809676661298;5442.727863606804;5495.340559132929;5528.889422211533;465295;467007;483741;490622;496302;70064;70761;71001.64499177471;71489.6425517869;73688.63155684188;1006.4464544500496;1018.4296793795646;1021.6883850425543;1037.6938803053117;1039.6932904792952;14430.927845360706;14474.348654310792;14670.193139377438;15022.248887555797;15140.772888406462;29989;30543.2364190897;33686;33850.32299354048;34376.82811585926;41011.38482922699;42999;43233.35149972816;43263.351049734905;45256.32115518204;8721.65113395457;8933.821323573622;8992.28061755071;9204.585793639437;9237.722868313962;15348.923255383652;15610.297536611108;15675.29461174227;15939.442119526224;16524.504264872074;13265;13483;13490.123141995738;13669.179849209078;13885.236312002937;12566.37168141571;12777.744445111231;12895.871041289467;13219.735605288033;13745;13199.67000824987;13747.243901585109;13752.174869507862;13949.302534873419;14146.717065658835;8654.870176947477;8745.169208925143;8835.64657413722;8950.373473856767;9045.683401081194;12974.026947978751;13069;13165;13238.073334866853;13303.66740831487 10:45:06 INFO - 2015-12-11 10:45:06,738 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.526478364964;1379.8896088312943;1396.0646366934154;1401.4114072089722;1443.0620096936993;5622.550195984321;5871.383504732005;6477.967610161949;6862.07362006129;6899.172099348085;6584.769533066344;6632.63520506372;6741.123653924995;6754.831129221772;6771.187457505094;1999.510120020597;2065.3597384810682;2065.6281869263526;2065.7521097468248;2066.628006958747;2055.9383218503394;2075.885826279554;2087.405089549479;2124.3095993802;2130.403487023636;1993.5614164883702;2009.6181725472186;2014.315132854829;2021.5047313408236;2026.3515674984012;2037.2665840297482;2066.5040390306367;2069;2070.099506714584;2071.492484341331;2089.3314139475374;2107.6838474228834;2127.8723276603455;2128.638131517646;2133.967990480144;6829.556078854858;6998.335158159966;7002.5098243123;7028.54314469563;7048.577085374894;4136.21411931732;4206.453161089069;4227.577242275778;4234.513031001413;4235.004773878136;2719.619253304539;2730.6586676665415;2751.4222013377216;2787.9442411151867;2802.579613058037;852.3820230333021;864.2999170671714;868.6785889221029;881.1100788203896;889.5329951775306;9291.907080929172;9371.953140234255;9406;9435.962044175203;9447.291453141042;3844.6347596978244;3852.5376954765607;3879;3889.3193691103943;3905.062784931596;8054.395920306;8061.879071813927;8071.4753541019645;8082.878756818653;8093.27160555541;4147.854825081168;4155.376693495939;4159.376093585925;4161.10536234711;4162.042730172077;3200.231944333343;3298.1589694627714;3725.4225595032813;3754.9436758448646;3769.981150094232;3384.424647809878;3426.297608990151;3429.3998550253605;3434.4504879219703;3441.587009558819;1083.3716444462193;1095.2278643556274;1095.895889890459;1104.4643347976225;1110.0841805510486;985.5417230987482;993.1310103659298;995.2933417273672;997.6258902911409;1024.6669832304383;6440.291567927524;6509.479241660656;6554.9672251639395;6555.868882622321;6575.980722987944;426.9146170765859;428.3189728331967;429.68632897984645;435.1362545347483;435.44698233244236;5163.4578369270685;5184.611154163377;5194.039102766001;5225;5242.135047717084;8145.877811832827;8177.713780017671;8248.422610417214;8330;8352.749417517363;8163.7142700005215;8184.836303273901;8189.672413103528;8191.631376588068;8235.629396677165;6223.657698826518;6267.091271765659;6286.591371560834;6311.715972781236;6317.905231421532;6504.219493660791;6532.150820393318;6551;6551.934480655133;6564.868702626016;7240.818979525554;7396.778096657109;7435.591042492715;7440.218777028334;7505;7334.266573342623;7486.7005319786595;7501.2123727007875;7570.886436703344;7585.658645361083;5744.597878148489;6147.262328520606;6222.253329600296;6228.657423841732;6229.127922091002;6444.678840837523;6459.321771213955;6489.967550162408;6530.412262896362;6543.051257567531;5968.432998865101;6034.577579569388;6237.625742455467;6251.4061164189325;6296.874062518816;5868.61853979507;6130.233720784902;6151;6155.446009859134;6210.534209934363;6277.717502712298;6342.936570634234;6400.519961003037;6404.327545607831;6409.038644203407;5955.493783028491;5958.404159584007;5972.820815375546;5981.3719559445635;5983.790567330123;5692.914606280826;5769.769209231752;5841.065429531254;5847.883042339215;5930.940690593211 10:45:06 INFO - 2015-12-11 10:45:06,739 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.7303136723999;306.6182602659689;307.5601889298304;310.6567243196268;313.1482367959151;5491.945080549193;5567.944320556793;5612.747426365813;5637.9718101409535;5653.180288858113;5416.566674666027;5533.972330138344;5555.472230138141;5562.276904002474;5578;4212.726172798758;4303.18239534489;4339.023719663082;4341.869743907672;4349.891252718691;4311.762853043081;4314.395984562164;4315.978420107895;4317.179735850194;4334.829596009075;4311.267084595626;4320.027993701424;4327.0913108247305;4329.978350108245;4333.479982402117;4334.393184954109;4338.305871060616;4340.891477713051;4341.41390912226;4341.479022517318;3664.2305115925687;3794.9620503794886;3813.7902415367143;3824.694024478035;3830.9808450957844;5205.115130427798;5294.947050529522;5295.364556253236;5307.2835167252315;5315.707636080014;4993.925091123636;4999.500049995007;5004.724740139291;5006.69959802413;5021.14640511114;5911.4975227105315;5918.7928422505;5920.940790592082;5932.911006334908;5948.643081415085;4004.2191772604356;4093.488313960755;4134.1731653669085;4146.1914926589325;4149.937750933738;6138.0792881067755;6190.0405437157315;6195.628262304231;6212.471939885115;6213.906791398087;4234.280172370704;4259.1268789897995;4274.1451709658195;4278.165757677285;4287.421198138211;4302.569743025672;4333.891652708645;4351;4353.477582690098;4359.258925982591;4800.4719480857075;4929.260610908393;4930.7288099154175;4952.579030782352;4954.628402869727;5906.379830117861;5917.349091599921;5928.140419639129;5928.67392293428;5929.080992446177;1531.0966529747502;1547.0562956596468;1550.550340401271;1551.9612009699622;1553.5572361876812;1039.449091981251;1044.6761503933806;1051.9263651544318;1055.9208059395423;1059.0944742245424;5121.4622464641425;5131.1277082895995;5133.486651334837;5133.768980395891;5136.357955255593;6108.633481991006;6115.449609535074;6118.510519158456;6121.387861213843;6121.602095863755;5115.974420127875;5121.07820592297;5124.846254612367;5131.281620573122;5135.204043373283;3215.1962009497624;3257.7719559631073;3281.2453135778906;3287.2439338952177;3289.490129030004;5637.492625663628;5717.971410142923;5817.185594016841;5821.126830975388;5825.2135961644635;6304.5586808922935;6362.077498762654;6380.106785050097;6385.48916086712;6406.487481001509;5757.539396848242;5813.76744930198;5821.825345239649;5822.970885145547;5835.503982161564;5989.64062156272;6146.569740118149;6160.537959652955;6162.969185154046;6165.568410211242;6011.428914253139;6018.759249629966;6019.638821670714;6022;6023.578349515492;5813;5824.388439213822;5825.0679891217205;5830.329512106162;5830.650160990354;4166.208420400114;4198.748075115503;4204.474440694913;4213.810378532912;4214.283571792741;6030.396960303934;6157.815265542041;6158.076288556573;6168.907466388097;6173.6913154343;5931.169636250842;5931.258592675916;5934.1988831508925;5936.703164841654;5938.346781854079;5883.470487656132;5907.704614769158;5921.259842519685;5927.347991720821;5929.911051334319;5508.834734957958;5718.628289161191;5756.30924289088;5767.990601644779;5796.971015144897;5904.527637789052;5950.7917222896995;5954.612950158225;5961.672108033927;5964.433378829004;5775.104858746901;5787.971060144672;5811.709414529341;5812.244408227072;5838.678872661874 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.1687102622633;761.8047540975485;767.0526899279389;783.8432313537293;798.4011991006748;11156.832647510284;11435.942820285887;11464.254823436491;11488.138389620792;11493.885061149385;11975.520979160823;12001.039916806656;12016.399180040984;12085.697857553565;12091.697707557316;801.5391150088708;825.78116799048;828.0891019878146;828.6436832162168;830.8753686946945;823.370121856777;828.6975254032265;830.7632324787437;830.9252167304942;830.9792255193609;853.8633818589027;856.2293935458075;862.9309655227598;863.6890719341033;865.8657908024267;858.2061593026425;859.2696208222992;859.3726579596898;860.0195776814375;861.4400639584258;624.7657128576784;627.1470799712388;632.1308201223318;632.3486808587163;634.8539835837737;11273.098152147808;11276.323420594708;11315.377654229014;11323.603673871376;11324.320540767498;11008.229423940327;11165.106791456665;11253.156013299036;11414.828777568344;11427;9317.72046838596;9362.204212641933;9658.517074146335;9776.364536305118;9783.777027871516;3283.9491362763924;3298.224917144469;3299.785513941586;3304.8347582620772;3339.632640409553;37710.81144594287;38676.41985370222;38753.41869871954;38805.611943880765;41212.58787412148;8083.514989100673;8107.878381824277;8244.505329680238;8312.044114926739;8338.207870252316;15252.542423727306;15315.540533784004;15330.846691532943;15369;15400.22998850053;6257.2804127525005;6300.117983482316;6309.558330916791;6408.070829729663;6458.38645328693;3544.964550354515;3594.2092739597247;3647.562292524914;3726.4037753959237;3748.8125593720206;2607.2569317744733;2621.3839747659285;2633.985915422576;2643.9867800660872;2645.6560647116135;483.7653737937098;486.56695540968565;489.8873259150415;490.78160218702334;494.3499298422563;452.86640441069966;455.219298902384;510.1124044163129;540.5459414092181;563.0428271937723;6860.48881355596;7149.714011439484;7246.420286377077;8267.83464330722;8380.8742868857;422.782267132427;483.6662702735102;508.70495112834465;539.7139516056496;543.8178210299594;3283.737301015961;3385.1875549868346;3480.9477857832153;3528.329617372742;3564.9643503564635;50421;53518.46481535213;53744.731276343366;53933.730331348874;53996.190057148386;43766.78116609396;44111.33832992508;44600.10799783986;44686.553134468886;45473;36407;37864.81067594644;38853;44336.909881939086;44584.10831783346;7870.212978702313;8223.506589604644;8305.709300174465;8423.747287581382;8519.446235994641;31482.37035259328;31788.523172152898;31822.204444888135;32307.19232019218;32532.67467325391;36268.410804333296;40913;41042.79478602588;41478.792606036775;41667.58332416637;9448.338616296793;9456.527173641429;9538.093881081286;9546.57040433196;9674.274429417963;10965.90340965897;11179.612012220805;11221.270617409842;11398.316101033965;11584.47869845842;10254.897451025394;10288.948555257175;10324.793504130026;10412.791744164922;10463;10210.897891021292;10256.12822910061;10275.537600808131;10279.126274266471;10295.742606434898;10363;10387.169026477712;10393.9480302598;10409.427481488288;10472.21458390639;9223.677171298972;9309.162175404246;9348.298877584344;9376.203022743142;9470.289728270269;8765.34259930495;9132;9187.862182067141;9224;9255.305852060988 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1449859506734__endTimestamp 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,741 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4687.07 Median:4856.37 stddev:489.90 (10.1%) stddev-sans-first:464.19 10:45:06 INFO - 2015-12-11 10:45:06,742 DEBUG : BROWSER_OUTPUT: Values: 2634.5 2702.9 2733.5 2750.7 2756.6 4553.5 4619.2 4673.1 4684.0 4688.5 4621.1 4633.2 4654.4 4739.3 4747.5 4310.7 4362.9 4457.5 4469.9 4487.0 4162.5 4374.6 4398.8 4433.3 4510.5 4288.4 4294.8 4395.8 4409.3 4430.0 4331.8 4374.7 4395.1 4396.7 4454.6 4183.4 4298.3 4339.1 4369.8 4420.4 4443.4 4513.6 4537.0 4542.0 4544.8 5053.5 5118.6 5120.9 5123.8 5135.5 4932.1 5028.5 5035.2 5153.9 5187.5 4780.4 4788.3 4795.7 4812.5 4856.5 5249.7 5280.9 5292.8 5311.2 5316.5 4845.4 4918.5 4960.4 5053.6 5065.5 5038.0 5092.2 5109.7 5113.3 5152.4 5040.6 5052.3 5055.9 5067.2 5070.7 4742.5 4875.5 4898.1 4965.9 4990.7 4246.0 4269.4 4274.4 4276.7 4308.2 3633.7 3767.7 3801.3 3803.3 3807.1 4312.9 4375.3 4381.0 4415.2 4427.7 5078.2 5162.1 5175.9 5200.2 5209.1 4205.0 4303.4 4440.7 4472.2 4515.2 4448.5 4518.1 4518.4 4554.9 4567.5 4816.5 4849.0 4856.4 4865.5 4898.8 4872.9 4992.5 4992.8 5082.5 5120.5 4783.9 4799.5 4916.3 4918.2 4935.0 5047.1 5059.1 5063.6 5068.9 5100.2 4960.4 5130.8 5135.3 5143.3 5149.3 4858.7 4897.9 4903.9 4944.8 4993.9 4933.2 4942.3 4949.8 4970.6 5026.9 4659.1 4853.2 4861.1 4861.9 4898.7 4859.6 4928.1 4943.7 4950.0 4977.5 4883.8 4898.6 4905.0 4910.9 4920.3 10:45:06 INFO - 2015-12-11 10:45:06,742 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,742 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39446.29 Median:3368.89 stddev:62316.11 (1849.7%) stddev-sans-first:62422.50 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: Values: 555.7 565.7 572.0 572.1 576.0 35614.8 36450.0 36458.3 36495.6 36551.8 40188.0 40884.4 40894.8 40999.2 41020.6 7707.9 7897.7 7900.1 7903.4 7905.8 7678.2 7679.5 7727.8 7740.3 7753.7 7775.1 7903.4 7907.0 7922.9 7935.8 7778.1 7856.3 7857.7 7865.3 7895.2 7765.3 7838.7 7844.9 7851.7 7886.2 36419.3 37133.0 37334.4 37498.0 37543.4 2801.1 2893.2 2937.2 2937.8 2945.8 28344.1 28528.4 28547.0 28598.7 28606.3 3334.2 3360.2 3377.6 3409.5 3459.3 203811.0 203837.0 203882.0 204326.0 204408.0 49851.8 51138.0 60524.6 62638.4 62779.0 54536.0 54883.7 54951.2 55236.2 55325.7 12626.2 12629.9 12713.9 12741.9 12747.6 9871.0 9912.8 9917.6 9937.0 9946.0 19034.6 19212.9 19343.3 19466.6 19467.3 7708.9 7937.0 7945.6 8053.4 8063.3 810.8 816.2 867.4 970.3 1019.3 25326.5 26000.5 26063.1 26182.0 26288.9 902.4 930.9 937.8 938.2 955.5 12692.0 12734.3 14034.6 14037.4 14512.6 260959.0 264808.0 265260.0 265994.0 266314.0 45372.8 45791.8 45863.3 45898.5 46010.0 1140.5 1147.8 1161.7 1162.0 1298.2 26153.2 26183.7 26266.5 26764.6 26903.6 39310.0 39808.4 39856.0 39908.4 40006.4 242846.0 243700.0 244536.0 244794.0 245839.0 27435.3 27820.6 28403.7 28666.3 28687.6 32893.8 33006.7 33186.0 33995.7 34094.7 29091.7 29502.0 29625.7 29847.3 30016.7 28707.7 28892.0 29301.6 31209.7 32047.4 29240.4 29456.1 29665.7 29993.4 30027.2 25618.5 26018.2 27278.5 27606.6 27712.4 23303.8 23366.6 23410.3 23766.4 23767.0 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25643.25 Median:4132.92 stddev:78597.61 (1901.7%) stddev-sans-first:78795.12 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: Values: 335.8 339.1 340.0 340.7 345.0 14710.1 15672.6 16019.3 16613.1 16653.8 9996.6 10099.3 10237.9 10264.9 10293.3 4580.3 4699.1 4699.1 4703.8 4705.2 4698.7 5085.5 5086.7 5088.4 5092.3 5051.0 5055.9 5068.9 5223.5 5236.9 5197.0 5210.0 5216.4 5222.2 5233.7 4996.6 5016.6 5175.7 5220.3 5223.4 11812.3 12017.8 12081.2 17324.7 19315.1 1767.7 1841.3 1845.9 1860.3 1907.4 8967.7 9288.6 9334.7 11692.6 12372.3 1745.9 1762.2 1808.6 1839.8 1890.6 53545.2 54540.2 54547.5 55595.0 57143.4 9822.9 9936.0 9965.9 9975.0 9999.5 12232.5 12328.5 12366.5 12466.2 12486.3 6833.1 6841.1 6870.7 6876.8 6876.8 6448.8 6464.4 6496.6 6507.1 6516.8 4120.5 4145.3 4196.3 4228.9 4241.3 1706.6 1724.6 1733.3 1737.8 1769.5 336.8 338.9 363.6 755.7 945.0 9108.4 9332.5 9581.0 9864.8 9880.6 373.7 384.3 384.9 392.9 399.3 4619.7 5437.8 5442.7 5495.3 5528.9 465295.0 467007.0 483741.0 490622.0 496302.0 70064.0 70761.0 71001.6 71489.6 73688.6 1006.4 1018.4 1021.7 1037.7 1039.7 14430.9 14474.3 14670.2 15022.2 15140.8 29989.0 30543.2 33686.0 33850.3 34376.8 41011.4 42999.0 43233.4 43263.4 45256.3 8721.7 8933.8 8992.3 9204.6 9237.7 15348.9 15610.3 15675.3 15939.4 16524.5 13265.0 13483.0 13490.1 13669.2 13885.2 12566.4 12777.7 12895.9 13219.7 13745.0 13199.7 13747.2 13752.2 13949.3 14146.7 8654.9 8745.2 8835.6 8950.4 9045.7 12974.0 13069.0 13165.0 13238.1 13303.7 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4819.87 Median:6009.18 stddev:2493.69 (41.5%) stddev-sans-first:2487.23 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: Values: 1372.5 1379.9 1396.1 1401.4 1443.1 5622.6 5871.4 6478.0 6862.1 6899.2 6584.8 6632.6 6741.1 6754.8 6771.2 1999.5 2065.4 2065.6 2065.8 2066.6 2055.9 2075.9 2087.4 2124.3 2130.4 1993.6 2009.6 2014.3 2021.5 2026.4 2037.3 2066.5 2069.0 2070.1 2071.5 2089.3 2107.7 2127.9 2128.6 2134.0 6829.6 6998.3 7002.5 7028.5 7048.6 4136.2 4206.5 4227.6 4234.5 4235.0 2719.6 2730.7 2751.4 2787.9 2802.6 852.4 864.3 868.7 881.1 889.5 9291.9 9372.0 9406.0 9436.0 9447.3 3844.6 3852.5 3879.0 3889.3 3905.1 8054.4 8061.9 8071.5 8082.9 8093.3 4147.9 4155.4 4159.4 4161.1 4162.0 3200.2 3298.2 3725.4 3754.9 3770.0 3384.4 3426.3 3429.4 3434.5 3441.6 1083.4 1095.2 1095.9 1104.5 1110.1 985.5 993.1 995.3 997.6 1024.7 6440.3 6509.5 6555.0 6555.9 6576.0 426.9 428.3 429.7 435.1 435.4 5163.5 5184.6 5194.0 5225.0 5242.1 8145.9 8177.7 8248.4 8330.0 8352.7 8163.7 8184.8 8189.7 8191.6 8235.6 6223.7 6267.1 6286.6 6311.7 6317.9 6504.2 6532.2 6551.0 6551.9 6564.9 7240.8 7396.8 7435.6 7440.2 7505.0 7334.3 7486.7 7501.2 7570.9 7585.7 5744.6 6147.3 6222.3 6228.7 6229.1 6444.7 6459.3 6490.0 6530.4 6543.1 5968.4 6034.6 6237.6 6251.4 6296.9 5868.6 6130.2 6151.0 6155.4 6210.5 6277.7 6342.9 6400.5 6404.3 6409.0 5955.5 5958.4 5972.8 5981.4 5983.8 5692.9 5769.8 5841.1 5847.9 5930.9 10:45:06 INFO - 2015-12-11 10:45:06,743 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,744 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4896.03 Median:5454.26 stddev:1439.64 (26.4%) stddev-sans-first:1401.83 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: Values: 304.7 306.6 307.6 310.7 313.1 5491.9 5567.9 5612.7 5638.0 5653.2 5416.6 5534.0 5555.5 5562.3 5578.0 4212.7 4303.2 4339.0 4341.9 4349.9 4311.8 4314.4 4316.0 4317.2 4334.8 4311.3 4320.0 4327.1 4330.0 4333.5 4334.4 4338.3 4340.9 4341.4 4341.5 3664.2 3795.0 3813.8 3824.7 3831.0 5205.1 5294.9 5295.4 5307.3 5315.7 4993.9 4999.5 5004.7 5006.7 5021.1 5911.5 5918.8 5920.9 5932.9 5948.6 4004.2 4093.5 4134.2 4146.2 4149.9 6138.1 6190.0 6195.6 6212.5 6213.9 4234.3 4259.1 4274.1 4278.2 4287.4 4302.6 4333.9 4351.0 4353.5 4359.3 4800.5 4929.3 4930.7 4952.6 4954.6 5906.4 5917.3 5928.1 5928.7 5929.1 1531.1 1547.1 1550.6 1552.0 1553.6 1039.4 1044.7 1051.9 1055.9 1059.1 5121.5 5131.1 5133.5 5133.8 5136.4 6108.6 6115.4 6118.5 6121.4 6121.6 5116.0 5121.1 5124.8 5131.3 5135.2 3215.2 3257.8 3281.2 3287.2 3289.5 5637.5 5718.0 5817.2 5821.1 5825.2 6304.6 6362.1 6380.1 6385.5 6406.5 5757.5 5813.8 5821.8 5823.0 5835.5 5989.6 6146.6 6160.5 6163.0 6165.6 6011.4 6018.8 6019.6 6022.0 6023.6 5813.0 5824.4 5825.1 5830.3 5830.7 4166.2 4198.7 4204.5 4213.8 4214.3 6030.4 6157.8 6158.1 6168.9 6173.7 5931.2 5931.3 5934.2 5936.7 5938.3 5883.5 5907.7 5921.3 5927.3 5929.9 5508.8 5718.6 5756.3 5768.0 5797.0 5904.5 5950.8 5954.6 5961.7 5964.4 5775.1 5788.0 5811.7 5812.2 5838.7 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12229.50 Median:22962.93 stddev:14071.43 (61.3%) stddev-sans-first:14084.54 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: Values: 759.2 761.8 767.1 783.8 798.4 11156.8 11435.9 11464.3 11488.1 11493.9 11975.5 12001.0 12016.4 12085.7 12091.7 801.5 825.8 828.1 828.6 830.9 823.4 828.7 830.8 830.9 831.0 853.9 856.2 862.9 863.7 865.9 858.2 859.3 859.4 860.0 861.4 624.8 627.1 632.1 632.3 634.9 11273.1 11276.3 11315.4 11323.6 11324.3 11008.2 11165.1 11253.2 11414.8 11427.0 9317.7 9362.2 9658.5 9776.4 9783.8 3283.9 3298.2 3299.8 3304.8 3339.6 37710.8 38676.4 38753.4 38805.6 41212.6 8083.5 8107.9 8244.5 8312.0 8338.2 15252.5 15315.5 15330.8 15369.0 15400.2 6257.3 6300.1 6309.6 6408.1 6458.4 3545.0 3594.2 3647.6 3726.4 3748.8 2607.3 2621.4 2634.0 2644.0 2645.7 483.8 486.6 489.9 490.8 494.3 452.9 455.2 510.1 540.5 563.0 6860.5 7149.7 7246.4 8267.8 8380.9 422.8 483.7 508.7 539.7 543.8 3283.7 3385.2 3480.9 3528.3 3565.0 50421.0 53518.5 53744.7 53933.7 53996.2 43766.8 44111.3 44600.1 44686.6 45473.0 36407.0 37864.8 38853.0 44336.9 44584.1 7870.2 8223.5 8305.7 8423.7 8519.4 31482.4 31788.5 31822.2 32307.2 32532.7 36268.4 40913.0 41042.8 41478.8 41667.6 9448.3 9456.5 9538.1 9546.6 9674.3 10965.9 11179.6 11221.3 11398.3 11584.5 10254.9 10288.9 10324.8 10412.8 10463.0 10210.9 10256.1 10275.5 10279.1 10295.7 10363.0 10387.2 10393.9 10409.4 10472.2 9223.7 9309.2 9348.3 9376.2 9470.3 8765.3 9132.0 9187.9 9224.0 9255.3 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:45:06 INFO - 2015-12-11 10:45:06,745 DEBUG : BROWSER_OUTPUT: 10:45:07 INFO - 2015-12-11 10:45:07,465 INFO : Browser exited with error code: 0 10:45:07 INFO - 2015-12-11 10:45:07,487 INFO : Completed test dromaeo_css (00:18:34) 10:45:07 INFO - 2015-12-11 10:45:07,487 INFO : Starting test kraken 10:45:07 INFO - 2015-12-11 10:45:07,487 DEBUG : operating with platform_type : linux_ 10:45:07 INFO - 2015-12-11 10:45:07,487 INFO : Initialising browser for kraken test... 10:45:07 INFO - 2015-12-11 10:45:07,493 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbItTt/profile http://localhost:56613/getInfo.html 10:45:12 INFO - 2015-12-11 10:45:12,792 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:45:12 INFO - 2015-12-11 10:45:12,793 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:45:12 INFO - 2015-12-11 10:45:12,793 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:45:12 INFO - 2015-12-11 10:45:12,793 DEBUG : BROWSER_OUTPUT: __metrics 10:45:12 INFO - 2015-12-11 10:45:12,954 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] 10:45:13 INFO - 2015-12-11 10:45:13,845 INFO : Browser initialized. 10:45:13 INFO - 2015-12-11 10:45:13,846 INFO : Running cycle 1/1 for kraken test... 10:45:13 INFO - 2015-12-11 10:45:13,846 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvbItTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:45:25 INFO - 2015-12-11 10:45:25,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 143212544 10:45:25 INFO - 2015-12-11 10:45:25,886 DEBUG : BROWSER_OUTPUT: 10:45:28 INFO - 2015-12-11 10:45:28,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56613/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:29 INFO - 2015-12-11 10:45:29,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 142880768 10:45:29 INFO - 2015-12-11 10:45:29,105 DEBUG : BROWSER_OUTPUT: 10:45:31 INFO - 2015-12-11 10:45:31,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56613/tests/kraken/driver.html?testName=audio-dft) 10:45:32 INFO - 2015-12-11 10:45:32,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 143474688 10:45:32 INFO - 2015-12-11 10:45:32,491 DEBUG : BROWSER_OUTPUT: 10:45:35 INFO - 2015-12-11 10:45:35,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56613/tests/kraken/driver.html?testName=audio-fft) 10:45:35 INFO - 2015-12-11 10:45:35,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 138330112 10:45:35 INFO - 2015-12-11 10:45:35,986 DEBUG : BROWSER_OUTPUT: 10:45:38 INFO - 2015-12-11 10:45:38,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56613/tests/kraken/driver.html?testName=audio-oscillator) 10:45:38 INFO - 2015-12-11 10:45:38,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 139698176 10:45:38 INFO - 2015-12-11 10:45:38,620 DEBUG : BROWSER_OUTPUT: 10:45:40 INFO - 2015-12-11 10:45:40,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:45:41 INFO - 2015-12-11 10:45:41,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 140816384 10:45:41 INFO - 2015-12-11 10:45:41,485 DEBUG : BROWSER_OUTPUT: 10:45:44 INFO - 2015-12-11 10:45:44,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56613/tests/kraken/driver.html?testName=imaging-darkroom) 10:45:45 INFO - 2015-12-11 10:45:45,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 139542528 10:45:45 INFO - 2015-12-11 10:45:45,168 DEBUG : BROWSER_OUTPUT: 10:45:48 INFO - 2015-12-11 10:45:48,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56613/tests/kraken/driver.html?testName=imaging-desaturate) 10:45:49 INFO - 2015-12-11 10:45:49,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 140836864 10:45:49 INFO - 2015-12-11 10:45:49,211 DEBUG : BROWSER_OUTPUT: 10:45:52 INFO - 2015-12-11 10:45:52,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56613/tests/kraken/driver.html?testName=json-parse-financial) 10:45:52 INFO - 2015-12-11 10:45:52,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 140210176 10:45:52 INFO - 2015-12-11 10:45:52,695 DEBUG : BROWSER_OUTPUT: 10:45:54 INFO - 2015-12-11 10:45:54,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:45:55 INFO - 2015-12-11 10:45:55,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 141377536 10:45:55 INFO - 2015-12-11 10:45:55,066 DEBUG : BROWSER_OUTPUT: 10:45:56 INFO - 2015-12-11 10:45:56,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:45:57 INFO - 2015-12-11 10:45:57,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 142008320 10:45:57 INFO - 2015-12-11 10:45:57,591 DEBUG : BROWSER_OUTPUT: 10:45:59 INFO - 2015-12-11 10:45:59,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:00 INFO - 2015-12-11 10:46:00,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 142364672 10:46:00 INFO - 2015-12-11 10:46:00,382 DEBUG : BROWSER_OUTPUT: 10:46:02 INFO - 2015-12-11 10:46:02,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:03 INFO - 2015-12-11 10:46:03,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 140509184 10:46:03 INFO - 2015-12-11 10:46:03,541 DEBUG : BROWSER_OUTPUT: 10:46:06 INFO - 2015-12-11 10:46:06,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:06 INFO - 2015-12-11 10:46:06,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 141393920 10:46:06 INFO - 2015-12-11 10:46:06,710 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56613/tests/kraken/driver.html?testName=ai-astar) 10:46:08 INFO - 2015-12-11 10:46:08,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 141062144 10:46:08 INFO - 2015-12-11 10:46:08,744 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,747 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:46:08 INFO - 2015-12-11 10:46:08,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:46:08 INFO - 2015-12-11 10:46:08,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:46:08 INFO - 2015-12-11 10:46:08,748 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:46:08 INFO - 2015-12-11 10:46:08,748 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;114;112;114;124;113;113;113;114 10:46:08 INFO - 2015-12-11 10:46:08,748 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;129;149;170;141;169;173;144;170;130 10:46:08 INFO - 2015-12-11 10:46:08,748 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;163;163;164;167;165;163;164;163 10:46:08 INFO - 2015-12-11 10:46:08,748 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;77;73;74;140;73;74;75;74 10:46:08 INFO - 2015-12-11 10:46:08,749 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;139;94;95;95;134;95;95;145 10:46:08 INFO - 2015-12-11 10:46:08,749 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;113;111;110;110;111;110;110;110;110 10:46:08 INFO - 2015-12-11 10:46:08,749 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;147;147;147;147;148;148;149 10:46:08 INFO - 2015-12-11 10:46:08,749 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;95;96;96;96;97;97;95 10:46:08 INFO - 2015-12-11 10:46:08,750 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;76;75;75;73;72;74;73;72 10:46:08 INFO - 2015-12-11 10:46:08,750 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;72;69;69;69;68;71;68;69;69 10:46:08 INFO - 2015-12-11 10:46:08,750 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;86;94;84;86;91;87;93;86;84 10:46:08 INFO - 2015-12-11 10:46:08,750 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;120;121;128;121;130;130;126;130;124 10:46:08 INFO - 2015-12-11 10:46:08,750 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;149;138;150;138;149;154;137;137 10:46:08 INFO - 2015-12-11 10:46:08,751 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;69;72;70;68;71;70;80;69 10:46:08 INFO - 2015-12-11 10:46:08,751 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:46:08 INFO - 2015-12-11 10:46:08,751 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:46:08 INFO - 2015-12-11 10:46:08,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,828 10:46:08 INFO - 2015-12-11 10:46:08,751 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:46:08 INFO - 2015-12-11 10:46:08,752 DEBUG : BROWSER_OUTPUT: __startTimestamp1449859568745__endTimestamp 10:46:08 INFO - 2015-12-11 10:46:08,752 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,755 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:3.83 (3.4%) stddev-sans-first:4.06 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 114.0 112.0 114.0 124.0 113.0 113.0 113.0 114.0 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.40 Median:164.00 stddev:17.04 (10.4%) stddev-sans-first:17.96 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: Values: 159.0 129.0 149.0 170.0 141.0 169.0 173.0 144.0 170.0 130.0 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,756 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.40 (0.9%) stddev-sans-first:1.32 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 163.0 163.0 164.0 167.0 165.0 163.0 164.0 163.0 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:20.95 (28.3%) stddev-sans-first:22.05 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 77.0 73.0 74.0 140.0 73.0 74.0 75.0 74.0 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.58 (22.7%) stddev-sans-first:22.34 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 139.0 94.0 95.0 95.0 134.0 95.0 95.0 145.0 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,757 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 149.0 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 95.0 96.0 96.0 96.0 97.0 97.0 95.0 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,758 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:74.00 stddev:1.43 (1.9%) stddev-sans-first:1.51 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 76.0 75.0 75.0 73.0 72.0 74.0 73.0 72.0 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.32 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 69.0 69.0 69.0 68.0 71.0 68.0 69.0 69.0 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:3.92 (4.4%) stddev-sans-first:3.79 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: Values: 93.0 86.0 94.0 84.0 86.0 91.0 87.0 93.0 86.0 84.0 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,759 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:129.00 stddev:4.19 (3.2%) stddev-sans-first:4.19 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: Values: 130.0 120.0 121.0 128.0 121.0 130.0 130.0 126.0 130.0 124.0 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:148.50 stddev:6.64 (4.5%) stddev-sans-first:6.80 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 149.0 138.0 150.0 138.0 149.0 154.0 137.0 137.0 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:3.38 (4.8%) stddev-sans-first:3.57 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 69.0 72.0 70.0 68.0 71.0 70.0 80.0 69.0 10:46:08 INFO - 2015-12-11 10:46:08,760 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:46:08 INFO - 2015-12-11 10:46:08,761 DEBUG : BROWSER_OUTPUT: 10:46:09 INFO - 2015-12-11 10:46:09,713 INFO : Browser exited with error code: 0 10:46:09 INFO - 2015-12-11 10:46:09,767 INFO : Completed test kraken (00:01:02) 10:46:09 INFO - 2015-12-11 10:46:09,767 INFO : Starting test v8_7 10:46:09 INFO - 2015-12-11 10:46:09,767 DEBUG : operating with platform_type : linux_ 10:46:09 INFO - 2015-12-11 10:46:09,768 INFO : Initialising browser for v8_7 test... 10:46:09 INFO - 2015-12-11 10:46:09,774 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzhB5_T/profile http://localhost:56613/getInfo.html 10:46:15 INFO - 2015-12-11 10:46:15,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:46:15 INFO - 2015-12-11 10:46:15,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:46:15 INFO - 2015-12-11 10:46:15,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:46:15 INFO - 2015-12-11 10:46:15,127 DEBUG : BROWSER_OUTPUT: __metrics 10:46:15 INFO - 2015-12-11 10:46:15,304 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] 10:46:16 INFO - 2015-12-11 10:46:16,281 INFO : Browser initialized. 10:46:16 INFO - 2015-12-11 10:46:16,282 INFO : Running cycle 1/1 for v8_7 test... 10:46:16 INFO - 2015-12-11 10:46:16,282 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzhB5_T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:46:28 INFO - 2015-12-11 10:46:28,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 143896576 10:46:28 INFO - 2015-12-11 10:46:28,336 DEBUG : BROWSER_OUTPUT: 10:46:49 INFO - 2015-12-11 10:46:49,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56613/tests/v8_7/run.html (next: http://localhost:56613/tests/v8_7/run.html) 10:46:50 INFO - 2015-12-11 10:46:50,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 138227712 10:46:50 INFO - 2015-12-11 10:46:50,077 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,079 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:46:50 INFO - 2015-12-11 10:46:50,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:46:50 INFO - 2015-12-11 10:46:50,079 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:46:50 INFO - 2015-12-11 10:46:50,079 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:46:50 INFO - 2015-12-11 10:46:50,079 DEBUG : BROWSER_OUTPUT: |0;Richards;166.88918558077435 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.0481125092524 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1047.1204188481674 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |5;Earley;754.1478129713424 10:46:50 INFO - 2015-12-11 10:46:50,080 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: |7;RegExp;26684.21052631579 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: |8;Splay;726.2164124909223 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: __startTimestamp1449859610078__endTimestamp 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:46:50 INFO - 2015-12-11 10:46:50,081 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: Values: 166.9 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.05 Median:185.05 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: Values: 185.0 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: Values: 277.5 10:46:50 INFO - 2015-12-11 10:46:50,082 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,083 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: Values: 5164.9 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1047.12 Median:1047.12 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: Values: 1047.1 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:754.15 Median:754.15 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: Values: 754.1 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: Values: 12048.2 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: Values: 26684.2 10:46:50 INFO - 2015-12-11 10:46:50,084 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:726.22 Median:726.22 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: Values: 726.2 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:46:50 INFO - 2015-12-11 10:46:50,085 DEBUG : BROWSER_OUTPUT: 10:46:50 INFO - 2015-12-11 10:46:50,985 INFO : Browser exited with error code: 0 10:46:50 INFO - 2015-12-11 10:46:50,997 INFO : Completed test v8_7 (00:00:41) 10:46:51 INFO - 2015-12-11 10:46:51,095 INFO : Completed test suite (00:20:18) 10:46:51 INFO - 2015-12-11 10:46:51,095 DEBUG : Working with test: dromaeo_css 10:46:51 INFO - 2015-12-11 10:46:51,095 DEBUG : Generating results file: dromaeo_css 10:46:51 INFO - 2015-12-11 10:46:51,096 DEBUG : Working with test: kraken 10:46:51 INFO - 2015-12-11 10:46:51,097 DEBUG : Generating results file: kraken 10:46:51 INFO - 2015-12-11 10:46:51,097 INFO : javascript benchmark 10:46:51 INFO - 2015-12-11 10:46:51,097 DEBUG : Working with test: v8_7 10:46:51 INFO - 2015-12-11 10:46:51,097 DEBUG : Generating results file: v8_7 10:46:51 INFO - 2015-12-11 10:46:51,098 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:46:51 INFO - 2015-12-11 10:46:51,154 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:46:51 INFO - 2015-12-11 10:46:51,154 DEBUG : process_Request line: dromaeo_css 6208.46 graph.html#tests=[[72,132,43]] 10:46:51 INFO - 2015-12-11 10:46:51,154 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:46:51 INFO - 2015-12-11 10:46:51,186 DEBUG : process_Request line: kraken 1546.60 graph.html#tests=[[232,132,43]] 10:46:51 INFO - 2015-12-11 10:46:51,186 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:46:51 INFO - 2015-12-11 10:46:51,218 DEBUG : process_Request line: v8_7 20886.84 graph.html#tests=[[230,132,43]] 10:46:51 INFO - 2015-12-11 10:46:51,219 INFO : javascript benchmark 10:46:51 INFO - 2015-12-11 10:46:51,223 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.4599357131783, 2702.905398311057, 2733.5079685656574, 2750.7249275072495, 2756.614074029635, 4553.521880202581, 4619.2147334953015, 4673.065386922616, 4684.039771846772, 4688.53114688531, 4621.098885717278, 4633.1891918914225, 4654.394928659278, 4739.265413860849, 4747.454042785081, 4310.741355518679, 4362.912741745163, 4457.465104187502, 4469.932951005738, 4487.0, 4162.542120366757, 4374.60628543431, 4398.846040388587, 4433.334999750047, 4510.526394728556, 4288.378185163149, 4294.785260736982, 4395.802188901507, 4409.316555933835, 4430.003249268889, 4331.7617531035785, 4374.715643483195, 4395.077033822901, 4396.71421357614, 4454.554544545552, 4183.3515805049965, 4298.290782020963, 4339.067100573392, 4369.80335884886, 4420.40324556184, 4443.42235509385, 4513.616342610882, 4537.0, 4542.02346495505, 4544.818207271705, 5053.469385714484, 5118.61610379223, 5120.92318615221, 5123.795048198068, 5135.537801597837, 4932.112219800434, 5028.547430731252, 5035.244713292998, 5153.871153221162, 5187.455317191679, 4780.426348838162, 4788.329633851264, 4795.736234507136, 4812.494688057774, 4856.490068542823, 5249.685018898802, 5280.9471905281225, 5292.761825717852, 5311.150215965427, 5316.521513063843, 4845.41854977405, 4918.458969513351, 4960.379952505937, 5053.570446512088, 5065.468125846806, 5038.0, 5092.2361645753435, 5109.718965456936, 5113.258577506241, 5152.433232344439, 5040.59675225981, 5052.317937078447, 5055.9494405055475, 5067.1639179535705, 5070.670406423571, 4742.549457801503, 4875.463698993108, 4898.14282500561, 4965.900681986413, 4990.675606085593, 4246.0, 4269.402283680287, 4274.401583778274, 4276.72201306914, 4308.159908817813, 3633.6729694327637, 3767.6797472215167, 3801.2967600993907, 3803.258364618928, 3807.0862992881507, 4312.913741725148, 4375.321825117112, 4381.014271788886, 4415.249407600716, 4427.712198707074, 5078.187490001582, 5162.148245539444, 5175.896482070338, 5200.24596433515, 5209.114450543341, 4205.032842446254, 4303.376010478463, 4440.711353761995, 4472.239719247736, 4515.2324104902245, 4448.488423831236, 4518.1415531049, 4518.4126063612175, 4554.863354099382, 4567.474740404829, 4816.54242846936, 4849.030193961151, 4856.368672072608, 4865.513448655177, 4898.804047838046, 4872.9269060964825, 4992.500749924979, 4992.750362481789, 5082.466341034286, 5120.462351453044, 4783.928241076456, 4799.544043315879, 4916.287138364845, 4918.2376731606655, 4934.963657631937, 5047.091523525801, 5059.139946209079, 5063.594912407072, 5068.873278168076, 5100.158473851773, 4960.379952505937, 5130.769115389891, 5135.2553879687985, 5143.254228136824, 5149.279100925948, 4858.659893807541, 4897.9020419592125, 4903.901921961469, 4944.802207911644, 4993.875153121201, 4933.235348520985, 4942.3080768693135, 4949.752512374439, 4970.602351811919, 5026.874328141826, 4659.138059459011, 4853.174960256694, 4861.149298872612, 4861.854144375674, 4898.657094003528, 4859.586935110555, 4928.088303663833, 4943.678660887031, 4949.97525012387, 4977.4773648767805, 4883.780229889735, 4898.559129678346, 4905.043516514245, 4910.901781964412, 4920.261960705922], "unit": "ms", "name": "dojo.html", "value": 4656.692095086841}, {"lowerIsBetter": false, "replicates": [555.6527170518428, 565.728450343835, 572.0389745228018, 572.1046562130264, 576.0092640658067, 35614.82192589037, 36450.0, 36458.270834583294, 36495.635043649556, 36551.817240913755, 40188.0, 40884.38673419894, 40894.795526022404, 40999.18001639965, 41020.58979410205, 7707.884381734279, 7897.723579674713, 7900.051993760757, 7903.40724445666, 7905.762827115196, 7678.155402905676, 7679.500832445901, 7727.845443091135, 7740.303372696456, 7753.651085701157, 7775.144734079275, 7903.40724445666, 7906.960465197666, 7922.920770792305, 7935.761927142195, 7778.105517865433, 7856.332211762007, 7857.685692572319, 7865.292123708894, 7895.249951254593, 7765.301122898966, 7838.686452541891, 7844.882326765103, 7851.725189618336, 7886.211378862068, 36419.27161456756, 37133.0, 37334.43998340027, 37498.0, 37543.436848447294, 2801.131649188738, 2893.1754449981654, 2937.1775902747263, 2937.7502912252485, 2945.7937944343903, 28344.14967550977, 28528.429431411463, 28547.0, 28598.714012859815, 28606.284842878886, 3334.1664583854035, 3360.1599600099976, 3377.628460869327, 3409.505621684842, 3459.3081383723106, 203811.0, 203837.0, 203882.0, 204325.97837010867, 204408.0, 49851.75074124606, 51138.0, 60524.579016839714, 62638.373616264165, 62779.0, 54536.0, 54883.72558137264, 54951.17573236405, 55236.17145742817, 55325.72337138288, 12626.242425454502, 12629.93685031569, 12713.872861271453, 12741.872581274254, 12747.553835615894, 9871.0, 9912.752181195383, 9917.553710083064, 9937.0, 9946.0, 19034.61930761377, 19212.903935480514, 19343.322983695503, 19466.61066778685, 19467.31864384768, 7708.884366734504, 7936.96003038075, 7945.562994035384, 8053.355731541463, 8063.27430531255, 810.7770363150181, 816.2408959667448, 867.4231635962014, 970.3110791338088, 1019.3068713275044, 25326.493470130496, 26000.479990400465, 26063.08779192719, 26182.0, 26288.8685556571, 902.3638334973828, 930.9487978161267, 937.7983733497331, 938.216589148069, 955.4697143085515, 12692.0, 12734.299613521345, 14034.578962631138, 14037.438502459992, 14512.564623061326, 260959.0, 264808.0, 265260.0, 265994.0, 266314.0, 45372.77313613411, 45791.77104114458, 45863.31205031927, 45898.5410145901, 46010.0, 1140.520981187903, 1147.7819214349247, 1161.6805378520974, 1162.0297051961707, 1298.1626850681446, 26153.215403537924, 26183.73816261813, 26266.4746705061, 26764.59853102244, 26903.596446053718, 39310.0, 39808.40287395634, 39856.0, 39908.401373978835, 40006.39990400204, 242846.0, 243700.0, 244536.0, 244794.0, 245839.0, 27435.31411714723, 27820.582691260053, 28403.721832517174, 28666.283342916595, 28687.569686454302, 32893.835530822194, 33006.669933300356, 33186.0, 33995.66004339925, 34094.65905340915, 29091.7090829089, 29502.0, 29625.703742962294, 29847.253818654706, 30016.699833001392, 28707.712922870505, 28892.0, 29301.560476593295, 31209.687903120677, 32047.35905281928, 29240.41519169562, 29456.11631651054, 29665.703342967157, 29993.400131997674, 30027.249318767204, 25618.462892226526, 26018.219453416426, 27278.454430910875, 27606.585901211096, 27712.44575108527, 23303.76696233016, 23366.64950025785, 23410.338174875404, 23766.405839854142, 23767.0], "unit": "ms", "name": "ext.html", "value": 16408.46267384987}, {"lowerIsBetter": false, "replicates": [335.8270490697293, 339.0743270870523, 340.01056924350144, 340.74444166874844, 344.99827500862494, 14710.117392956417, 15672.608184795386, 16019.279132439038, 16613.08628025458, 16653.833461665396, 9996.60013599457, 10099.29304948654, 10237.897621023787, 10264.897351026488, 10293.279470437072, 4580.267157254832, 4699.107169637758, 4699.107169637775, 4703.835365762199, 4705.176594096037, 4698.671093023489, 5085.5423011928915, 5086.720230387327, 5088.4148322942965, 5092.337996060507, 5050.964552266776, 5055.949440505603, 5068.949310506885, 5223.477652234765, 5236.8690782730355, 5197.038547868638, 5210.036143313499, 5216.374035115791, 5222.190560463135, 5233.65981211222, 4996.600271978233, 5016.573591244749, 5175.663581867204, 5220.29526013987, 5223.425423203445, 11812.291262524275, 12017.819732703929, 12081.214721043105, 17324.740128898076, 19315.130819113172, 1767.7348397740313, 1841.29110292537, 1845.8800177988387, 1860.2930886263268, 1907.4468404162776, 8967.68613098545, 9288.628454861797, 9334.71995840126, 11692.649220523397, 12372.257664540066, 1745.860331173503, 1762.207006846924, 1808.5749848785524, 1839.8252166044203, 1890.602973375579, 53545.1968220477, 54540.18189727157, 54547.45452545463, 55595.0, 57143.42856571464, 9822.901770982342, 9935.950320248352, 9965.85392679851, 9975.0, 9999.450030248407, 12232.510699572096, 12328.50685972569, 12366.505339786489, 12466.189697669804, 12486.250824950532, 6833.145856767904, 6841.076454678654, 6870.725170993204, 6876.828079298058, 6876.828079298058, 6448.838779030561, 6464.418202361716, 6496.610203387718, 6507.089007538948, 6516.837079073061, 4120.526139493936, 4145.316022856256, 4196.349565817303, 4228.873133805991, 4241.27898257297, 1706.5733566608349, 1724.6033412315237, 1733.2806885142525, 1737.7654016707584, 1769.4691592522192, 336.8231678368876, 338.89155470249284, 363.59277609078003, 755.7317152410925, 944.976375590602, 9108.407953483002, 9332.486713230837, 9580.95209523948, 9864.802703945881, 9880.555375008142, 373.7383831318088, 384.3427738567026, 384.8672208088205, 392.931237033518, 399.2693371130824, 4619.745913974696, 5437.809676661298, 5442.727863606804, 5495.340559132929, 5528.889422211533, 465295.0, 467007.0, 483741.0, 490622.0, 496302.0, 70064.0, 70761.0, 71001.64499177471, 71489.6425517869, 73688.63155684188, 1006.4464544500496, 1018.4296793795646, 1021.6883850425543, 1037.6938803053117, 1039.6932904792952, 14430.927845360706, 14474.348654310792, 14670.193139377438, 15022.248887555797, 15140.772888406462, 29989.0, 30543.2364190897, 33686.0, 33850.32299354048, 34376.82811585926, 41011.38482922699, 42999.0, 43233.35149972816, 43263.351049734905, 45256.32115518204, 8721.65113395457, 8933.821323573622, 8992.28061755071, 9204.585793639437, 9237.722868313962, 15348.923255383652, 15610.297536611108, 15675.29461174227, 15939.442119526224, 16524.504264872074, 13265.0, 13483.0, 13490.123141995738, 13669.179849209078, 13885.236312002937, 12566.37168141571, 12777.744445111231, 12895.871041289467, 13219.735605288033, 13745.0, 13199.67000824987, 13747.243901585109, 13752.174869507862, 13949.302534873419, 14146.717065658835, 8654.870176947477, 8745.169208925143, 8835.64657413722, 8950.373473856767, 9045.683401081194, 12974.026947978751, 13069.0, 13165.0, 13238.073334866853, 13303.66740831487], "unit": "ms", "name": "jquery.html", "value": 7639.682940271659}, {"lowerIsBetter": false, "replicates": [1372.526478364964, 1379.8896088312943, 1396.0646366934154, 1401.4114072089722, 1443.0620096936993, 5622.550195984321, 5871.383504732005, 6477.967610161949, 6862.07362006129, 6899.172099348085, 6584.769533066344, 6632.63520506372, 6741.123653924995, 6754.831129221772, 6771.187457505094, 1999.510120020597, 2065.3597384810682, 2065.6281869263526, 2065.7521097468248, 2066.628006958747, 2055.9383218503394, 2075.885826279554, 2087.405089549479, 2124.3095993802, 2130.403487023636, 1993.5614164883702, 2009.6181725472186, 2014.315132854829, 2021.5047313408236, 2026.3515674984012, 2037.2665840297482, 2066.5040390306367, 2069.0, 2070.099506714584, 2071.492484341331, 2089.3314139475374, 2107.6838474228834, 2127.8723276603455, 2128.638131517646, 2133.967990480144, 6829.556078854858, 6998.335158159966, 7002.5098243123, 7028.54314469563, 7048.577085374894, 4136.21411931732, 4206.453161089069, 4227.577242275778, 4234.513031001413, 4235.004773878136, 2719.619253304539, 2730.6586676665415, 2751.4222013377216, 2787.9442411151867, 2802.579613058037, 852.3820230333021, 864.2999170671714, 868.6785889221029, 881.1100788203896, 889.5329951775306, 9291.907080929172, 9371.953140234255, 9406.0, 9435.962044175203, 9447.291453141042, 3844.6347596978244, 3852.5376954765607, 3879.0, 3889.3193691103943, 3905.062784931596, 8054.395920306, 8061.879071813927, 8071.4753541019645, 8082.878756818653, 8093.27160555541, 4147.854825081168, 4155.376693495939, 4159.376093585925, 4161.10536234711, 4162.042730172077, 3200.231944333343, 3298.1589694627714, 3725.4225595032813, 3754.9436758448646, 3769.981150094232, 3384.424647809878, 3426.297608990151, 3429.3998550253605, 3434.4504879219703, 3441.587009558819, 1083.3716444462193, 1095.2278643556274, 1095.895889890459, 1104.4643347976225, 1110.0841805510486, 985.5417230987482, 993.1310103659298, 995.2933417273672, 997.6258902911409, 1024.6669832304383, 6440.291567927524, 6509.479241660656, 6554.9672251639395, 6555.868882622321, 6575.980722987944, 426.9146170765859, 428.3189728331967, 429.68632897984645, 435.1362545347483, 435.44698233244236, 5163.4578369270685, 5184.611154163377, 5194.039102766001, 5225.0, 5242.135047717084, 8145.877811832827, 8177.713780017671, 8248.422610417214, 8330.0, 8352.749417517363, 8163.7142700005215, 8184.836303273901, 8189.672413103528, 8191.631376588068, 8235.629396677165, 6223.657698826518, 6267.091271765659, 6286.591371560834, 6311.715972781236, 6317.905231421532, 6504.219493660791, 6532.150820393318, 6551.0, 6551.934480655133, 6564.868702626016, 7240.818979525554, 7396.778096657109, 7435.591042492715, 7440.218777028334, 7505.0, 7334.266573342623, 7486.7005319786595, 7501.2123727007875, 7570.886436703344, 7585.658645361083, 5744.597878148489, 6147.262328520606, 6222.253329600296, 6228.657423841732, 6229.127922091002, 6444.678840837523, 6459.321771213955, 6489.967550162408, 6530.412262896362, 6543.051257567531, 5968.432998865101, 6034.577579569388, 6237.625742455467, 6251.4061164189325, 6296.874062518816, 5868.61853979507, 6130.233720784902, 6151.0, 6155.446009859134, 6210.534209934363, 6277.717502712298, 6342.936570634234, 6400.519961003037, 6404.327545607831, 6409.038644203407, 5955.493783028491, 5958.404159584007, 5972.820815375546, 5981.3719559445635, 5983.790567330123, 5692.914606280826, 5769.769209231752, 5841.065429531254, 5847.883042339215, 5930.940690593211], "unit": "ms", "name": "mootools.html", "value": 3901.7940134496234}, {"lowerIsBetter": false, "replicates": [304.7303136723999, 306.6182602659689, 307.5601889298304, 310.6567243196268, 313.1482367959151, 5491.945080549193, 5567.944320556793, 5612.747426365813, 5637.9718101409535, 5653.180288858113, 5416.566674666027, 5533.972330138344, 5555.472230138141, 5562.276904002474, 5578.0, 4212.726172798758, 4303.18239534489, 4339.023719663082, 4341.869743907672, 4349.891252718691, 4311.762853043081, 4314.395984562164, 4315.978420107895, 4317.179735850194, 4334.829596009075, 4311.267084595626, 4320.027993701424, 4327.0913108247305, 4329.978350108245, 4333.479982402117, 4334.393184954109, 4338.305871060616, 4340.891477713051, 4341.41390912226, 4341.479022517318, 3664.2305115925687, 3794.9620503794886, 3813.7902415367143, 3824.694024478035, 3830.9808450957844, 5205.115130427798, 5294.947050529522, 5295.364556253236, 5307.2835167252315, 5315.707636080014, 4993.925091123636, 4999.500049995007, 5004.724740139291, 5006.69959802413, 5021.14640511114, 5911.4975227105315, 5918.7928422505, 5920.940790592082, 5932.911006334908, 5948.643081415085, 4004.2191772604356, 4093.488313960755, 4134.1731653669085, 4146.1914926589325, 4149.937750933738, 6138.0792881067755, 6190.0405437157315, 6195.628262304231, 6212.471939885115, 6213.906791398087, 4234.280172370704, 4259.1268789897995, 4274.1451709658195, 4278.165757677285, 4287.421198138211, 4302.569743025672, 4333.891652708645, 4351.0, 4353.477582690098, 4359.258925982591, 4800.4719480857075, 4929.260610908393, 4930.7288099154175, 4952.579030782352, 4954.628402869727, 5906.379830117861, 5917.349091599921, 5928.140419639129, 5928.67392293428, 5929.080992446177, 1531.0966529747502, 1547.0562956596468, 1550.550340401271, 1551.9612009699622, 1553.5572361876812, 1039.449091981251, 1044.6761503933806, 1051.9263651544318, 1055.9208059395423, 1059.0944742245424, 5121.4622464641425, 5131.1277082895995, 5133.486651334837, 5133.768980395891, 5136.357955255593, 6108.633481991006, 6115.449609535074, 6118.510519158456, 6121.387861213843, 6121.602095863755, 5115.974420127875, 5121.07820592297, 5124.846254612367, 5131.281620573122, 5135.204043373283, 3215.1962009497624, 3257.7719559631073, 3281.2453135778906, 3287.2439338952177, 3289.490129030004, 5637.492625663628, 5717.971410142923, 5817.185594016841, 5821.126830975388, 5825.2135961644635, 6304.5586808922935, 6362.077498762654, 6380.106785050097, 6385.48916086712, 6406.487481001509, 5757.539396848242, 5813.76744930198, 5821.825345239649, 5822.970885145547, 5835.503982161564, 5989.64062156272, 6146.569740118149, 6160.537959652955, 6162.969185154046, 6165.568410211242, 6011.428914253139, 6018.759249629966, 6019.638821670714, 6022.0, 6023.578349515492, 5813.0, 5824.388439213822, 5825.0679891217205, 5830.329512106162, 5830.650160990354, 4166.208420400114, 4198.748075115503, 4204.474440694913, 4213.810378532912, 4214.283571792741, 6030.396960303934, 6157.815265542041, 6158.076288556573, 6168.907466388097, 6173.6913154343, 5931.169636250842, 5931.258592675916, 5934.1988831508925, 5936.703164841654, 5938.346781854079, 5883.470487656132, 5907.704614769158, 5921.259842519685, 5927.347991720821, 5929.911051334319, 5508.834734957958, 5718.628289161191, 5756.30924289088, 5767.990601644779, 5796.971015144897, 5904.527637789052, 5950.7917222896995, 5954.612950158225, 5961.672108033927, 5964.433378829004, 5775.104858746901, 5787.971060144672, 5811.709414529341, 5812.244408227072, 5838.678872661874], "unit": "ms", "name": "prototype.html", "value": 4431.893783220335}, {"lowerIsBetter": false, "replicates": [759.1687102622633, 761.8047540975485, 767.0526899279389, 783.8432313537293, 798.4011991006748, 11156.832647510284, 11435.942820285887, 11464.254823436491, 11488.138389620792, 11493.885061149385, 11975.520979160823, 12001.039916806656, 12016.399180040984, 12085.697857553565, 12091.697707557316, 801.5391150088708, 825.78116799048, 828.0891019878146, 828.6436832162168, 830.8753686946945, 823.370121856777, 828.6975254032265, 830.7632324787437, 830.9252167304942, 830.9792255193609, 853.8633818589027, 856.2293935458075, 862.9309655227598, 863.6890719341033, 865.8657908024267, 858.2061593026425, 859.2696208222992, 859.3726579596898, 860.0195776814375, 861.4400639584258, 624.7657128576784, 627.1470799712388, 632.1308201223318, 632.3486808587163, 634.8539835837737, 11273.098152147808, 11276.323420594708, 11315.377654229014, 11323.603673871376, 11324.320540767498, 11008.229423940327, 11165.106791456665, 11253.156013299036, 11414.828777568344, 11427.0, 9317.72046838596, 9362.204212641933, 9658.517074146335, 9776.364536305118, 9783.777027871516, 3283.9491362763924, 3298.224917144469, 3299.785513941586, 3304.8347582620772, 3339.632640409553, 37710.81144594287, 38676.41985370222, 38753.41869871954, 38805.611943880765, 41212.58787412148, 8083.514989100673, 8107.878381824277, 8244.505329680238, 8312.044114926739, 8338.207870252316, 15252.542423727306, 15315.540533784004, 15330.846691532943, 15369.0, 15400.22998850053, 6257.2804127525005, 6300.117983482316, 6309.558330916791, 6408.070829729663, 6458.38645328693, 3544.964550354515, 3594.2092739597247, 3647.562292524914, 3726.4037753959237, 3748.8125593720206, 2607.2569317744733, 2621.3839747659285, 2633.985915422576, 2643.9867800660872, 2645.6560647116135, 483.7653737937098, 486.56695540968565, 489.8873259150415, 490.78160218702334, 494.3499298422563, 452.86640441069966, 455.219298902384, 510.1124044163129, 540.5459414092181, 563.0428271937723, 6860.48881355596, 7149.714011439484, 7246.420286377077, 8267.83464330722, 8380.8742868857, 422.782267132427, 483.6662702735102, 508.70495112834465, 539.7139516056496, 543.8178210299594, 3283.737301015961, 3385.1875549868346, 3480.9477857832153, 3528.329617372742, 3564.9643503564635, 50421.0, 53518.46481535213, 53744.731276343366, 53933.730331348874, 53996.190057148386, 43766.78116609396, 44111.33832992508, 44600.10799783986, 44686.553134468886, 45473.0, 36407.0, 37864.81067594644, 38853.0, 44336.909881939086, 44584.10831783346, 7870.212978702313, 8223.506589604644, 8305.709300174465, 8423.747287581382, 8519.446235994641, 31482.37035259328, 31788.523172152898, 31822.204444888135, 32307.19232019218, 32532.67467325391, 36268.410804333296, 40913.0, 41042.79478602588, 41478.792606036775, 41667.58332416637, 9448.338616296793, 9456.527173641429, 9538.093881081286, 9546.57040433196, 9674.274429417963, 10965.90340965897, 11179.612012220805, 11221.270617409842, 11398.316101033965, 11584.47869845842, 10254.897451025394, 10288.948555257175, 10324.793504130026, 10412.791744164922, 10463.0, 10210.897891021292, 10256.12822910061, 10275.537600808131, 10279.126274266471, 10295.742606434898, 10363.0, 10387.169026477712, 10393.9480302598, 10409.427481488288, 10472.21458390639, 9223.677171298972, 9309.162175404246, 9348.298877584344, 9376.203022743142, 9470.289728270269, 8765.34259930495, 9132.0, 9187.862182067141, 9224.0, 9255.305852060988], "unit": "ms", "name": "yui.html", "value": 5672.6483611174}], "name": "dromaeo_css", "value": 6208.459243622192}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 112.0, 114.0, 124.0, 113.0, 113.0, 113.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 149.0, 170.0, 141.0, 169.0, 173.0, 144.0, 170.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.4}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 163.0, 164.0, 167.0, 165.0, 163.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 77.0, 73.0, 74.0, 140.0, 73.0, 74.0, 75.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 94.0, 95.0, 95.0, 134.0, 95.0, 95.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 76.0, 75.0, 75.0, 73.0, 72.0, 74.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 69.0, 69.0, 69.0, 68.0, 71.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [93.0, 86.0, 94.0, 84.0, 86.0, 91.0, 87.0, 93.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [130.0, 120.0, 121.0, 128.0, 121.0, 130.0, 130.0, 126.0, 130.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 149.0, 138.0, 150.0, 138.0, 149.0, 154.0, 137.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 69.0, 72.0, 70.0, 68.0, 71.0, 70.0, 80.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1546.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [185.0481125092524], "unit": "score", "name": "DeltaBlue", "value": 357.3016719999998}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1047.1204188481674], "unit": "score", "name": "RayTrace", "value": 706.6894950000002}, {"lowerIsBetter": false, "replicates": [754.1478129713424], "unit": "score", "name": "Earley", "value": 883.7299379999995}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [726.2164124909223], "unit": "score", "name": "Splay", "value": 112.21310700000001}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20886.843775896057}]} 10:46:51 INFO - RETURN: dromaeo_css: 6208.46 10:46:51 INFO - RETURN: kraken: 1546.60 10:46:51 INFO - RETURN: v8_7: 20886.84 10:46:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20886.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6208.46"}}} 10:46:51 INFO - Return code: 0 10:46:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:46:51 INFO - # TBPL SUCCESS # 10:46:51 INFO - Running post-action listener: _resource_record_post_action 10:46:51 INFO - Running post-run listener: _resource_record_post_run 10:46:52 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504635392; Read time: 16; Write time: 958544 10:46:52 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231522304; Read time: 0; Write time: 581268 10:46:52 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273108992; Read time: 16; Write time: 376180 10:46:52 INFO - Running post-run listener: _upload_blobber_files 10:46:52 INFO - Blob upload gear active. 10:46:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:46:52 INFO - Copying logs to upload dir... 10:46:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.483508 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-11 10:46:51.554034) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.557875) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009963 build_url: 'https://queue.taskcluster.net/v1/task/1yHKRmvgRgOHI2mncdmk1A/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-11 10:46:51.613514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.614193) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449856907.184517-551256388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.664454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:46:51.664777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:46:51.665107) ========= ========= Total master_lag: 0.28 =========