builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1449971424.09 results: success (0) buildid: 20151212170032 builduid: d2dc4ff36da14cc4b9da867f3455c55d revision: 13ae37c3583715ff87f5ef92e873dcb1d122151c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.094998) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.095461) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.095816) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.135177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.135517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.188718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.189002) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.252779) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.253086) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.253759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.254095) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-12 17:50:24-- 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% 77.9M=0s 2015-12-12 17:50:24 (77.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.461259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.461657) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015497 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:24.512296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-12 17:50:24.512663) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 13ae37c3583715ff87f5ef92e873dcb1d122151c --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 13ae37c3583715ff87f5ef92e873dcb1d122151c --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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-12 17:50:24,883 truncating revision to first 12 chars 2015-12-12 17:50:24,883 Setting DEBUG logging. 2015-12-12 17:50:24,883 attempt 1/10 2015-12-12 17:50:24,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/13ae37c35837?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-12 17:50:25,139 unpacking tar archive at: fx-team-13ae37c35837/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581729 ========= master_lag: 0.89 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-12 17:50:25.987649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:25.987918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:26.084141) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:26.084396) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-12 17:50:26.084807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-12 17:50:26.085088) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:50:26 INFO - MultiFileLogger online at 20151212 17:50:26 in /builds/slave/test 17:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 17:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:50:26 INFO - {'append_to_log': False, 17:50:26 INFO - 'base_work_dir': '/builds/slave/test', 17:50:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:50:26 INFO - 'branch': 'Fx-Team-Non-PGO', 17:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:50:26 INFO - 'config_files': ('talos/linux_config.py',), 17:50:26 INFO - 'default_actions': ('clobber', 17:50:26 INFO - 'read-buildbot-config', 17:50:26 INFO - 'download-and-extract', 17:50:26 INFO - 'populate-webroot', 17:50:26 INFO - 'create-virtualenv', 17:50:26 INFO - 'install', 17:50:26 INFO - 'run-tests'), 17:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:50:26 INFO - 'download_minidump_stackwalk': True, 17:50:26 INFO - 'download_symbols': 'ondemand', 17:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:50:26 INFO - 'installer_path': 'installer.exe', 17:50:26 INFO - 'log_level': 'info', 17:50:26 INFO - 'log_name': 'talos', 17:50:26 INFO - 'log_to_console': True, 17:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:50:26 INFO - 'opt_config_files': (), 17:50:26 INFO - 'pip_index': False, 17:50:26 INFO - 'sps_profile': False, 17:50:26 INFO - 'sps_profile_interval': 0, 17:50:26 INFO - 'suite': 'dromaeojs', 17:50:26 INFO - 'system_bits': '64', 17:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:50:26 INFO - 'title': 'talos-linux64-ix-004', 17:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:50:26 INFO - 'use_talos_json': True, 17:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:50:26 INFO - 'work_dir': 'build'} 17:50:26 INFO - ##### 17:50:26 INFO - ##### Running clobber step. 17:50:26 INFO - ##### 17:50:26 INFO - Running pre-action listener: _resource_record_pre_action 17:50:26 INFO - Running main action method: clobber 17:50:26 INFO - rmtree: /builds/slave/test/build 17:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:27 INFO - Running post-action listener: _resource_record_post_action 17:50:27 INFO - ##### 17:50:27 INFO - ##### Running read-buildbot-config step. 17:50:27 INFO - ##### 17:50:27 INFO - Running pre-action listener: _resource_record_pre_action 17:50:27 INFO - Running main action method: read_buildbot_config 17:50:27 INFO - Using buildbot properties: 17:50:27 INFO - { 17:50:27 INFO - "properties": { 17:50:27 INFO - "buildnumber": 1196, 17:50:27 INFO - "product": "firefox", 17:50:27 INFO - "script_repo_revision": "production", 17:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:50:27 INFO - "repository": "", 17:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:50:27 INFO - "buildid": "20151212170032", 17:50:27 INFO - "slavename": "talos-linux64-ix-004", 17:50:27 INFO - "pgo_build": "False", 17:50:27 INFO - "basedir": "/builds/slave/test", 17:50:27 INFO - "project": "", 17:50:27 INFO - "platform": "ubuntu64_hw", 17:50:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:50:27 INFO - "slavebuilddir": "test", 17:50:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:50:27 INFO - "branch": "fx-team", 17:50:27 INFO - "repo_path": "integration/fx-team", 17:50:27 INFO - "stage_platform": "linux64", 17:50:27 INFO - "builduid": "d2dc4ff36da14cc4b9da867f3455c55d", 17:50:27 INFO - "revision": "13ae37c3583715ff87f5ef92e873dcb1d122151c" 17:50:27 INFO - }, 17:50:27 INFO - "sourcestamp": { 17:50:27 INFO - "repository": "", 17:50:27 INFO - "hasPatch": false, 17:50:27 INFO - "project": "", 17:50:27 INFO - "branch": "fx-team-linux64-talos", 17:50:27 INFO - "changes": [ 17:50:27 INFO - { 17:50:27 INFO - "category": null, 17:50:27 INFO - "files": [ 17:50:27 INFO - { 17:50:27 INFO - "url": null, 17:50:27 INFO - "name": "https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:50:27 INFO - } 17:50:27 INFO - ], 17:50:27 INFO - "repository": "", 17:50:27 INFO - "rev": "13ae37c3583715ff87f5ef92e873dcb1d122151c", 17:50:27 INFO - "who": "philringnalda@gmail.com", 17:50:27 INFO - "when": 1449971318, 17:50:27 INFO - "number": 7355395, 17:50:27 INFO - "comments": "Merge m-c to f-t", 17:50:27 INFO - "project": "", 17:50:27 INFO - "at": "Sat 12 Dec 2015 17:48:38", 17:50:27 INFO - "branch": "fx-team-linux64-talos", 17:50:27 INFO - "revlink": "", 17:50:27 INFO - "properties": [ 17:50:27 INFO - [ 17:50:27 INFO - "buildid", 17:50:27 INFO - "20151212170032", 17:50:27 INFO - "Change" 17:50:27 INFO - ], 17:50:27 INFO - [ 17:50:27 INFO - "builduid", 17:50:27 INFO - "d2dc4ff36da14cc4b9da867f3455c55d", 17:50:27 INFO - "Change" 17:50:27 INFO - ], 17:50:27 INFO - [ 17:50:27 INFO - "pgo_build", 17:50:27 INFO - "False", 17:50:27 INFO - "Change" 17:50:27 INFO - ] 17:50:27 INFO - ], 17:50:27 INFO - "revision": "13ae37c3583715ff87f5ef92e873dcb1d122151c" 17:50:27 INFO - } 17:50:27 INFO - ], 17:50:27 INFO - "revision": "13ae37c3583715ff87f5ef92e873dcb1d122151c" 17:50:27 INFO - } 17:50:27 INFO - } 17:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:50:27 INFO - Running post-action listener: _resource_record_post_action 17:50:27 INFO - ##### 17:50:27 INFO - ##### Running download-and-extract step. 17:50:27 INFO - ##### 17:50:27 INFO - Running pre-action listener: _resource_record_pre_action 17:50:27 INFO - Running main action method: download_and_extract 17:50:27 INFO - mkdir: /builds/slave/test/build/tests 17:50:27 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')]} 17:50:27 INFO - https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/test_packages.json 17:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/test_packages.json 17:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:50:31 INFO - Downloaded 1302 bytes. 17:50:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:50:31 INFO - Using the following test package requirements: 17:50:31 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:50:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'jsshell-linux-x86_64.zip'], 17:50:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:50:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:50:31 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:50:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:50:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:50:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:50: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')]} 17:50:31 INFO - https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:44 INFO - Downloaded 21869834 bytes. 17:50:44 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 17:50:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:44 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 17:50:45 INFO - Return code: 0 17:50:45 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 17:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:45 INFO - https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:46 INFO - Downloaded 21869834 bytes. 17:50:46 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 17:50:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:50:46 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 17:50:47 INFO - Return code: 0 17:50:47 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')]} 17:50:47 INFO - https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:48 INFO - Downloaded 11132038 bytes. 17:50:48 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 17:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:48 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 17:50:49 INFO - Return code: 0 17:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:49 INFO - https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/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 17:50:50 INFO - Downloaded 57738311 bytes. 17:50:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:50:50 INFO - mkdir: /builds/slave/test/properties 17:50:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:50 INFO - Contents: 17:50:50 INFO - build_url:https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:50:50 INFO - Running post-action listener: _resource_record_post_action 17:50:50 INFO - Running post-action listener: set_extra_try_arguments 17:50:50 INFO - ##### 17:50:50 INFO - ##### Running populate-webroot step. 17:50:50 INFO - ##### 17:50:50 INFO - Running pre-action listener: _resource_record_pre_action 17:50:50 INFO - Running main action method: populate_webroot 17:50:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:50:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:50:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:50:50 INFO - '--tppagecycles', 17:50:50 INFO - '7'], 17:50:50 INFO - 'tests': ['tsvgm']}}, 17:50:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:50:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'tests': ['damp', 'tps']}, 17:50:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['damp', 'tps']}, 17:50:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:50:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:50 INFO - 'other': {'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'other_l64': {'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'other_nol64': {'tests': ['a11yr', 17:50:50 INFO - 'ts_paint', 17:50:50 INFO - 'tpaint', 17:50:50 INFO - 'sessionrestore', 17:50:50 INFO - 'sessionrestore_no_auto_restore']}, 17:50:50 INFO - 'svgr': {'tests': ['tsvgx', 17:50:50 INFO - 'tsvgr_opacity', 17:50:50 INFO - 'tart', 17:50:50 INFO - 'tscrollx', 17:50:50 INFO - 'cart']}, 17:50:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['tsvgx', 17:50:50 INFO - 'tsvgr_opacity', 17:50:50 INFO - 'tart', 17:50:50 INFO - 'tscrollx', 17:50:50 INFO - 'cart']}, 17:50:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'tests': ['tp5o']}, 17:50:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'talos_options': ['--e10s'], 17:50:50 INFO - 'tests': ['tp5o']}, 17:50:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'talos_options': ['--xperf_path', 17:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:50 INFO - 'tests': ['tp5n']}, 17:50:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:50 INFO - 'talos_options': ['--e10s', 17:50:50 INFO - '--xperf_path', 17:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:50 INFO - 'tests': ['tp5n']}}, 17:50:50 INFO - 'talos.zip': {'path': '', 17:50:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:50:50 INFO - Running post-action listener: _resource_record_post_action 17:50:50 INFO - ##### 17:50:50 INFO - ##### Running create-virtualenv step. 17:50:50 INFO - ##### 17:50:50 INFO - Running pre-action listener: _resource_record_pre_action 17:50:50 INFO - Running main action method: create_virtualenv 17:50:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:50 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 17:50:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:50 INFO - Using real prefix '/usr' 17:50:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:52 INFO - Installing pip.................done. 17:50:52 INFO - Return code: 0 17:50:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50: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')]} 17:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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')]} 17:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:50:52 INFO - Using env: {'DISPLAY': ':0', 17:50:52 INFO - 'HOME': '/home/cltbld', 17:50:52 INFO - 'LANG': 'en_US.UTF-8', 17:50:52 INFO - 'LANGUAGE': 'en_US:en', 17:50:52 INFO - 'LOGNAME': 'cltbld', 17:50:52 INFO - 'MAIL': '/var/mail/cltbld', 17:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:52 INFO - 'MOZ_NO_REMOTE': '1', 17:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:52 INFO - 'NO_EM_RESTART': '1', 17:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:52 INFO - 'PWD': '/builds/slave/test', 17:50:52 INFO - 'SHELL': '/bin/bash', 17:50:52 INFO - 'SHLVL': '1', 17:50:52 INFO - 'TERM': 'linux', 17:50:52 INFO - 'TMOUT': '86400', 17:50:52 INFO - 'USER': 'cltbld', 17:50:52 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:52 INFO - '_': '/tools/buildbot/bin/python'} 17:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:53 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 17:50:53 INFO - Cleaning up... 17:50:53 INFO - Return code: 0 17:50:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:50:53 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 17:50:53 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 17:50:53 INFO - Using env: {'DISPLAY': ':0', 17:50:53 INFO - 'HOME': '/home/cltbld', 17:50:53 INFO - 'LANG': 'en_US.UTF-8', 17:50:53 INFO - 'LANGUAGE': 'en_US:en', 17:50:53 INFO - 'LOGNAME': 'cltbld', 17:50:53 INFO - 'MAIL': '/var/mail/cltbld', 17:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:53 INFO - 'MOZ_NO_REMOTE': '1', 17:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:53 INFO - 'NO_EM_RESTART': '1', 17:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:53 INFO - 'PWD': '/builds/slave/test', 17:50:53 INFO - 'SHELL': '/bin/bash', 17:50:53 INFO - 'SHLVL': '1', 17:50:53 INFO - 'TERM': 'linux', 17:50:53 INFO - 'TMOUT': '86400', 17:50:53 INFO - 'USER': 'cltbld', 17:50:53 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:53 INFO - '_': '/tools/buildbot/bin/python'} 17:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:53 INFO - Downloading/unpacking psutil>=0.7.1 17:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:50:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:55 INFO - Installing collected packages: psutil 17:50:55 INFO - Running setup.py install for psutil 17:50:55 INFO - building 'psutil._psutil_linux' extension 17:50:55 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 17:50:55 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 17:50:55 INFO - building 'psutil._psutil_posix' extension 17:50:55 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 17:50:55 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 17:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:55 INFO - Successfully installed psutil 17:50:55 INFO - Cleaning up... 17:50:55 INFO - Return code: 0 17:50:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:50:55 INFO - Using env: {'DISPLAY': ':0', 17:50:55 INFO - 'HOME': '/home/cltbld', 17:50:55 INFO - 'LANG': 'en_US.UTF-8', 17:50:55 INFO - 'LANGUAGE': 'en_US:en', 17:50:55 INFO - 'LOGNAME': 'cltbld', 17:50:55 INFO - 'MAIL': '/var/mail/cltbld', 17:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:55 INFO - 'MOZ_NO_REMOTE': '1', 17:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:55 INFO - 'NO_EM_RESTART': '1', 17:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:55 INFO - 'PWD': '/builds/slave/test', 17:50:55 INFO - 'SHELL': '/bin/bash', 17:50:55 INFO - 'SHLVL': '1', 17:50:55 INFO - 'TERM': 'linux', 17:50:55 INFO - 'TMOUT': '86400', 17:50:55 INFO - 'USER': 'cltbld', 17:50:55 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:55 INFO - '_': '/tools/buildbot/bin/python'} 17:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:50:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:50:57 INFO - Installing collected packages: mozsystemmonitor 17:50:57 INFO - Running setup.py install for mozsystemmonitor 17:50:57 INFO - Successfully installed mozsystemmonitor 17:50:57 INFO - Cleaning up... 17:50:57 INFO - Return code: 0 17:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:50:57 INFO - Using env: {'DISPLAY': ':0', 17:50:57 INFO - 'HOME': '/home/cltbld', 17:50:57 INFO - 'LANG': 'en_US.UTF-8', 17:50:57 INFO - 'LANGUAGE': 'en_US:en', 17:50:57 INFO - 'LOGNAME': 'cltbld', 17:50:57 INFO - 'MAIL': '/var/mail/cltbld', 17:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:57 INFO - 'MOZ_NO_REMOTE': '1', 17:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:57 INFO - 'NO_EM_RESTART': '1', 17:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:57 INFO - 'PWD': '/builds/slave/test', 17:50:57 INFO - 'SHELL': '/bin/bash', 17:50:57 INFO - 'SHLVL': '1', 17:50:57 INFO - 'TERM': 'linux', 17:50:57 INFO - 'TMOUT': '86400', 17:50:57 INFO - 'USER': 'cltbld', 17:50:57 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:57 INFO - '_': '/tools/buildbot/bin/python'} 17:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:57 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50: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 17:50: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 17:50: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 17:50: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 17:50: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 17:50: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 17:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:00 INFO - Downloading docopt-0.6.1.tar.gz 17:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:00 INFO - Running setup.py install for blobuploader 17:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:00 INFO - Running setup.py install for requests 17:51:00 INFO - Running setup.py install for docopt 17:51:00 INFO - Successfully installed blobuploader requests docopt 17:51:00 INFO - Cleaning up... 17:51:00 INFO - Return code: 0 17:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:00 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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:51:00 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 17:51:00 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 17:51:00 INFO - Using env: {'DISPLAY': ':0', 17:51:00 INFO - 'HOME': '/home/cltbld', 17:51:00 INFO - 'LANG': 'en_US.UTF-8', 17:51:00 INFO - 'LANGUAGE': 'en_US:en', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MAIL': '/var/mail/cltbld', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SHLVL': '1', 17:51:00 INFO - 'TERM': 'linux', 17:51:00 INFO - 'TMOUT': '86400', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - '_': '/tools/buildbot/bin/python'} 17:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:01 INFO - Running setup.py (path:/tmp/pip-AEQzzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:01 INFO - Running setup.py (path:/tmp/pip-jCkNis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:01 INFO - Running setup.py (path:/tmp/pip-G3_NRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:01 INFO - Running setup.py (path:/tmp/pip-kRLQxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:01 INFO - Running setup.py (path:/tmp/pip-6VZzLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:01 INFO - Running setup.py (path:/tmp/pip-gkgxO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:01 INFO - Running setup.py (path:/tmp/pip-MPZmje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:01 INFO - Running setup.py (path:/tmp/pip-G0UDch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:01 INFO - Running setup.py (path:/tmp/pip-PgjVBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:01 INFO - Running setup.py (path:/tmp/pip-S0X4mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:01 INFO - Running setup.py (path:/tmp/pip-PLkJ94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:01 INFO - Running setup.py (path:/tmp/pip-em0Y7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:02 INFO - Running setup.py (path:/tmp/pip-rLZRsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:02 INFO - Running setup.py (path:/tmp/pip-3FNiI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:02 INFO - Running setup.py (path:/tmp/pip-zEtxKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:02 INFO - Running setup.py (path:/tmp/pip-FYrQE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:02 INFO - Running setup.py (path:/tmp/pip-pQYd02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:02 INFO - Running setup.py install for manifestparser 17:51:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:02 INFO - Running setup.py install for mozcrash 17:51:02 INFO - Running setup.py install for mozdebug 17:51:02 INFO - Running setup.py install for mozdevice 17:51:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:51:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:02 INFO - Running setup.py install for mozfile 17:51:02 INFO - Running setup.py install for mozhttpd 17:51:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozinfo 17:51:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozInstall 17:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozleak 17:51:03 INFO - Running setup.py install for mozlog 17:51:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for moznetwork 17:51:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozprocess 17:51:03 INFO - Running setup.py install for mozprofile 17:51:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozrunner 17:51:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:03 INFO - Running setup.py install for mozscreenshot 17:51:03 INFO - Running setup.py install for moztest 17:51:04 INFO - Running setup.py install for mozversion 17:51:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:04 INFO - Cleaning up... 17:51:04 INFO - Return code: 0 17:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:51:04 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 17:51:04 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 17:51:04 INFO - Using env: {'DISPLAY': ':0', 17:51:04 INFO - 'HOME': '/home/cltbld', 17:51:04 INFO - 'LANG': 'en_US.UTF-8', 17:51:04 INFO - 'LANGUAGE': 'en_US:en', 17:51:04 INFO - 'LOGNAME': 'cltbld', 17:51:04 INFO - 'MAIL': '/var/mail/cltbld', 17:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:04 INFO - 'MOZ_NO_REMOTE': '1', 17:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:04 INFO - 'NO_EM_RESTART': '1', 17:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:04 INFO - 'PWD': '/builds/slave/test', 17:51:04 INFO - 'SHELL': '/bin/bash', 17:51:04 INFO - 'SHLVL': '1', 17:51:04 INFO - 'TERM': 'linux', 17:51:04 INFO - 'TMOUT': '86400', 17:51:04 INFO - 'USER': 'cltbld', 17:51:04 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:04 INFO - '_': '/tools/buildbot/bin/python'} 17:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:04 INFO - Running setup.py (path:/tmp/pip-_fMu5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:04 INFO - Running setup.py (path:/tmp/pip-vW3qd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:04 INFO - Running setup.py (path:/tmp/pip-AC5ibb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:04 INFO - Running setup.py (path:/tmp/pip-CondmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:04 INFO - Running setup.py (path:/tmp/pip-ymyd6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 INFO - Running setup.py (path:/tmp/pip-mjc3QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:04 INFO - Running setup.py (path:/tmp/pip-eDc9E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:04 INFO - Running setup.py (path:/tmp/pip-tIci76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:04 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)) 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:04 INFO - Running setup.py (path:/tmp/pip-WdnDAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:05 INFO - Running setup.py (path:/tmp/pip-smOvDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:05 INFO - Running setup.py (path:/tmp/pip-pfB50a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:05 INFO - Running setup.py (path:/tmp/pip-tYfV6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:05 INFO - Running setup.py (path:/tmp/pip-Jmw3Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:05 INFO - Running setup.py (path:/tmp/pip-ubSlvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 INFO - Running setup.py (path:/tmp/pip-eoJLu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:05 INFO - Running setup.py (path:/tmp/pip-_KpsPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:05 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)) 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:05 INFO - Running setup.py (path:/tmp/pip-JPKFLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:05 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)) 17:51:05 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)) 17:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:51:05 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)) 17:51:05 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)) 17:51:05 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)) 17:51:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:07 INFO - Downloading blessings-1.5.1.tar.gz 17:51:07 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 17:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:07 INFO - Installing collected packages: blessings 17:51:07 INFO - Running setup.py install for blessings 17:51:07 INFO - Successfully installed blessings 17:51:07 INFO - Cleaning up... 17:51:07 INFO - Return code: 0 17:51:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:07 INFO - Reading from file tmpfile_stdout 17:51:07 INFO - Current package versions: 17:51:07 INFO - argparse == 1.2.1 17:51:07 INFO - blessings == 1.5.1 17:51:07 INFO - blobuploader == 1.2.4 17:51:07 INFO - docopt == 0.6.1 17:51:07 INFO - manifestparser == 1.1 17:51:07 INFO - mozInstall == 1.12 17:51:07 INFO - mozcrash == 0.16 17:51:07 INFO - mozdebug == 0.1 17:51:07 INFO - mozdevice == 0.47 17:51:07 INFO - mozfile == 1.2 17:51:07 INFO - mozhttpd == 0.7 17:51:07 INFO - mozinfo == 0.9 17:51:07 INFO - mozleak == 0.1 17:51:07 INFO - mozlog == 3.1 17:51:07 INFO - moznetwork == 0.27 17:51:07 INFO - mozprocess == 0.22 17:51:07 INFO - mozprofile == 0.27 17:51:07 INFO - mozrunner == 6.11 17:51:07 INFO - mozscreenshot == 0.1 17:51:07 INFO - mozsystemmonitor == 0.0 17:51:07 INFO - moztest == 0.7 17:51:07 INFO - mozversion == 1.4 17:51:07 INFO - psutil == 3.1.1 17:51:07 INFO - requests == 1.2.3 17:51:07 INFO - wsgiref == 0.1.2 17:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 17:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 17:51:07 INFO - Using env: {'DISPLAY': ':0', 17:51:07 INFO - 'HOME': '/home/cltbld', 17:51:07 INFO - 'LANG': 'en_US.UTF-8', 17:51:07 INFO - 'LANGUAGE': 'en_US:en', 17:51:07 INFO - 'LOGNAME': 'cltbld', 17:51:07 INFO - 'MAIL': '/var/mail/cltbld', 17:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:07 INFO - 'MOZ_NO_REMOTE': '1', 17:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:07 INFO - 'NO_EM_RESTART': '1', 17:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:07 INFO - 'PWD': '/builds/slave/test', 17:51:07 INFO - 'SHELL': '/bin/bash', 17:51:07 INFO - 'SHLVL': '1', 17:51:07 INFO - 'TERM': 'linux', 17:51:07 INFO - 'TMOUT': '86400', 17:51:07 INFO - 'USER': 'cltbld', 17:51:07 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:07 INFO - '_': '/tools/buildbot/bin/python'} 17:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 INFO - Cleaning up... 17:51:07 INFO - Return code: 0 17:51:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:51:07 INFO - Using env: {'DISPLAY': ':0', 17:51:07 INFO - 'HOME': '/home/cltbld', 17:51:07 INFO - 'LANG': 'en_US.UTF-8', 17:51:07 INFO - 'LANGUAGE': 'en_US:en', 17:51:07 INFO - 'LOGNAME': 'cltbld', 17:51:07 INFO - 'MAIL': '/var/mail/cltbld', 17:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:07 INFO - 'MOZ_NO_REMOTE': '1', 17:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:07 INFO - 'NO_EM_RESTART': '1', 17:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:07 INFO - 'PWD': '/builds/slave/test', 17:51:07 INFO - 'SHELL': '/bin/bash', 17:51:07 INFO - 'SHLVL': '1', 17:51:07 INFO - 'TERM': 'linux', 17:51:07 INFO - 'TMOUT': '86400', 17:51:07 INFO - 'USER': 'cltbld', 17:51:07 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:07 INFO - '_': '/tools/buildbot/bin/python'} 17:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:08 INFO - Downloading/unpacking jsonschema 17:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:51:09 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 17:51:09 INFO - Downloading/unpacking functools32 (from jsonschema) 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:10 INFO - warning: no files found matching '*.txt' 17:51:10 INFO - no previously-included directories found matching 'build' 17:51:10 INFO - no previously-included directories found matching 'dist' 17:51:10 INFO - no previously-included directories found matching '.git*' 17:51:10 INFO - Installing collected packages: jsonschema, functools32 17:51:10 INFO - Running setup.py install for functools32 17:51:10 INFO - warning: no files found matching '*.txt' 17:51:10 INFO - no previously-included directories found matching 'build' 17:51:10 INFO - no previously-included directories found matching 'dist' 17:51:10 INFO - no previously-included directories found matching '.git*' 17:51:10 INFO - Successfully installed jsonschema functools32 17:51:10 INFO - Cleaning up... 17:51:10 INFO - Return code: 0 17:51:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9b9f805f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d32240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', '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 17:51:10 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 17:51:10 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 17:51:10 INFO - Using env: {'DISPLAY': ':0', 17:51:10 INFO - 'HOME': '/home/cltbld', 17:51:10 INFO - 'LANG': 'en_US.UTF-8', 17:51:10 INFO - 'LANGUAGE': 'en_US:en', 17:51:10 INFO - 'LOGNAME': 'cltbld', 17:51:10 INFO - 'MAIL': '/var/mail/cltbld', 17:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:10 INFO - 'MOZ_NO_REMOTE': '1', 17:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:10 INFO - 'NO_EM_RESTART': '1', 17:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:10 INFO - 'PWD': '/builds/slave/test', 17:51:10 INFO - 'SHELL': '/bin/bash', 17:51:10 INFO - 'SHLVL': '1', 17:51:10 INFO - 'TERM': 'linux', 17:51:10 INFO - 'TMOUT': '86400', 17:51:10 INFO - 'USER': 'cltbld', 17:51:10 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:10 INFO - '_': '/tools/buildbot/bin/python'} 17:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:10 INFO - Downloading/unpacking flake8 17:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:51:12 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 17:51:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:51:12 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 17:51:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 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 17:51:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:51:12 INFO - no previously-included directories found matching 'docs/_build' 17:51:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:51:12 INFO - Running setup.py install for pep8 17:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:51:12 INFO - no previously-included directories found matching 'docs/_build' 17:51:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:51:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:51:13 INFO - Cleaning up... 17:51:13 INFO - Return code: 0 17:51:13 INFO - Running post-action listener: _resource_record_post_action 17:51:13 INFO - Running post-action listener: _start_resource_monitoring 17:51:13 INFO - Starting resource monitoring. 17:51:13 INFO - ##### 17:51:13 INFO - ##### Running install step. 17:51:13 INFO - ##### 17:51:13 INFO - Running pre-action listener: _resource_record_pre_action 17:51:13 INFO - Running main action method: install 17:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:13 INFO - Reading from file tmpfile_stdout 17:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:13 INFO - Reading from file tmpfile_stdout 17:51:13 INFO - Output received: 17:51:13 INFO - Usage: mozinstall [options] installer 17:51:13 INFO - Options: 17:51:13 INFO - -h, --help show this help message and exit 17:51:13 INFO - -d DEST, --destination=DEST 17:51:13 INFO - Directory to install application into. [default: 17:51:13 INFO - "/builds/slave/test"] 17:51:13 INFO - --app=APP Application being installed. [default: firefox] 17:51:13 INFO - mkdir: /builds/slave/test/build/application 17:51:13 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'] 17:51:13 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 17:51:27 INFO - Reading from file tmpfile_stdout 17:51:27 INFO - Output received: 17:51:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:51:27 INFO - Running post-action listener: _resource_record_post_action 17:51:27 INFO - ##### 17:51:27 INFO - ##### Running run-tests step. 17:51:27 INFO - ##### 17:51:27 INFO - Running pre-action listener: _resource_record_pre_action 17:51:27 INFO - Running main action method: run_tests 17:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:27 INFO - Python 2.7.3 17:51:27 INFO - Return code: 0 17:51:27 INFO - grabbing minidump binary from tooltool 17:51:27 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')]} 17:51:27 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 0x1dc10b0>, '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 0x1dc1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:27 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 17:51:27 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 17:51:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:27 INFO - Return code: 0 17:51:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:51:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:51:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:51:28 INFO - Return code: 0 17:51:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test/build 17:51:28 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 17:51:28 INFO - Using env: {'DISPLAY': ':0', 17:51:28 INFO - 'HOME': '/home/cltbld', 17:51:28 INFO - 'LANG': 'en_US.UTF-8', 17:51:28 INFO - 'LANGUAGE': 'en_US:en', 17:51:28 INFO - 'LOGNAME': 'cltbld', 17:51:28 INFO - 'MAIL': '/var/mail/cltbld', 17:51:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:28 INFO - 'MOZ_NO_REMOTE': '1', 17:51:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:28 INFO - 'NO_EM_RESTART': '1', 17:51:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:28 INFO - 'PWD': '/builds/slave/test', 17:51:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:28 INFO - 'SHELL': '/bin/bash', 17:51:28 INFO - 'SHLVL': '1', 17:51:28 INFO - 'TERM': 'linux', 17:51:28 INFO - 'TMOUT': '86400', 17:51:28 INFO - 'USER': 'cltbld', 17:51:28 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222', 17:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:28 INFO - '_': '/tools/buildbot/bin/python'} 17:51:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 17:51:29 INFO - mozversion INFO | application_buildid: 20151212170032 17:51:29 INFO - mozversion INFO | application_changeset: 13ae37c3583715ff87f5ef92e873dcb1d122151c 17:51:29 INFO - mozversion INFO | application_display_name: Nightly 17:51:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:29 INFO - mozversion INFO | application_name: Firefox 17:51:29 INFO - mozversion INFO | application_remotingname: firefox 17:51:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:51:29 INFO - mozversion INFO | application_vendor: Mozilla 17:51:29 INFO - mozversion INFO | application_version: 45.0a1 17:51:29 INFO - mozversion INFO | platform_buildid: 20151212170032 17:51:29 INFO - mozversion INFO | platform_changeset: 13ae37c3583715ff87f5ef92e873dcb1d122151c 17:51:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:51:29 INFO - mozversion INFO | platform_version: 45.0a1 17:51:29 INFO - 2015-12-12 17:51:29,111 DEBUG : using testdate: 1449971489 17:51:29 INFO - 2015-12-12 17:51:29,111 DEBUG : actual date: 1449971489 17:51:29 INFO - 2015-12-12 17:51:29,184 INFO : starting webserver on 'localhost:59625' 17:51:29 INFO - 2015-12-12 17:51:29,185 INFO : Starting test suite talos-linux64-ix-004 17:51:29 INFO - 2015-12-12 17:51:29,185 INFO : Starting test dromaeo_css 17:51:29 INFO - 2015-12-12 17:51:29,185 DEBUG : operating with platform_type : linux_ 17:51:29 INFO - 2015-12-12 17:51:29,186 INFO : Initialising browser for dromaeo_css test... 17:51:29 INFO - 2015-12-12 17:51:29,197 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoVOleu/profile http://localhost:59625/getInfo.html 17:51:33 INFO - 2015-12-12 17:51:33,321 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:51:33 INFO - 2015-12-12 17:51:33,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:51:33 INFO - 2015-12-12 17:51:33,323 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:51:33 INFO - 2015-12-12 17:51:33,323 DEBUG : BROWSER_OUTPUT: __metrics 17:51:33 INFO - 2015-12-12 17:51:33,499 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] 17:51:33 INFO - 2015-12-12 17:51:33,563 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:51:34 INFO - 2015-12-12 17:51:34,716 INFO : Browser initialized. 17:51:34 INFO - 2015-12-12 17:51:34,717 INFO : Running cycle 1/1 for dromaeo_css test... 17:51:34 INFO - 2015-12-12 17:51:34,717 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoVOleu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:51:46 INFO - 2015-12-12 17:51:46,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 17:51:46 INFO - 2015-12-12 17:51:46,759 DEBUG : BROWSER_OUTPUT: 17:52:37 INFO - 2015-12-12 17:52:37,873 DEBUG : BROWSER_OUTPUT: 1449971557870 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] 17:54:50 INFO - 2015-12-12 17:54:50,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59625/tests/dromaeo/cssquery-ext.html) 17:54:51 INFO - 2015-12-12 17:54:51,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 254046208 17:54:51 INFO - 2015-12-12 17:54:51,361 DEBUG : BROWSER_OUTPUT: 17:57:53 INFO - 2015-12-12 17:57:53,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-ext.html (next: http://localhost:59625/tests/dromaeo/cssquery-jquery.html) 17:57:54 INFO - 2015-12-12 17:57:54,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 219545600 17:57:54 INFO - 2015-12-12 17:57:54,452 DEBUG : BROWSER_OUTPUT: 18:00:56 INFO - 2015-12-12 18:00:56,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59625/tests/dromaeo/cssquery-mootools.html) 18:00:57 INFO - 2015-12-12 18:00:57,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 220000256 18:00:57 INFO - 2015-12-12 18:00:57,134 DEBUG : BROWSER_OUTPUT: 18:03:59 INFO - 2015-12-12 18:03:59,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59625/tests/dromaeo/cssquery-prototype.html) 18:03:59 INFO - 2015-12-12 18:03:59,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 201293824 18:03:59 INFO - 2015-12-12 18:03:59,591 DEBUG : BROWSER_OUTPUT: 18:07:02 INFO - 2015-12-12 18:07:02,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59625/tests/dromaeo/cssquery-yui.html) 18:07:03 INFO - 2015-12-12 18:07:03,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 192983040 18:07:03 INFO - 2015-12-12 18:07:03,037 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/dromaeo/cssquery-yui.html (next: http://localhost:59625/tests/dromaeo/cssquery-dojo.html) 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 250023936 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:10:05 INFO - 2015-12-12 18:10:05,710 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:10:05 INFO - 2015-12-12 18:10:05,713 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.354583127134;2709.2007857681983;2726.8500232487204;2747.9450410991794;2754.6418965534476;4505;4634.443866735988;4680.4149481314835;4748.6913350632185;4755.215389460739;4639.048994956034;4644.024754801496;4748.6913350632185;4752.144613969484;4753.049390121981;4303.827846886129;4324.54592267812;4326.870193894172;4372.890677733066;4385.386045953554;4351.673624478161;4480.8879778005485;4485.439320084989;4486.887827804315;4491.708038977472;4193.475815523059;4309.310510318334;4320.24395730749;4437.5340589237985;4480.5967462928165;4347.956520434786;4371.103923695635;4371.825126994916;4373.934390984138;4378.868633940987;4264.296391095466;4314.7411155330465;4337.522872484024;4362.36745671879;4373.059792144672;4634.467036290836;4648.74431906245;4656.092062047902;4656.5343465653505;4687.484376718558;4824.324594556765;5074.314967479417;5118.897622047575;5161.200013997799;5164.741762911839;4943.431505376856;4951.009798040406;4963.826266080706;4964.404271487409;4992.101421744084;4735.550122738335;4736.289556566542;4736.573708366263;4737.502562230916;4786.928196077061;5185.559227465707;5223.869403264873;5226.085435048852;5234.162533994619;5235.816746413857;4808.9519104808505;4810.326554282403;4940.382452193476;4950.356453661073;5004.274380214922;5129.051125541787;5129.9230511542355;5132.024915266087;5136.614753893398;5137.0753264412015;5064.594832413398;5070.492950704974;5076.213186956028;5076.44159142494;5086.949130508721;4798.760061996956;4838.637102217277;4934.259861020875;4936.481669424658;5028.195488721787;4218.346156345771;4222.7888605570215;4226.894327641833;4229.238737027303;4262.786860657016;3702.0929872181487;3713.1088538751046;3717.2565486902727;3744.5506539215467;3748.2316125194816;4128.504579450485;4230.936535951963;4233.915321693549;4237.512686041145;4388.451443569554;5048.495150484922;5077;5086.4659210783075;5103.183490641553;5152.330197074356;4346.891327716832;4353.673474489426;4358.782060896942;4390.495093064274;4392.3191905254735;4274.465691788527;4383.49589797171;4388.648908087409;4490.887727806766;4495.595396414338;4734.644901632391;4822.156122678587;4837.395325584302;4840.491748366371;4877.024595080998;5026.623003274842;5130.333056702605;5133.768980395966;5135.409427915837;5136.280920671034;4606.470255920612;4716.245400735866;4730.101280756783;4852.417709874838;4874.683145595525;4923.793670550738;4930.556249937523;4935.111679897509;4939.876503087452;4940.530649588283;5101.846944591668;5133.845984620468;5135.845924622267;5145.536901678867;5156.922646160236;4969.503049695001;4983.9501604984935;4988.176950803077;4991.450940396626;5034.169362055366;4697.600703940203;4813.350197723263;4820.060088282751;4979.452260251442;4996.300517927566;4755.548222918817;4828.468868424541;4828.855134345975;4846.442659094249;4891.584215341736;4968.677035992793;4978.47725988766;4991.775370108427;4991.975040124921;5032.647714659939;4618.445786505641;4735.147673418817;4835.540623640749;4863.781129849236;4930.211166213532 18:10:05 INFO - 2015-12-12 18:10:05,715 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.515304526135;572.8396049106249;580.3268208877702;581.1428143488353;590.365357240966;25060.49879002419;25437.872810635945;25515.489690206206;35609.64390356096;36411.817940910325;39680.404793928115;39817.60182398175;39836;39918.800405998;39988.20023599526;7775.183605721402;7998.920010799905;8003.359731221517;8004.439689221756;8007.51954882706;7116.43068554517;7294.635268236593;7737.922620773805;10121.949390253038;10388.37669739818;9992.500374981222;10159.644412445567;10172.389656620626;10172.542235599416;10192.33749806264;7282;9953.153981911546;10050.396976181453;10066.094051535398;10066.29535932485;7161.104861892263;10008.49957502122;10242.385456872536;10285.640002599874;10331.431771252579;37354.25291494155;37724.811375943216;37794.43308350377;37872.242555149016;37876.81061594702;2924;2926.312316605596;3402.3195360927666;3463.3765922134007;3479.6346383629607;28222.576661350096;28534.714652853414;28537.429251415062;28680.71319286822;28854;3474.5483087198504;3493.441049432104;3503.2818272254126;3508.508808766749;3616.67449929505;218130;218724;218893;219765;220309.89845050834;50928.74535627298;55172.448275516734;55575;55607.721961389936;55635.721821391446;45003.324950125774;59247.40752592419;60602;60627.69686151629;60689.69655151696;12642.304673242876;12925.22448653065;12933.805992910115;12941.929291313532;12951.740965180643;9149.908500914906;9252.259819214447;9300.488473134043;9303.627854885865;9306.255499560019;18739.531511712044;19157.317975483442;19187;19275;19307.4207773767;7204.783856484314;7461.291177338144;7544.962275188589;7571.891524814325;7584;837.6816809612309;888.4447220487195;893.7988952485769;1005.3465247589126;1011;22448.551028979327;23235.7676423237;26438.6034209487;29224.269393264913;29661;898.3486971945288;923.5890028937058;938.1790932933683;960.8030353777459;1001.8246806808925;13376;13472.663183420493;13611.319434028259;13655.658608534668;13662.31688415595;374502;382464;383041;383442;383902;43391;43834.56165438305;43872;43921.34117988233;43922.78038609851;1192.1595275330872;1198.083466148397;1201.9459124339426;1208.112037652325;1318.1036894911551;22205.22281720132;24680.753192468565;25026.62460063137;25331.240062798144;26430.471390572464;36670.266594667424;38041.61958380381;38052.42921356237;38076.428853566664;38118.809405952794;167171;168492;168667;168965;169356;25098.498030039664;25623.871880640476;28721;29540.704592953796;29654.25864353322;33890.66109338974;39357.212855743295;39408;40073;40472.1905561893;31575.526367104972;31786.841065794524;32428.675713242566;32814.34371312608;33000.33999320048;32283.19292017718;32703.672963270063;32974.34051318912;33848;34140.65859341375;30585.388292234475;30690.693093068785;30752.384952301276;32318.35363292768;32634.184145395604;28705.28236794097;29174.854125730086;29702;29741;29966.19040246884;22969.196078137185;23272.4181895454;23556.882215588812;23640.527189456458;23640.645390319503 18:10:05 INFO - 2015-12-12 18:10:05,716 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.4937593609585;338.125944433639;338.154613466334;341.13862497194594;346.9670381313774;12305.938470307658;12661.113722039461;14527.564173074798;14697.485588004422;16274.511764647064;12682.365881705924;15684.137372444511;16027.679446411064;16367.345306187739;16389.098599577017;5015.874603134915;5021.648484606079;5145.3568303962;5148.922766158511;5151.639385243035;3726.6832319252762;3837.1558257183515;5143.768530416121;5674.602777805555;5899.144624029514;5818.06910894257;5826.737796799133;5827.242458480391;5843.328017278003;5853.268341457318;5664.235328230698;5821.388754180834;5830.7667693292215;5834.27071616048;5837.387074357216;5076.670016448919;5090.211017292326;5096.439391666913;5098.847034588931;5109.3613298337705;19012.239510419568;19280.614387712307;19612.607747845104;19631.607367852706;19652.50868728279;1913.4929243750416;1927.0364817591205;1959.8628096033283;1983.5239542509837;2014.63736527425;12457.377131143498;12458.314792686399;12669.239845609201;12688.23870567769;12994;1668.5077902018934;1704.616461296211;1709.572606848288;1716.0733204069788;1728.8616910647117;48373.75813120912;49674.50325496735;49761.50238497605;53038;53250.20124698094;9485.383450075724;9664.178544823768;9735.951320243496;9751.609935602497;9794.804103917882;12387.07096967731;12396.690082748004;12398.442070106867;12407.193532420364;12440.253584784941;6446.580972236789;6632.1046658701425;6653.168353955755;6674.632895190714;6729.461643068543;6271.843203919939;6295.6537390443045;6308.747650093945;6501.577397469149;6514.674266286666;4093.4064560639135;4129;4137.275976704064;4139.254934111888;4159.085001299709;1614.2090375715816;1660.65126323471;1668.8080870700026;1692.2469501071905;1727.153694689593;370.54978201485324;376.4090378106347;378.9962100379016;760.1676164599754;778.9844203115906;9739.756506087404;10207.387556746618;10530.526126324181;10584.523696433678;15440.382384704712;825.2696363718153;866.441145461174;881.0836729801064;927.5315965437546;961.0821665309612;8488.363372746946;8682.782930426663;8845.690400836069;8904.109589041043;8944.910550894538;512553;515290;522238;522732;524409;70797.64601176961;71368;72916;72957;74161.62919185478;1047.512906498482;1060.1359891688248;1065.2756125834353;1071.705281047718;1088.161007896652;13719.256654548843;13806.792898106336;13927.955403344993;14117.43530258778;14167.64580885486;31414.528782068744;31703.048908532783;32670.183245419055;34160.48759268663;35218.295634087684;40424.39363409492;41662.58337416708;42109.368359475244;42742.14515709731;44341.11317773691;8791.252743516872;8953.597088130919;9199.448033118035;9211.078892110736;9215;15926.28331725052;16267.430639927547;16373.280805515249;16586;16843.41048063312;10604.917186320983;10797.514111864828;13687.247201404018;14048.648783780487;14120.43518259258;10475.423851687925;11970.581029664268;12362.589295087371;13510.459581617019;14755.188464634548;13582.86417135816;14077.718445631235;14283.28583570838;14376.928115359357;14442.783358249844;8527.275181609633;8617.82764344722;8809;8873.29013678917;8889.955550222208;9372.625094996123;9542.33203675736;11823.822642660194;13519.324033798468;13911.930440347733 18:10:05 INFO - 2015-12-12 18:10:05,717 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1442.386985531149;1656.9834301656983;1709.2564734340563;1732.4456174024313;1736.296799796083;6126.509879209663;7037.859242815147;7211.314925082109;7222.061132052839;7233.095863017123;7025.26234745352;7209.603471809049;7218.278172182792;7221.4944953853255;7230.963845180767;1739.4955462915739;1763.1801212436214;1778.8754787164903;2048.1909645689943;2089.059923034633;1790.024436682005;1796.685580023497;2091.9372418827384;2117.2483768262277;2132.2110818996994;1978.5844972555708;2001.1295086637288;2003.0385415000808;2004.4888553418857;2005.6389849827026;1992.4620352504814;2029.3911826452006;2033.66444536652;2034.033833928872;2034.6541088015074;2044.5604195098126;2054.3734161080865;2066.617675729995;2066.844986626009;2078.781727918562;6962.7911162665205;6966.303369663044;7033.191183013968;7033.437325013987;7047.929520704779;4102.138550904314;4175.394567787654;4196.223698615766;4207.43199668044;4211.410402543646;2568.319395360231;2577.9613305800426;2607.4133320002848;2611.908583199579;2661.534231509478;835.757630287216;843.8312337532457;846.475185385059;880.1682410122437;891.5631340643102;9440.150386465251;9567.186789122863;9573.617055317778;9574.569144388519;9610.327277090606;3731.2350968051483;3779.565349984732;3806.1626442182674;3824.1778017726324;3826.8660596878976;8396.370272229608;8435.873461898076;8439;8439.451435656663;8443.366747493963;4151.294279972351;4175.937360939588;4180.038591124058;4186.979065104655;4196.034911970264;3752.287065457609;3788.5643151037434;3790.77255364679;3796.335641262768;3803.8858834235016;3278.246003419227;3291.127851119455;3306.074299196229;3333.0834020644515;3339.3154403347257;905.1220316293185;936.4521754773398;1032.2155162076726;1052.6315789473622;1062.1184416933927;840.9747707568782;848.4145939301862;848.4654667559398;901.2789768185426;999.3254553176577;6439.8068057958335;6466.127072845105;6472.996685513753;6473.417392434703;6488.156539649815;572.3761100400583;586.5278450847023;586.5307753796945;594.5362617158623;729.7701224114387;5183.352080989876;5272.288241087481;5303.390110137384;5305.973470132624;5311.867203319948;8036.557989310527;8678.6528538859;8691.304695624334;8726.91273087261;8765.298776097898;8467.618957146944;8576.313894888519;8594.699185528476;8598.699045533502;8618.353623478264;6629.834254143685;6728.495362847708;6772.86454270902;6779.559328643622;6790.864182716318;6440.645764482999;6473.611583305017;6479.384458476437;6482.351764823668;6483;7609.086909570887;7683.846323073619;7784.170719880936;7790.182030886675;7805.18045605226;7827.843443130992;8013.839723205387;8018.037835459782;8123.8781418277595;8145.51126932386;6389.041643753474;6451.3226111257645;6454.5159113065765;6481.449076828522;6498.122753428227;6740.427063699444;6771.525993180627;6783.59298442095;6800.557963732342;6820.113385259884;5462.617616766788;5577.079781836114;6288.088227207121;6368.235811702625;6450.967745161244;6191.597546159485;6201.565890387629;6203;6221.595596286227;6270.059491076375;6291.685415729104;6300.810975670737;6351.77768778109;6355.904661430175;6356.713947872265;5836.153757705194;5847.473727364558;5906.645601263938;5912.46787789101;5916.881662366643;5989.371116032754;6035.6076855004285;6035.607685500604;6039.607425517327;6051.273847138195 18:10:05 INFO - 2015-12-12 18:10:05,721 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.921580781093;300.67376896067765;305.84401955002943;307.1017274472169;307.1415393973843;5190.506901844324;5205.843824685266;5215.947840521593;5277.050130976423;5279.208118782185;5140.7172605506685;5192.999999999991;5224.947750522494;5227.424983251839;5238.685678859271;3893.279743247494;4135.359019352005;4140.5859414058505;4141.544430112685;4142.316517774571;3971.6822654187595;3991.321475349183;4102.220578090153;4122.402251673506;4138.13099249158;4068.9186216275657;4070.104576993057;4096.877093687194;4098.098418347959;4112.218678451085;3898.376259798447;3954.307996100671;3993.9600603993877;4093.263212621727;4105.158442519291;3585.229175727205;3607.8376473058775;3611.735892437652;3612.5123108380294;3620.5474315710535;4986.900261994776;5005.6496045276845;5009.724465154415;5017.122003649383;5026.246063090529;4688.413948256468;4699.060187962387;4699.906001879944;4706.788194531255;4706.835260765891;5332.626716129873;5500.092484740013;5510.724463776835;5514.062609356419;5514.641548299348;3827.119762454623;3828.425736139601;3829.253295607358;3831.3678243089857;3831.9808400958095;5709.371969083398;5785.566082543826;5798.246227990377;5810.21562089121;5814.040683287252;3951.2887680217264;3953.2093581283857;3955.7626542407547;3956.940645890314;3959.366501359769;3931.4692516510477;4009.1981603679383;4009.218202450494;4013.3979903014783;4013.4381186633896;4569.497355290915;4621.537846215351;4623.583877451046;4627.051454451829;4627.259638457831;5517.972410138004;5525.0883604204855;5530.6128571000445;5533.22534845122;5536.307961504812;1396.9092009019382;1416.6458385403648;1418.1420240754196;1418.9428875487622;1419.7657386531314;934.3973137326386;947.251671179774;953.1326492891574;968.3657204531044;970.8689326940914;4814.9518504815205;4820.204666230103;4825.372701548777;4827.517248275144;4828.106800241966;5617.354004289477;5665.235193248941;5666.914996275059;5671.602987790898;5674.602777805597;4813.205821039559;4816.133096042676;4819.566239038503;4823.083614113307;4829.541193586604;2758.213909035915;2935.280856190247;3081.198888289061;3102.534619807002;3108.114187456564;5306.946930530646;5325.813596524103;5326.893462130735;5435.83692489226;5443.156310771837;5935.673537955454;5937.228160339128;5940.584159108821;5942.970285148546;5962.046072628359;5485.533729633026;5490.80782172622;5499.752511137089;5500.80747173839;5502.642328248651;5784.305883294031;5787.826365209051;5791.160281759037;5796.855078623068;5798.507126894261;5506.724663766716;5636.85907852307;5642.6614403135945;5651.773929042793;5654.6324488908085;5527;5539.639923405127;5547.972260138674;5552.500274975271;5553;3904.219156168721;3905.6875449964505;3917.745346552465;3940.7438516496336;3949.9407508887966;5769.624974376652;5772.336181339199;5776.335721391925;5776.364599894092;5788.27646544182;5281.55106815925;5463.31708536433;5475.986942415507;5567.331920169606;5569.05326094573;5407.324084489439;5462.371827239918;5464.890702186013;5468.671879687232;5570.749316280696;5254.5533629641905;5413.160960051198;5432.837014889559;5452.781888724407;5455.881544283492;5482.5613950884635;5575.749091290821;5583.883223355264;5598.776048958159;5604.467575580314;5475.890482190254;5479.123340265538;5484;5486.835394937999;5490.862728431821 18:10:05 INFO - 2015-12-12 18:10:05,722 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.3168723868704;745.7688116683828;750.6546988385343;751.2037240525044;761.2615762710169;11235.438228088593;11381.430928453565;11391.601293954713;11424.086073114162;11441.141914356425;11029.724256893562;11091.500882460288;11108.944455277713;11143.554257829697;11173.497192626332;613.5858295650429;627.1564745417429;774.0749803984241;794.3010151067082;795.7692269241913;793.1592511937336;796.1242633103569;798.9760307190794;803.8151225218203;804.1516200408566;648.9707963141647;833.5707110837923;842.3008902610849;845.6067928413287;846.2214762418558;650.677914432359;650.879587276353;651.732789556282;651.7425616881329;808.7573727881671;620.3393386043849;621.018790311307;621.1521273461738;621.2358798677652;621.2482895696168;11259.21185517014;11367.204295699305;11378.31730096197;11391.259568128127;11416.486258118322;10517.526711297933;10979.17656175782;11044.668659940135;11261.943690281496;11319.151063670257;9344.2524598032;9427.151556359891;9493.857592136124;9664.420134791935;9722.902770972341;3217.3565286942703;3221.2752130770623;3225.451673215559;3257.153140183569;3318.6017677878567;35184.29631407383;35219;35622.28755424903;35826.28347433063;35925.46111808325;9074.228690561244;9082.636694532277;9083.591238394289;9269.768255793659;9455.149036586603;15456.690866182613;15464.922675386551;15479.5356139316;15490.30293636789;15506.767398489032;6445.935540644534;6513.706883190268;6588.11060506835;6624.9337506624315;6701.430378417792;3755.0987762937243;3764.8682296119505;3787.981060094737;3789.696824254053;3855.248226595843;2649.986750066237;2663.760261576467;2669.9733002670114;2670.479256544994;2679.6918354389104;473.0373689541766;476.0384024270953;486.2536007228887;490.5707505932309;493.04103518656586;547.370523897521;581.8748968971692;592.3158751641861;593.4391999560374;601.1103566721278;7339.266073392725;7496.175420703718;7557.244275572399;7587.127480339721;7605.353544948742;468.93434919111354;481.3237401450967;530.7744208711282;558.8407303918445;613.5766321238332;3533.8939831805087;3575.696065834381;3593.3711600470338;3723.8696645617274;3738.177600927846;46471;47009.76495117503;47130.764346178046;47859;48011.27983080257;43713;43722.56277437248;44043.11913761707;44359.77820110879;44819;39739.80130099331;39850.20299593992;40037.599624003386;40636.79681601573;40799.18401631951;7053.788386348418;7231.963840180765;7274.96362518184;7311.890321645286;7408.03695519579;29403.411931760817;30201.546976794925;30223.546646799874;30379.69620303857;30494;35021.64978350184;35125.29749405049;35319.11702207466;36017.819910900274;38252.6174738249;9089.136532029446;9207.263418926605;9221;9385.249180065715;9577.664781732607;9680.515974201402;9737.951310243403;10418.68743937683;10434.947825260826;10613.681589552325;9285.535723213678;9572.138507534355;9617.374870633386;9623.470709111067;10255.07704306616;9738;9955.850662240216;10027;10110.949445252727;10190.898091018995;8607.526586037577;9298.39560428597;9378.5779639915;9860.556274967501;10155.136813370946;9148.63405463774;9256.907430925605;9539;9574.808503830023;9633.470159141314;9038.412503187272;9127.634894604142;9198.172164504958;9399.53002349866;9405.341626086109 18:10:05 INFO - 2015-12-12 18:10:05,722 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:10:05 INFO - 2015-12-12 18:10:05,722 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,996 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: __startTimestamp1449972605709__endTimestamp 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4664.05 Median:4786.93 stddev:489.21 (10.2%) stddev-sans-first:464.07 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: Values: 2634.4 2709.2 2726.9 2747.9 2754.6 4505.0 4634.4 4680.4 4748.7 4755.2 4639.0 4644.0 4748.7 4752.1 4753.0 4303.8 4324.5 4326.9 4372.9 4385.4 4351.7 4480.9 4485.4 4486.9 4491.7 4193.5 4309.3 4320.2 4437.5 4480.6 4348.0 4371.1 4371.8 4373.9 4378.9 4264.3 4314.7 4337.5 4362.4 4373.1 4634.5 4648.7 4656.1 4656.5 4687.5 4824.3 5074.3 5118.9 5161.2 5164.7 4943.4 4951.0 4963.8 4964.4 4992.1 4735.6 4736.3 4736.6 4737.5 4786.9 5185.6 5223.9 5226.1 5234.2 5235.8 4809.0 4810.3 4940.4 4950.4 5004.3 5129.1 5129.9 5132.0 5136.6 5137.1 5064.6 5070.5 5076.2 5076.4 5086.9 4798.8 4838.6 4934.3 4936.5 5028.2 4218.3 4222.8 4226.9 4229.2 4262.8 3702.1 3713.1 3717.3 3744.6 3748.2 4128.5 4230.9 4233.9 4237.5 4388.5 5048.5 5077.0 5086.5 5103.2 5152.3 4346.9 4353.7 4358.8 4390.5 4392.3 4274.5 4383.5 4388.6 4490.9 4495.6 4734.6 4822.2 4837.4 4840.5 4877.0 5026.6 5130.3 5133.8 5135.4 5136.3 4606.5 4716.2 4730.1 4852.4 4874.7 4923.8 4930.6 4935.1 4939.9 4940.5 5101.8 5133.8 5135.8 5145.5 5156.9 4969.5 4984.0 4988.2 4991.5 5034.2 4697.6 4813.4 4820.1 4979.5 4996.3 4755.5 4828.5 4828.9 4846.4 4891.6 4968.7 4978.5 4991.8 4992.0 5032.6 4618.4 4735.1 4835.5 4863.8 4930.2 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,723 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41217.91 Median:32759.01 stddev:71812.38 (219.2%) stddev-sans-first:71948.93 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: Values: 554.5 572.8 580.3 581.1 590.4 25060.5 25437.9 25515.5 35609.6 36411.8 39680.4 39817.6 39836.0 39918.8 39988.2 7775.2 7998.9 8003.4 8004.4 8007.5 7116.4 7294.6 7737.9 10121.9 10388.4 9992.5 10159.6 10172.4 10172.5 10192.3 7282.0 9953.2 10050.4 10066.1 10066.3 7161.1 10008.5 10242.4 10285.6 10331.4 37354.3 37724.8 37794.4 37872.2 37876.8 2924.0 2926.3 3402.3 3463.4 3479.6 28222.6 28534.7 28537.4 28680.7 28854.0 3474.5 3493.4 3503.3 3508.5 3616.7 218130.0 218724.0 218893.0 219765.0 220309.9 50928.7 55172.4 55575.0 55607.7 55635.7 45003.3 59247.4 60602.0 60627.7 60689.7 12642.3 12925.2 12933.8 12941.9 12951.7 9149.9 9252.3 9300.5 9303.6 9306.3 18739.5 19157.3 19187.0 19275.0 19307.4 7204.8 7461.3 7545.0 7571.9 7584.0 837.7 888.4 893.8 1005.3 1011.0 22448.6 23235.8 26438.6 29224.3 29661.0 898.3 923.6 938.2 960.8 1001.8 13376.0 13472.7 13611.3 13655.7 13662.3 374502.0 382464.0 383041.0 383442.0 383902.0 43391.0 43834.6 43872.0 43921.3 43922.8 1192.2 1198.1 1201.9 1208.1 1318.1 22205.2 24680.8 25026.6 25331.2 26430.5 36670.3 38041.6 38052.4 38076.4 38118.8 167171.0 168492.0 168667.0 168965.0 169356.0 25098.5 25623.9 28721.0 29540.7 29654.3 33890.7 39357.2 39408.0 40073.0 40472.2 31575.5 31786.8 32428.7 32814.3 33000.3 32283.2 32703.7 32974.3 33848.0 34140.7 30585.4 30690.7 30752.4 32318.4 32634.2 28705.3 29174.9 29702.0 29741.0 29966.2 22969.2 23272.4 23556.9 23640.5 23640.6 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27027.17 Median:2108.08 stddev:84767.55 (4021.1%) stddev-sans-first:84981.65 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: Values: 337.5 338.1 338.2 341.1 347.0 12305.9 12661.1 14527.6 14697.5 16274.5 12682.4 15684.1 16027.7 16367.3 16389.1 5015.9 5021.6 5145.4 5148.9 5151.6 3726.7 3837.2 5143.8 5674.6 5899.1 5818.1 5826.7 5827.2 5843.3 5853.3 5664.2 5821.4 5830.8 5834.3 5837.4 5076.7 5090.2 5096.4 5098.8 5109.4 19012.2 19280.6 19612.6 19631.6 19652.5 1913.5 1927.0 1959.9 1983.5 2014.6 12457.4 12458.3 12669.2 12688.2 12994.0 1668.5 1704.6 1709.6 1716.1 1728.9 48373.8 49674.5 49761.5 53038.0 53250.2 9485.4 9664.2 9736.0 9751.6 9794.8 12387.1 12396.7 12398.4 12407.2 12440.3 6446.6 6632.1 6653.2 6674.6 6729.5 6271.8 6295.7 6308.7 6501.6 6514.7 4093.4 4129.0 4137.3 4139.3 4159.1 1614.2 1660.7 1668.8 1692.2 1727.2 370.5 376.4 379.0 760.2 779.0 9739.8 10207.4 10530.5 10584.5 15440.4 825.3 866.4 881.1 927.5 961.1 8488.4 8682.8 8845.7 8904.1 8944.9 512553.0 515290.0 522238.0 522732.0 524409.0 70797.6 71368.0 72916.0 72957.0 74161.6 1047.5 1060.1 1065.3 1071.7 1088.2 13719.3 13806.8 13928.0 14117.4 14167.6 31414.5 31703.0 32670.2 34160.5 35218.3 40424.4 41662.6 42109.4 42742.1 44341.1 8791.3 8953.6 9199.4 9211.1 9215.0 15926.3 16267.4 16373.3 16586.0 16843.4 10604.9 10797.5 13687.2 14048.6 14120.4 10475.4 11970.6 12362.6 13510.5 14755.2 13582.9 14077.7 14283.3 14376.9 14442.8 8527.3 8617.8 8809.0 8873.3 8890.0 9372.6 9542.3 11823.8 13519.3 13911.9 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,724 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4932.18 Median:6289.89 stddev:2617.54 (41.6%) stddev-sans-first:2611.74 18:10:05 INFO - 2015-12-12 18:10:05,725 DEBUG : BROWSER_OUTPUT: Values: 1442.4 1657.0 1709.3 1732.4 1736.3 6126.5 7037.9 7211.3 7222.1 7233.1 7025.3 7209.6 7218.3 7221.5 7231.0 1739.5 1763.2 1778.9 2048.2 2089.1 1790.0 1796.7 2091.9 2117.2 2132.2 1978.6 2001.1 2003.0 2004.5 2005.6 1992.5 2029.4 2033.7 2034.0 2034.7 2044.6 2054.4 2066.6 2066.8 2078.8 6962.8 6966.3 7033.2 7033.4 7047.9 4102.1 4175.4 4196.2 4207.4 4211.4 2568.3 2578.0 2607.4 2611.9 2661.5 835.8 843.8 846.5 880.2 891.6 9440.2 9567.2 9573.6 9574.6 9610.3 3731.2 3779.6 3806.2 3824.2 3826.9 8396.4 8435.9 8439.0 8439.5 8443.4 4151.3 4175.9 4180.0 4187.0 4196.0 3752.3 3788.6 3790.8 3796.3 3803.9 3278.2 3291.1 3306.1 3333.1 3339.3 905.1 936.5 1032.2 1052.6 1062.1 841.0 848.4 848.5 901.3 999.3 6439.8 6466.1 6473.0 6473.4 6488.2 572.4 586.5 586.5 594.5 729.8 5183.4 5272.3 5303.4 5306.0 5311.9 8036.6 8678.7 8691.3 8726.9 8765.3 8467.6 8576.3 8594.7 8598.7 8618.4 6629.8 6728.5 6772.9 6779.6 6790.9 6440.6 6473.6 6479.4 6482.4 6483.0 7609.1 7683.8 7784.2 7790.2 7805.2 7827.8 8013.8 8018.0 8123.9 8145.5 6389.0 6451.3 6454.5 6481.4 6498.1 6740.4 6771.5 6783.6 6800.6 6820.1 5462.6 5577.1 6288.1 6368.2 6451.0 6191.6 6201.6 6203.0 6221.6 6270.1 6291.7 6300.8 6351.8 6355.9 6356.7 5836.2 5847.5 5906.6 5912.5 5916.9 5989.4 6035.6 6035.6 6039.6 6051.3 18:10:05 INFO - 2015-12-12 18:10:05,725 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,725 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4584.02 Median:5226.19 stddev:1352.86 (25.9%) stddev-sans-first:1317.82 18:10:05 INFO - 2015-12-12 18:10:05,725 DEBUG : BROWSER_OUTPUT: Values: 295.9 300.7 305.8 307.1 307.1 5190.5 5205.8 5215.9 5277.1 5279.2 5140.7 5193.0 5224.9 5227.4 5238.7 3893.3 4135.4 4140.6 4141.5 4142.3 3971.7 3991.3 4102.2 4122.4 4138.1 4068.9 4070.1 4096.9 4098.1 4112.2 3898.4 3954.3 3994.0 4093.3 4105.2 3585.2 3607.8 3611.7 3612.5 3620.5 4986.9 5005.6 5009.7 5017.1 5026.2 4688.4 4699.1 4699.9 4706.8 4706.8 5332.6 5500.1 5510.7 5514.1 5514.6 3827.1 3828.4 3829.3 3831.4 3832.0 5709.4 5785.6 5798.2 5810.2 5814.0 3951.3 3953.2 3955.8 3956.9 3959.4 3931.5 4009.2 4009.2 4013.4 4013.4 4569.5 4621.5 4623.6 4627.1 4627.3 5518.0 5525.1 5530.6 5533.2 5536.3 1396.9 1416.6 1418.1 1418.9 1419.8 934.4 947.3 953.1 968.4 970.9 4815.0 4820.2 4825.4 4827.5 4828.1 5617.4 5665.2 5666.9 5671.6 5674.6 4813.2 4816.1 4819.6 4823.1 4829.5 2758.2 2935.3 3081.2 3102.5 3108.1 5306.9 5325.8 5326.9 5435.8 5443.2 5935.7 5937.2 5940.6 5943.0 5962.0 5485.5 5490.8 5499.8 5500.8 5502.6 5784.3 5787.8 5791.2 5796.9 5798.5 5506.7 5636.9 5642.7 5651.8 5654.6 5527.0 5539.6 5548.0 5552.5 5553.0 3904.2 3905.7 3917.7 3940.7 3949.9 5769.6 5772.3 5776.3 5776.4 5788.3 5281.6 5463.3 5476.0 5567.3 5569.1 5407.3 5462.4 5464.9 5468.7 5570.7 5254.6 5413.2 5432.8 5452.8 5455.9 5482.6 5575.7 5583.9 5598.8 5604.5 5475.9 5479.1 5484.0 5486.8 5490.9 18:10:05 INFO - 2015-12-12 18:10:05,726 DEBUG : BROWSER_OUTPUT: 18:10:05 INFO - 2015-12-12 18:10:05,726 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11674.65 Median:539.07 stddev:13085.81 (2427.5%) stddev-sans-first:13096.64 18:10:05 INFO - 2015-12-12 18:10:05,726 DEBUG : BROWSER_OUTPUT: Values: 715.3 745.8 750.7 751.2 761.3 11235.4 11381.4 11391.6 11424.1 11441.1 11029.7 11091.5 11108.9 11143.6 11173.5 613.6 627.2 774.1 794.3 795.8 793.2 796.1 799.0 803.8 804.2 649.0 833.6 842.3 845.6 846.2 650.7 650.9 651.7 651.7 808.8 620.3 621.0 621.2 621.2 621.2 11259.2 11367.2 11378.3 11391.3 11416.5 10517.5 10979.2 11044.7 11261.9 11319.2 9344.3 9427.2 9493.9 9664.4 9722.9 3217.4 3221.3 3225.5 3257.2 3318.6 35184.3 35219.0 35622.3 35826.3 35925.5 9074.2 9082.6 9083.6 9269.8 9455.1 15456.7 15464.9 15479.5 15490.3 15506.8 6445.9 6513.7 6588.1 6624.9 6701.4 3755.1 3764.9 3788.0 3789.7 3855.2 2650.0 2663.8 2670.0 2670.5 2679.7 473.0 476.0 486.3 490.6 493.0 547.4 581.9 592.3 593.4 601.1 7339.3 7496.2 7557.2 7587.1 7605.4 468.9 481.3 530.8 558.8 613.6 3533.9 3575.7 3593.4 3723.9 3738.2 46471.0 47009.8 47130.8 47859.0 48011.3 43713.0 43722.6 44043.1 44359.8 44819.0 39739.8 39850.2 40037.6 40636.8 40799.2 7053.8 7232.0 7275.0 7311.9 7408.0 29403.4 30201.5 30223.5 30379.7 30494.0 35021.6 35125.3 35319.1 36017.8 38252.6 9089.1 9207.3 9221.0 9385.2 9577.7 9680.5 9738.0 10418.7 10434.9 10613.7 9285.5 9572.1 9617.4 9623.5 10255.1 9738.0 9955.9 10027.0 10110.9 10190.9 8607.5 9298.4 9378.6 9860.6 10155.1 9148.6 9256.9 9539.0 9574.8 9633.5 9038.4 9127.6 9198.2 9399.5 9405.3 18:10:05 INFO - 2015-12-12 18:10:05,726 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:10:05 INFO - 2015-12-12 18:10:05,726 DEBUG : BROWSER_OUTPUT: 18:10:06 INFO - 2015-12-12 18:10:06,530 INFO : Browser exited with error code: 0 18:10:06 INFO - 2015-12-12 18:10:06,546 INFO : Completed test dromaeo_css (00:18:37) 18:10:06 INFO - 2015-12-12 18:10:06,546 INFO : Starting test kraken 18:10:06 INFO - 2015-12-12 18:10:06,546 DEBUG : operating with platform_type : linux_ 18:10:06 INFO - 2015-12-12 18:10:06,546 INFO : Initialising browser for kraken test... 18:10:06 INFO - 2015-12-12 18:10:06,552 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhpsNO/profile http://localhost:59625/getInfo.html 18:10:10 INFO - 2015-12-12 18:10:10,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:10:10 INFO - 2015-12-12 18:10:10,592 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:10:10 INFO - 2015-12-12 18:10:10,592 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:10:10 INFO - 2015-12-12 18:10:10,592 DEBUG : BROWSER_OUTPUT: __metrics 18:10:10 INFO - 2015-12-12 18:10:10,701 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] 18:10:10 INFO - 2015-12-12 18:10:10,797 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:11 INFO - 2015-12-12 18:10:11,820 INFO : Browser initialized. 18:10:11 INFO - 2015-12-12 18:10:11,821 INFO : Running cycle 1/1 for kraken test... 18:10:11 INFO - 2015-12-12 18:10:11,821 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhpsNO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:10:23 INFO - 2015-12-12 18:10:23,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 142794752 18:10:23 INFO - 2015-12-12 18:10:23,855 DEBUG : BROWSER_OUTPUT: 18:10:26 INFO - 2015-12-12 18:10:26,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59625/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:27 INFO - 2015-12-12 18:10:27,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 180371456 18:10:27 INFO - 2015-12-12 18:10:27,043 DEBUG : BROWSER_OUTPUT: 18:10:29 INFO - 2015-12-12 18:10:29,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59625/tests/kraken/driver.html?testName=audio-dft) 18:10:30 INFO - 2015-12-12 18:10:30,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 168615936 18:10:30 INFO - 2015-12-12 18:10:30,334 DEBUG : BROWSER_OUTPUT: 18:10:33 INFO - 2015-12-12 18:10:33,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59625/tests/kraken/driver.html?testName=audio-fft) 18:10:33 INFO - 2015-12-12 18:10:33,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 153501696 18:10:33 INFO - 2015-12-12 18:10:33,923 DEBUG : BROWSER_OUTPUT: 18:10:35 INFO - 2015-12-12 18:10:35,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59625/tests/kraken/driver.html?testName=audio-oscillator) 18:10:36 INFO - 2015-12-12 18:10:36,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 156516352 18:10:36 INFO - 2015-12-12 18:10:36,541 DEBUG : BROWSER_OUTPUT: 18:10:38 INFO - 2015-12-12 18:10:38,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:39 INFO - 2015-12-12 18:10:39,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 156631040 18:10:39 INFO - 2015-12-12 18:10:39,329 DEBUG : BROWSER_OUTPUT: 18:10:42 INFO - 2015-12-12 18:10:42,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59625/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:42 INFO - 2015-12-12 18:10:42,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 156360704 18:10:42 INFO - 2015-12-12 18:10:42,937 DEBUG : BROWSER_OUTPUT: 18:10:46 INFO - 2015-12-12 18:10:46,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59625/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:46 INFO - 2015-12-12 18:10:46,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 157614080 18:10:46 INFO - 2015-12-12 18:10:46,929 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-12 18:10:49,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59625/tests/kraken/driver.html?testName=json-parse-financial) 18:10:50 INFO - 2015-12-12 18:10:50,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 157843456 18:10:50 INFO - 2015-12-12 18:10:50,337 DEBUG : BROWSER_OUTPUT: 18:10:52 INFO - 2015-12-12 18:10:52,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:52 INFO - 2015-12-12 18:10:52,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 168181760 18:10:52 INFO - 2015-12-12 18:10:52,688 DEBUG : BROWSER_OUTPUT: 18:10:54 INFO - 2015-12-12 18:10:54,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:55 INFO - 2015-12-12 18:10:55,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 167002112 18:10:55 INFO - 2015-12-12 18:10:55,181 DEBUG : BROWSER_OUTPUT: 18:10:57 INFO - 2015-12-12 18:10:57,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:57 INFO - 2015-12-12 18:10:57,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 176529408 18:10:57 INFO - 2015-12-12 18:10:57,875 DEBUG : BROWSER_OUTPUT: 18:11:00 INFO - 2015-12-12 18:11:00,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:01 INFO - 2015-12-12 18:11:01,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 186220544 18:11:01 INFO - 2015-12-12 18:11:01,006 DEBUG : BROWSER_OUTPUT: 18:11:03 INFO - 2015-12-12 18:11:03,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:04 INFO - 2015-12-12 18:11:04,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 183316480 18:11:04 INFO - 2015-12-12 18:11:04,206 DEBUG : BROWSER_OUTPUT: 18:11:05 INFO - 2015-12-12 18:11:05,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59625/tests/kraken/driver.html?testName=ai-astar) 18:11:06 INFO - 2015-12-12 18:11:06,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 243265536 18:11:06 INFO - 2015-12-12 18:11:06,244 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,245 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:06 INFO - 2015-12-12 18:11:06,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:06 INFO - 2015-12-12 18:11:06,245 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:06 INFO - 2015-12-12 18:11:06,245 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:06 INFO - 2015-12-12 18:11:06,245 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;106;112;113;112;103;112;113;113 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;148;170;132;156;153;129;170;130 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;161;161;159;162;162;161;161 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;92;71;72;71;99;89;71 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;127;94;95;94;130;94;94;127 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;110;109;110;110;110 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;147;147;146;147;147 18:11:06 INFO - 2015-12-12 18:11:06,246 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;96;95;95;96 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;72;72;74;73;73;73;81;70;71 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;67;69;69;68;67;67;68 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;83;84;83;84;85;83;82;84;86 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;118;126;137;126;124;121;125;121;120 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;157;145;147;156;136;149;148;145;135 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;70;69;74;69;73;69;69;69 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:06 INFO - 2015-12-12 18:11:06,247 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:11:06 INFO - 2015-12-12 18:11:06,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 18:11:06 INFO - 2015-12-12 18:11:06,248 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:11:06 INFO - 2015-12-12 18:11:06,248 DEBUG : BROWSER_OUTPUT: __startTimestamp1449972666243__endTimestamp 18:11:06 INFO - 2015-12-12 18:11:06,248 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,251 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:06 INFO - 2015-12-12 18:11:06,251 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:11:06 INFO - 2015-12-12 18:11:06,251 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.37 (3.0%) stddev-sans-first:3.57 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 106.0 112.0 113.0 112.0 103.0 112.0 113.0 113.0 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.40 Median:154.50 stddev:16.27 (10.5%) stddev-sans-first:16.96 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 148.0 170.0 132.0 156.0 153.0 129.0 170.0 130.0 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 161.0 161.0 159.0 162.0 162.0 161.0 161.0 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:80.00 stddev:10.82 (13.5%) stddev-sans-first:11.11 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 92.0 71.0 72.0 71.0 99.0 89.0 71.0 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:94.00 stddev:16.31 (17.4%) stddev-sans-first:16.86 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 127.0 94.0 95.0 94.0 130.0 94.0 94.0 127.0 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:11:06 INFO - 2015-12-12 18:11:06,252 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.30 Median:73.00 stddev:2.98 (4.1%) stddev-sans-first:3.15 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 72.0 74.0 73.0 73.0 73.0 81.0 70.0 71.0 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 69.0 69.0 68.0 67.0 67.0 68.0 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.27 (2.7%) stddev-sans-first:1.20 18:11:06 INFO - 2015-12-12 18:11:06,253 DEBUG : BROWSER_OUTPUT: Values: 90.0 83.0 84.0 83.0 84.0 85.0 83.0 82.0 84.0 86.0 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:125.50 stddev:5.38 (4.3%) stddev-sans-first:5.56 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: Values: 128.0 118.0 126.0 137.0 126.0 124.0 121.0 125.0 121.0 120.0 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.50 stddev:7.85 (5.3%) stddev-sans-first:7.55 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: Values: 136.0 157.0 145.0 147.0 156.0 136.0 149.0 148.0 145.0 135.0 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.94 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 69.0 74.0 69.0 73.0 69.0 69.0 69.0 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:06 INFO - 2015-12-12 18:11:06,254 DEBUG : BROWSER_OUTPUT: 18:11:07 INFO - 2015-12-12 18:11:07,129 INFO : Browser exited with error code: 0 18:11:07 INFO - 2015-12-12 18:11:07,173 INFO : Completed test kraken (00:01:00) 18:11:07 INFO - 2015-12-12 18:11:07,174 INFO : Starting test v8_7 18:11:07 INFO - 2015-12-12 18:11:07,174 DEBUG : operating with platform_type : linux_ 18:11:07 INFO - 2015-12-12 18:11:07,174 INFO : Initialising browser for v8_7 test... 18:11:07 INFO - 2015-12-12 18:11:07,180 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHDQUw/profile http://localhost:59625/getInfo.html 18:11:11 INFO - 2015-12-12 18:11:11,236 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:11:11 INFO - 2015-12-12 18:11:11,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:11:11 INFO - 2015-12-12 18:11:11,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:11:11 INFO - 2015-12-12 18:11:11,236 DEBUG : BROWSER_OUTPUT: __metrics 18:11:11 INFO - 2015-12-12 18:11:11,381 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] 18:11:11 INFO - 2015-12-12 18:11:11,442 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:11:12 INFO - 2015-12-12 18:11:12,599 INFO : Browser initialized. 18:11:12 INFO - 2015-12-12 18:11:12,599 INFO : Running cycle 1/1 for v8_7 test... 18:11:12 INFO - 2015-12-12 18:11:12,600 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphHDQUw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:11:24 INFO - 2015-12-12 18:11:24,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 142270464 18:11:24 INFO - 2015-12-12 18:11:24,665 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59625/tests/v8_7/run.html (next: http://localhost:59625/tests/v8_7/run.html) 18:11:46 INFO - 2015-12-12 18:11:46,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 440692736 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: |0;Richards;168.01075268817203 18:11:46 INFO - 2015-12-12 18:11:46,323 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.8045336306206 18:11:46 INFO - 2015-12-12 18:11:46,324 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 18:11:46 INFO - 2015-12-12 18:11:46,324 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 18:11:46 INFO - 2015-12-12 18:11:46,324 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2034.5528455284552 18:11:46 INFO - 2015-12-12 18:11:46,324 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: |8;Splay;606.2801932367149 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:46 INFO - 2015-12-12 18:11:46,325 DEBUG : BROWSER_OUTPUT: __startTimestamp1449972706320__endTimestamp 18:11:46 INFO - 2015-12-12 18:11:46,326 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,326 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:46 INFO - 2015-12-12 18:11:46,326 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:11:46 INFO - 2015-12-12 18:11:46,326 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,326 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: Values: 168.0 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.80 Median:185.80 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: Values: 185.8 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,327 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: Values: 278.2 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: Values: 5186.5 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,328 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2034.55 Median:2034.55 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,329 DEBUG : BROWSER_OUTPUT: Values: 2034.6 18:11:46 INFO - 2015-12-12 18:11:46,329 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,329 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,329 DEBUG : BROWSER_OUTPUT: Values: 784.9 18:11:46 INFO - 2015-12-12 18:11:46,329 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,330 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,330 DEBUG : BROWSER_OUTPUT: Values: 11964.3 18:11:46 INFO - 2015-12-12 18:11:46,330 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: Values: 26868.4 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.28 Median:606.28 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: Values: 606.3 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: Values: 4830.9 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:46 INFO - 2015-12-12 18:11:46,331 DEBUG : BROWSER_OUTPUT: 18:11:47 INFO - 2015-12-12 18:11:47,278 INFO : Browser exited with error code: 0 18:11:47 INFO - 2015-12-12 18:11:47,292 INFO : Completed test v8_7 (00:00:40) 18:11:47 INFO - 2015-12-12 18:11:47,346 INFO : Completed test suite (00:20:18) 18:11:47 INFO - 2015-12-12 18:11:47,346 DEBUG : Working with test: dromaeo_css 18:11:47 INFO - 2015-12-12 18:11:47,347 DEBUG : Generating results file: dromaeo_css 18:11:47 INFO - 2015-12-12 18:11:47,347 DEBUG : Working with test: kraken 18:11:47 INFO - 2015-12-12 18:11:47,347 DEBUG : Generating results file: kraken 18:11:47 INFO - 2015-12-12 18:11:47,348 INFO : javascript benchmark 18:11:47 INFO - 2015-12-12 18:11:47,348 DEBUG : Working with test: v8_7 18:11:47 INFO - 2015-12-12 18:11:47,348 DEBUG : Generating results file: v8_7 18:11:47 INFO - 2015-12-12 18:11:47,348 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:47 INFO - 2015-12-12 18:11:47,399 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:11:47 INFO - 2015-12-12 18:11:47,400 DEBUG : process_Request line: dromaeo_css 6218.82 graph.html#tests=[[72,132,35]] 18:11:47 INFO - 2015-12-12 18:11:47,400 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:47 INFO - 2015-12-12 18:11:47,427 DEBUG : process_Request line: kraken 1520.30 graph.html#tests=[[232,132,35]] 18:11:47 INFO - 2015-12-12 18:11:47,427 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:47 INFO - 2015-12-12 18:11:47,455 DEBUG : process_Request line: v8_7 19785.12 graph.html#tests=[[230,132,35]] 18:11:47 INFO - 2015-12-12 18:11:47,456 INFO : javascript benchmark 18:11:47 INFO - 2015-12-12 18:11:47,460 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.354583127134, 2709.2007857681983, 2726.8500232487204, 2747.9450410991794, 2754.6418965534476, 4505.0, 4634.443866735988, 4680.4149481314835, 4748.6913350632185, 4755.215389460739, 4639.048994956034, 4644.024754801496, 4748.6913350632185, 4752.144613969484, 4753.049390121981, 4303.827846886129, 4324.54592267812, 4326.870193894172, 4372.890677733066, 4385.386045953554, 4351.673624478161, 4480.8879778005485, 4485.439320084989, 4486.887827804315, 4491.708038977472, 4193.475815523059, 4309.310510318334, 4320.24395730749, 4437.5340589237985, 4480.5967462928165, 4347.956520434786, 4371.103923695635, 4371.825126994916, 4373.934390984138, 4378.868633940987, 4264.296391095466, 4314.7411155330465, 4337.522872484024, 4362.36745671879, 4373.059792144672, 4634.467036290836, 4648.74431906245, 4656.092062047902, 4656.5343465653505, 4687.484376718558, 4824.324594556765, 5074.314967479417, 5118.897622047575, 5161.200013997799, 5164.741762911839, 4943.431505376856, 4951.009798040406, 4963.826266080706, 4964.404271487409, 4992.101421744084, 4735.550122738335, 4736.289556566542, 4736.573708366263, 4737.502562230916, 4786.928196077061, 5185.559227465707, 5223.869403264873, 5226.085435048852, 5234.162533994619, 5235.816746413857, 4808.9519104808505, 4810.326554282403, 4940.382452193476, 4950.356453661073, 5004.274380214922, 5129.051125541787, 5129.9230511542355, 5132.024915266087, 5136.614753893398, 5137.0753264412015, 5064.594832413398, 5070.492950704974, 5076.213186956028, 5076.44159142494, 5086.949130508721, 4798.760061996956, 4838.637102217277, 4934.259861020875, 4936.481669424658, 5028.195488721787, 4218.346156345771, 4222.7888605570215, 4226.894327641833, 4229.238737027303, 4262.786860657016, 3702.0929872181487, 3713.1088538751046, 3717.2565486902727, 3744.5506539215467, 3748.2316125194816, 4128.504579450485, 4230.936535951963, 4233.915321693549, 4237.512686041145, 4388.451443569554, 5048.495150484922, 5077.0, 5086.4659210783075, 5103.183490641553, 5152.330197074356, 4346.891327716832, 4353.673474489426, 4358.782060896942, 4390.495093064274, 4392.3191905254735, 4274.465691788527, 4383.49589797171, 4388.648908087409, 4490.887727806766, 4495.595396414338, 4734.644901632391, 4822.156122678587, 4837.395325584302, 4840.491748366371, 4877.024595080998, 5026.623003274842, 5130.333056702605, 5133.768980395966, 5135.409427915837, 5136.280920671034, 4606.470255920612, 4716.245400735866, 4730.101280756783, 4852.417709874838, 4874.683145595525, 4923.793670550738, 4930.556249937523, 4935.111679897509, 4939.876503087452, 4940.530649588283, 5101.846944591668, 5133.845984620468, 5135.845924622267, 5145.536901678867, 5156.922646160236, 4969.503049695001, 4983.9501604984935, 4988.176950803077, 4991.450940396626, 5034.169362055366, 4697.600703940203, 4813.350197723263, 4820.060088282751, 4979.452260251442, 4996.300517927566, 4755.548222918817, 4828.468868424541, 4828.855134345975, 4846.442659094249, 4891.584215341736, 4968.677035992793, 4978.47725988766, 4991.775370108427, 4991.975040124921, 5032.647714659939, 4618.445786505641, 4735.147673418817, 4835.540623640749, 4863.781129849236, 4930.211166213532], "unit": "ms", "name": "dojo.html", "value": 4633.704526613694}, {"lowerIsBetter": false, "replicates": [554.515304526135, 572.8396049106249, 580.3268208877702, 581.1428143488353, 590.365357240966, 25060.49879002419, 25437.872810635945, 25515.489690206206, 35609.64390356096, 36411.817940910325, 39680.404793928115, 39817.60182398175, 39836.0, 39918.800405998, 39988.20023599526, 7775.183605721402, 7998.920010799905, 8003.359731221517, 8004.439689221756, 8007.51954882706, 7116.43068554517, 7294.635268236593, 7737.922620773805, 10121.949390253038, 10388.37669739818, 9992.500374981222, 10159.644412445567, 10172.389656620626, 10172.542235599416, 10192.33749806264, 7282.0, 9953.153981911546, 10050.396976181453, 10066.094051535398, 10066.29535932485, 7161.104861892263, 10008.49957502122, 10242.385456872536, 10285.640002599874, 10331.431771252579, 37354.25291494155, 37724.811375943216, 37794.43308350377, 37872.242555149016, 37876.81061594702, 2924.0, 2926.312316605596, 3402.3195360927666, 3463.3765922134007, 3479.6346383629607, 28222.576661350096, 28534.714652853414, 28537.429251415062, 28680.71319286822, 28854.0, 3474.5483087198504, 3493.441049432104, 3503.2818272254126, 3508.508808766749, 3616.67449929505, 218130.0, 218724.0, 218893.0, 219765.0, 220309.89845050834, 50928.74535627298, 55172.448275516734, 55575.0, 55607.721961389936, 55635.721821391446, 45003.324950125774, 59247.40752592419, 60602.0, 60627.69686151629, 60689.69655151696, 12642.304673242876, 12925.22448653065, 12933.805992910115, 12941.929291313532, 12951.740965180643, 9149.908500914906, 9252.259819214447, 9300.488473134043, 9303.627854885865, 9306.255499560019, 18739.531511712044, 19157.317975483442, 19187.0, 19275.0, 19307.4207773767, 7204.783856484314, 7461.291177338144, 7544.962275188589, 7571.891524814325, 7584.0, 837.6816809612309, 888.4447220487195, 893.7988952485769, 1005.3465247589126, 1011.0, 22448.551028979327, 23235.7676423237, 26438.6034209487, 29224.269393264913, 29661.0, 898.3486971945288, 923.5890028937058, 938.1790932933683, 960.8030353777459, 1001.8246806808925, 13376.0, 13472.663183420493, 13611.319434028259, 13655.658608534668, 13662.31688415595, 374502.0, 382464.0, 383041.0, 383442.0, 383902.0, 43391.0, 43834.56165438305, 43872.0, 43921.34117988233, 43922.78038609851, 1192.1595275330872, 1198.083466148397, 1201.9459124339426, 1208.112037652325, 1318.1036894911551, 22205.22281720132, 24680.753192468565, 25026.62460063137, 25331.240062798144, 26430.471390572464, 36670.266594667424, 38041.61958380381, 38052.42921356237, 38076.428853566664, 38118.809405952794, 167171.0, 168492.0, 168667.0, 168965.0, 169356.0, 25098.498030039664, 25623.871880640476, 28721.0, 29540.704592953796, 29654.25864353322, 33890.66109338974, 39357.212855743295, 39408.0, 40073.0, 40472.1905561893, 31575.526367104972, 31786.841065794524, 32428.675713242566, 32814.34371312608, 33000.33999320048, 32283.19292017718, 32703.672963270063, 32974.34051318912, 33848.0, 34140.65859341375, 30585.388292234475, 30690.693093068785, 30752.384952301276, 32318.35363292768, 32634.184145395604, 28705.28236794097, 29174.854125730086, 29702.0, 29741.0, 29966.19040246884, 22969.196078137185, 23272.4181895454, 23556.882215588812, 23640.527189456458, 23640.645390319503], "unit": "ms", "name": "ext.html", "value": 16879.527365276233}, {"lowerIsBetter": false, "replicates": [337.4937593609585, 338.125944433639, 338.154613466334, 341.13862497194594, 346.9670381313774, 12305.938470307658, 12661.113722039461, 14527.564173074798, 14697.485588004422, 16274.511764647064, 12682.365881705924, 15684.137372444511, 16027.679446411064, 16367.345306187739, 16389.098599577017, 5015.874603134915, 5021.648484606079, 5145.3568303962, 5148.922766158511, 5151.639385243035, 3726.6832319252762, 3837.1558257183515, 5143.768530416121, 5674.602777805555, 5899.144624029514, 5818.06910894257, 5826.737796799133, 5827.242458480391, 5843.328017278003, 5853.268341457318, 5664.235328230698, 5821.388754180834, 5830.7667693292215, 5834.27071616048, 5837.387074357216, 5076.670016448919, 5090.211017292326, 5096.439391666913, 5098.847034588931, 5109.3613298337705, 19012.239510419568, 19280.614387712307, 19612.607747845104, 19631.607367852706, 19652.50868728279, 1913.4929243750416, 1927.0364817591205, 1959.8628096033283, 1983.5239542509837, 2014.63736527425, 12457.377131143498, 12458.314792686399, 12669.239845609201, 12688.23870567769, 12994.0, 1668.5077902018934, 1704.616461296211, 1709.572606848288, 1716.0733204069788, 1728.8616910647117, 48373.75813120912, 49674.50325496735, 49761.50238497605, 53038.0, 53250.20124698094, 9485.383450075724, 9664.178544823768, 9735.951320243496, 9751.609935602497, 9794.804103917882, 12387.07096967731, 12396.690082748004, 12398.442070106867, 12407.193532420364, 12440.253584784941, 6446.580972236789, 6632.1046658701425, 6653.168353955755, 6674.632895190714, 6729.461643068543, 6271.843203919939, 6295.6537390443045, 6308.747650093945, 6501.577397469149, 6514.674266286666, 4093.4064560639135, 4129.0, 4137.275976704064, 4139.254934111888, 4159.085001299709, 1614.2090375715816, 1660.65126323471, 1668.8080870700026, 1692.2469501071905, 1727.153694689593, 370.54978201485324, 376.4090378106347, 378.9962100379016, 760.1676164599754, 778.9844203115906, 9739.756506087404, 10207.387556746618, 10530.526126324181, 10584.523696433678, 15440.382384704712, 825.2696363718153, 866.441145461174, 881.0836729801064, 927.5315965437546, 961.0821665309612, 8488.363372746946, 8682.782930426663, 8845.690400836069, 8904.109589041043, 8944.910550894538, 512553.0, 515290.0, 522238.0, 522732.0, 524409.0, 70797.64601176961, 71368.0, 72916.0, 72957.0, 74161.62919185478, 1047.512906498482, 1060.1359891688248, 1065.2756125834353, 1071.705281047718, 1088.161007896652, 13719.256654548843, 13806.792898106336, 13927.955403344993, 14117.43530258778, 14167.64580885486, 31414.528782068744, 31703.048908532783, 32670.183245419055, 34160.48759268663, 35218.295634087684, 40424.39363409492, 41662.58337416708, 42109.368359475244, 42742.14515709731, 44341.11317773691, 8791.252743516872, 8953.597088130919, 9199.448033118035, 9211.078892110736, 9215.0, 15926.28331725052, 16267.430639927547, 16373.280805515249, 16586.0, 16843.41048063312, 10604.917186320983, 10797.514111864828, 13687.247201404018, 14048.648783780487, 14120.43518259258, 10475.423851687925, 11970.581029664268, 12362.589295087371, 13510.459581617019, 14755.188464634548, 13582.86417135816, 14077.718445631235, 14283.28583570838, 14376.928115359357, 14442.783358249844, 8527.275181609633, 8617.82764344722, 8809.0, 8873.29013678917, 8889.955550222208, 9372.625094996123, 9542.33203675736, 11823.822642660194, 13519.324033798468, 13911.930440347733], "unit": "ms", "name": "jquery.html", "value": 8132.894844470267}, {"lowerIsBetter": false, "replicates": [1442.386985531149, 1656.9834301656983, 1709.2564734340563, 1732.4456174024313, 1736.296799796083, 6126.509879209663, 7037.859242815147, 7211.314925082109, 7222.061132052839, 7233.095863017123, 7025.26234745352, 7209.603471809049, 7218.278172182792, 7221.4944953853255, 7230.963845180767, 1739.4955462915739, 1763.1801212436214, 1778.8754787164903, 2048.1909645689943, 2089.059923034633, 1790.024436682005, 1796.685580023497, 2091.9372418827384, 2117.2483768262277, 2132.2110818996994, 1978.5844972555708, 2001.1295086637288, 2003.0385415000808, 2004.4888553418857, 2005.6389849827026, 1992.4620352504814, 2029.3911826452006, 2033.66444536652, 2034.033833928872, 2034.6541088015074, 2044.5604195098126, 2054.3734161080865, 2066.617675729995, 2066.844986626009, 2078.781727918562, 6962.7911162665205, 6966.303369663044, 7033.191183013968, 7033.437325013987, 7047.929520704779, 4102.138550904314, 4175.394567787654, 4196.223698615766, 4207.43199668044, 4211.410402543646, 2568.319395360231, 2577.9613305800426, 2607.4133320002848, 2611.908583199579, 2661.534231509478, 835.757630287216, 843.8312337532457, 846.475185385059, 880.1682410122437, 891.5631340643102, 9440.150386465251, 9567.186789122863, 9573.617055317778, 9574.569144388519, 9610.327277090606, 3731.2350968051483, 3779.565349984732, 3806.1626442182674, 3824.1778017726324, 3826.8660596878976, 8396.370272229608, 8435.873461898076, 8439.0, 8439.451435656663, 8443.366747493963, 4151.294279972351, 4175.937360939588, 4180.038591124058, 4186.979065104655, 4196.034911970264, 3752.287065457609, 3788.5643151037434, 3790.77255364679, 3796.335641262768, 3803.8858834235016, 3278.246003419227, 3291.127851119455, 3306.074299196229, 3333.0834020644515, 3339.3154403347257, 905.1220316293185, 936.4521754773398, 1032.2155162076726, 1052.6315789473622, 1062.1184416933927, 840.9747707568782, 848.4145939301862, 848.4654667559398, 901.2789768185426, 999.3254553176577, 6439.8068057958335, 6466.127072845105, 6472.996685513753, 6473.417392434703, 6488.156539649815, 572.3761100400583, 586.5278450847023, 586.5307753796945, 594.5362617158623, 729.7701224114387, 5183.352080989876, 5272.288241087481, 5303.390110137384, 5305.973470132624, 5311.867203319948, 8036.557989310527, 8678.6528538859, 8691.304695624334, 8726.91273087261, 8765.298776097898, 8467.618957146944, 8576.313894888519, 8594.699185528476, 8598.699045533502, 8618.353623478264, 6629.834254143685, 6728.495362847708, 6772.86454270902, 6779.559328643622, 6790.864182716318, 6440.645764482999, 6473.611583305017, 6479.384458476437, 6482.351764823668, 6483.0, 7609.086909570887, 7683.846323073619, 7784.170719880936, 7790.182030886675, 7805.18045605226, 7827.843443130992, 8013.839723205387, 8018.037835459782, 8123.8781418277595, 8145.51126932386, 6389.041643753474, 6451.3226111257645, 6454.5159113065765, 6481.449076828522, 6498.122753428227, 6740.427063699444, 6771.525993180627, 6783.59298442095, 6800.557963732342, 6820.113385259884, 5462.617616766788, 5577.079781836114, 6288.088227207121, 6368.235811702625, 6450.967745161244, 6191.597546159485, 6201.565890387629, 6203.0, 6221.595596286227, 6270.059491076375, 6291.685415729104, 6300.810975670737, 6351.77768778109, 6355.904661430175, 6356.713947872265, 5836.153757705194, 5847.473727364558, 5906.645601263938, 5912.46787789101, 5916.881662366643, 5989.371116032754, 6035.6076855004285, 6035.607685500604, 6039.607425517327, 6051.273847138195], "unit": "ms", "name": "mootools.html", "value": 3973.2311270169753}, {"lowerIsBetter": false, "replicates": [295.921580781093, 300.67376896067765, 305.84401955002943, 307.1017274472169, 307.1415393973843, 5190.506901844324, 5205.843824685266, 5215.947840521593, 5277.050130976423, 5279.208118782185, 5140.7172605506685, 5192.999999999991, 5224.947750522494, 5227.424983251839, 5238.685678859271, 3893.279743247494, 4135.359019352005, 4140.5859414058505, 4141.544430112685, 4142.316517774571, 3971.6822654187595, 3991.321475349183, 4102.220578090153, 4122.402251673506, 4138.13099249158, 4068.9186216275657, 4070.104576993057, 4096.877093687194, 4098.098418347959, 4112.218678451085, 3898.376259798447, 3954.307996100671, 3993.9600603993877, 4093.263212621727, 4105.158442519291, 3585.229175727205, 3607.8376473058775, 3611.735892437652, 3612.5123108380294, 3620.5474315710535, 4986.900261994776, 5005.6496045276845, 5009.724465154415, 5017.122003649383, 5026.246063090529, 4688.413948256468, 4699.060187962387, 4699.906001879944, 4706.788194531255, 4706.835260765891, 5332.626716129873, 5500.092484740013, 5510.724463776835, 5514.062609356419, 5514.641548299348, 3827.119762454623, 3828.425736139601, 3829.253295607358, 3831.3678243089857, 3831.9808400958095, 5709.371969083398, 5785.566082543826, 5798.246227990377, 5810.21562089121, 5814.040683287252, 3951.2887680217264, 3953.2093581283857, 3955.7626542407547, 3956.940645890314, 3959.366501359769, 3931.4692516510477, 4009.1981603679383, 4009.218202450494, 4013.3979903014783, 4013.4381186633896, 4569.497355290915, 4621.537846215351, 4623.583877451046, 4627.051454451829, 4627.259638457831, 5517.972410138004, 5525.0883604204855, 5530.6128571000445, 5533.22534845122, 5536.307961504812, 1396.9092009019382, 1416.6458385403648, 1418.1420240754196, 1418.9428875487622, 1419.7657386531314, 934.3973137326386, 947.251671179774, 953.1326492891574, 968.3657204531044, 970.8689326940914, 4814.9518504815205, 4820.204666230103, 4825.372701548777, 4827.517248275144, 4828.106800241966, 5617.354004289477, 5665.235193248941, 5666.914996275059, 5671.602987790898, 5674.602777805597, 4813.205821039559, 4816.133096042676, 4819.566239038503, 4823.083614113307, 4829.541193586604, 2758.213909035915, 2935.280856190247, 3081.198888289061, 3102.534619807002, 3108.114187456564, 5306.946930530646, 5325.813596524103, 5326.893462130735, 5435.83692489226, 5443.156310771837, 5935.673537955454, 5937.228160339128, 5940.584159108821, 5942.970285148546, 5962.046072628359, 5485.533729633026, 5490.80782172622, 5499.752511137089, 5500.80747173839, 5502.642328248651, 5784.305883294031, 5787.826365209051, 5791.160281759037, 5796.855078623068, 5798.507126894261, 5506.724663766716, 5636.85907852307, 5642.6614403135945, 5651.773929042793, 5654.6324488908085, 5527.0, 5539.639923405127, 5547.972260138674, 5552.500274975271, 5553.0, 3904.219156168721, 3905.6875449964505, 3917.745346552465, 3940.7438516496336, 3949.9407508887966, 5769.624974376652, 5772.336181339199, 5776.335721391925, 5776.364599894092, 5788.27646544182, 5281.55106815925, 5463.31708536433, 5475.986942415507, 5567.331920169606, 5569.05326094573, 5407.324084489439, 5462.371827239918, 5464.890702186013, 5468.671879687232, 5570.749316280696, 5254.5533629641905, 5413.160960051198, 5432.837014889559, 5452.781888724407, 5455.881544283492, 5482.5613950884635, 5575.749091290821, 5583.883223355264, 5598.776048958159, 5604.467575580314, 5475.890482190254, 5479.123340265538, 5484.0, 5486.835394937999, 5490.862728431821], "unit": "ms", "name": "prototype.html", "value": 4149.51594437666}, {"lowerIsBetter": false, "replicates": [715.3168723868704, 745.7688116683828, 750.6546988385343, 751.2037240525044, 761.2615762710169, 11235.438228088593, 11381.430928453565, 11391.601293954713, 11424.086073114162, 11441.141914356425, 11029.724256893562, 11091.500882460288, 11108.944455277713, 11143.554257829697, 11173.497192626332, 613.5858295650429, 627.1564745417429, 774.0749803984241, 794.3010151067082, 795.7692269241913, 793.1592511937336, 796.1242633103569, 798.9760307190794, 803.8151225218203, 804.1516200408566, 648.9707963141647, 833.5707110837923, 842.3008902610849, 845.6067928413287, 846.2214762418558, 650.677914432359, 650.879587276353, 651.732789556282, 651.7425616881329, 808.7573727881671, 620.3393386043849, 621.018790311307, 621.1521273461738, 621.2358798677652, 621.2482895696168, 11259.21185517014, 11367.204295699305, 11378.31730096197, 11391.259568128127, 11416.486258118322, 10517.526711297933, 10979.17656175782, 11044.668659940135, 11261.943690281496, 11319.151063670257, 9344.2524598032, 9427.151556359891, 9493.857592136124, 9664.420134791935, 9722.902770972341, 3217.3565286942703, 3221.2752130770623, 3225.451673215559, 3257.153140183569, 3318.6017677878567, 35184.29631407383, 35219.0, 35622.28755424903, 35826.28347433063, 35925.46111808325, 9074.228690561244, 9082.636694532277, 9083.591238394289, 9269.768255793659, 9455.149036586603, 15456.690866182613, 15464.922675386551, 15479.5356139316, 15490.30293636789, 15506.767398489032, 6445.935540644534, 6513.706883190268, 6588.11060506835, 6624.9337506624315, 6701.430378417792, 3755.0987762937243, 3764.8682296119505, 3787.981060094737, 3789.696824254053, 3855.248226595843, 2649.986750066237, 2663.760261576467, 2669.9733002670114, 2670.479256544994, 2679.6918354389104, 473.0373689541766, 476.0384024270953, 486.2536007228887, 490.5707505932309, 493.04103518656586, 547.370523897521, 581.8748968971692, 592.3158751641861, 593.4391999560374, 601.1103566721278, 7339.266073392725, 7496.175420703718, 7557.244275572399, 7587.127480339721, 7605.353544948742, 468.93434919111354, 481.3237401450967, 530.7744208711282, 558.8407303918445, 613.5766321238332, 3533.8939831805087, 3575.696065834381, 3593.3711600470338, 3723.8696645617274, 3738.177600927846, 46471.0, 47009.76495117503, 47130.764346178046, 47859.0, 48011.27983080257, 43713.0, 43722.56277437248, 44043.11913761707, 44359.77820110879, 44819.0, 39739.80130099331, 39850.20299593992, 40037.599624003386, 40636.79681601573, 40799.18401631951, 7053.788386348418, 7231.963840180765, 7274.96362518184, 7311.890321645286, 7408.03695519579, 29403.411931760817, 30201.546976794925, 30223.546646799874, 30379.69620303857, 30494.0, 35021.64978350184, 35125.29749405049, 35319.11702207466, 36017.819910900274, 38252.6174738249, 9089.136532029446, 9207.263418926605, 9221.0, 9385.249180065715, 9577.664781732607, 9680.515974201402, 9737.951310243403, 10418.68743937683, 10434.947825260826, 10613.681589552325, 9285.535723213678, 9572.138507534355, 9617.374870633386, 9623.470709111067, 10255.07704306616, 9738.0, 9955.850662240216, 10027.0, 10110.949445252727, 10190.898091018995, 8607.526586037577, 9298.39560428597, 9378.5779639915, 9860.556274967501, 10155.136813370946, 9148.63405463774, 9256.907430925605, 9539.0, 9574.808503830023, 9633.470159141314, 9038.412503187272, 9127.634894604142, 9198.172164504958, 9399.53002349866, 9405.341626086109], "unit": "ms", "name": "yui.html", "value": 5514.744979633677}], "name": "dromaeo_css", "value": 6218.817857314784}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 112.0, 113.0, 112.0, 103.0, 112.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 148.0, 170.0, 132.0, 156.0, 153.0, 129.0, 170.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 159.0, 162.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 92.0, 71.0, 72.0, 71.0, 99.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 127.0, 94.0, 95.0, 94.0, 130.0, 94.0, 94.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 74.0, 73.0, 73.0, 73.0, 81.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 84.0, 83.0, 84.0, 85.0, 83.0, 82.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [128.0, 118.0, 126.0, 137.0, 126.0, 124.0, 121.0, 125.0, 121.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [136.0, 157.0, 145.0, 147.0, 156.0, 136.0, 149.0, 148.0, 145.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 69.0, 74.0, 69.0, 73.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1520.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "Richards", "value": 210.11750400000008}, {"lowerIsBetter": false, "replicates": [185.8045336306206], "unit": "score", "name": "DeltaBlue", "value": 355.8470759999999}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2034.5528455284552], "unit": "score", "name": "RayTrace", "value": 363.7108771228772}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [606.2801932367149], "unit": "score", "name": "Splay", "value": 134.41145019920324}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19785.12017947125}]} 18:11:47 INFO - RETURN: dromaeo_css: 6218.82 18:11:47 INFO - RETURN: kraken: 1520.30 18:11:47 INFO - RETURN: v8_7: 19785.12 18:11:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19785.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6218.82"}}} 18:11:47 INFO - Return code: 0 18:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:11:47 INFO - # TBPL SUCCESS # 18:11:47 INFO - Running post-action listener: _resource_record_post_action 18:11:47 INFO - Running post-run listener: _resource_record_post_run 18:11:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 12288; Write bytes: 508280832; Read time: 124; Write time: 494760 18:11:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232173568; Read time: 0; Write time: 354624 18:11:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 12288; Write bytes: 276107264; Read time: 124; Write time: 140136 18:11:48 INFO - Running post-run listener: _upload_blobber_files 18:11:48 INFO - Blob upload gear active. 18:11:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:11:48 INFO - Copying logs to upload dir... 18:11:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.274053 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-12 18:11:48.399891) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-12 18:11:48.403864) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010011 build_url: 'https://queue.taskcluster.net/v1/task/zMkr2qxyT0OgmKJ2aH2MUg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-12 18:11:48.457573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 18:11:48.457932) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1449970890.740812-891172222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-12 18:11:48.509195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-12 18:11:48.509537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-12 18:11:48.509996) ========= ========= Total master_lag: 1.16 =========